builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1462787312.19 results: success (0) buildid: 20160509020948 builduid: ea7aa0d0c1704203a367144f732767ea revision: 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.195580) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.195995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.196276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.299908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.300165) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 02:48:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-09 02:48:32 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084102 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.410324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.410612) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:32.461258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 02:48:32.461602) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 02:48:33,059 truncating revision to first 12 chars 2016-05-09 02:48:33,059 Setting DEBUG logging. 2016-05-09 02:48:33,060 attempt 1/10 2016-05-09 02:48:33,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8deb0d7312e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 02:48:34,021 unpacking tar archive at: fx-team-8deb0d7312e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 02:48:33.747062) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:33.747378) ========= script_repo_revision: 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:33.747786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:33.748060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 02:48:33.755326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 02:48:33.755669) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:48:34 INFO - MultiFileLogger online at 20160509 02:48:34 in /builds/slave/test 02:48:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:48:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:34 INFO - {'append_to_log': False, 02:48:34 INFO - 'base_work_dir': '/builds/slave/test', 02:48:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:48:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:34 INFO - 'branch': 'Fx-Team-Non-PGO', 02:48:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:34 INFO - 'config_files': ('talos/linux_config.py',), 02:48:34 INFO - 'default_actions': ('clobber', 02:48:34 INFO - 'read-buildbot-config', 02:48:34 INFO - 'download-and-extract', 02:48:34 INFO - 'populate-webroot', 02:48:34 INFO - 'create-virtualenv', 02:48:34 INFO - 'install', 02:48:34 INFO - 'run-tests'), 02:48:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:34 INFO - 'download_minidump_stackwalk': True, 02:48:34 INFO - 'download_symbols': 'ondemand', 02:48:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:34 INFO - 'installer_path': 'installer.exe', 02:48:34 INFO - 'log_level': 'info', 02:48:34 INFO - 'log_name': 'talos', 02:48:34 INFO - 'log_to_console': True, 02:48:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:48:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:48:34 INFO - 'opt_config_files': (), 02:48:34 INFO - 'pip_index': False, 02:48:34 INFO - 'sps_profile': False, 02:48:34 INFO - 'sps_profile_interval': 0, 02:48:34 INFO - 'suite': 'dromaeojs', 02:48:34 INFO - 'system_bits': '32', 02:48:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:34 INFO - 'title': 'talos-linux64-ix-009', 02:48:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:34 INFO - 'use_talos_json': True, 02:48:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:34 INFO - 'work_dir': 'build'} 02:48:34 INFO - ##### 02:48:34 INFO - ##### Running clobber step. 02:48:34 INFO - ##### 02:48:34 INFO - Running pre-action listener: _resource_record_pre_action 02:48:34 INFO - Running main action method: clobber 02:48:34 INFO - rmtree: /builds/slave/test/build 02:48:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:34 INFO - Running post-action listener: _resource_record_post_action 02:48:34 INFO - ##### 02:48:34 INFO - ##### Finished clobber step (success) 02:48:34 INFO - ##### 02:48:34 INFO - ##### 02:48:34 INFO - ##### Running read-buildbot-config step. 02:48:34 INFO - ##### 02:48:34 INFO - Running pre-action listener: _resource_record_pre_action 02:48:34 INFO - Running main action method: read_buildbot_config 02:48:34 INFO - Using buildbot properties: 02:48:34 INFO - { 02:48:34 INFO - "project": "", 02:48:34 INFO - "product": "firefox", 02:48:34 INFO - "script_repo_revision": "production", 02:48:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:48:34 INFO - "repository": "", 02:48:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:48:34 INFO - "buildid": "20160509020948", 02:48:34 INFO - "pgo_build": "False", 02:48:34 INFO - "basedir": "/builds/slave/test", 02:48:34 INFO - "buildnumber": 2935, 02:48:34 INFO - "slavename": "talos-linux64-ix-009", 02:48:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:48:34 INFO - "platform": "ubuntu64_hw", 02:48:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:48:34 INFO - "branch": "fx-team", 02:48:34 INFO - "repo_path": "integration/fx-team", 02:48:34 INFO - "revision": "8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006", 02:48:34 INFO - "stage_platform": "linux64", 02:48:34 INFO - "builduid": "ea7aa0d0c1704203a367144f732767ea", 02:48:34 INFO - "slavebuilddir": "test" 02:48:34 INFO - } 02:48:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:48:34 INFO - Running post-action listener: _resource_record_post_action 02:48:34 INFO - ##### 02:48:34 INFO - ##### Finished read-buildbot-config step (success) 02:48:34 INFO - ##### 02:48:34 INFO - ##### 02:48:34 INFO - ##### Running download-and-extract step. 02:48:34 INFO - ##### 02:48:34 INFO - Running pre-action listener: _resource_record_pre_action 02:48:34 INFO - Running main action method: download_and_extract 02:48:34 INFO - mkdir: /builds/slave/test/build/tests 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:48:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:48:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:48:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:48:36 INFO - Downloaded 1361 bytes. 02:48:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:48:36 INFO - Using the following test package requirements: 02:48:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:48:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:48:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:48:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'jsshell-linux-x86_64.zip'], 02:48:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:48:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:48:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:48:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:48:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:48:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:48:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:36 INFO - https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:48:37 INFO - Downloaded 22321369 bytes. 02:48:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:48:38 INFO - Return code: 0 02:48:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:38 INFO - https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:48:40 INFO - Downloaded 22321369 bytes. 02:48:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:48:41 INFO - Return code: 0 02:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:41 INFO - https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:48:42 INFO - Downloaded 10840152 bytes. 02:48:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:48:42 INFO - Return code: 0 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:48:44 INFO - Downloaded 54849100 bytes. 02:48:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:48:44 INFO - mkdir: /builds/slave/test/properties 02:48:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:44 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:44 INFO - Contents: 02:48:44 INFO - build_url:https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:48:45 INFO - Running post-action listener: _resource_record_post_action 02:48:45 INFO - Running post-action listener: set_extra_try_arguments 02:48:45 INFO - ##### 02:48:45 INFO - ##### Finished download-and-extract step (success) 02:48:45 INFO - ##### 02:48:45 INFO - ##### 02:48:45 INFO - ##### Running populate-webroot step. 02:48:45 INFO - ##### 02:48:45 INFO - Running pre-action listener: _resource_record_pre_action 02:48:45 INFO - Running main action method: populate_webroot 02:48:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:45 INFO - '--tppagecycles', 02:48:45 INFO - '7'], 02:48:45 INFO - 'tests': ['tsvgm']}}, 02:48:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['damp', 'tps']}, 02:48:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'tests': ['damp', 'tps']}, 02:48:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['dromaeo_dom']}, 02:48:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['a11yr', 02:48:45 INFO - 'ts_paint', 02:48:45 INFO - 'tpaint', 02:48:45 INFO - 'sessionrestore', 02:48:45 INFO - 'sessionrestore_no_auto_restore', 02:48:45 INFO - 'tabpaint']}, 02:48:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['tsvgx', 02:48:45 INFO - 'tsvgr_opacity', 02:48:45 INFO - 'tart', 02:48:45 INFO - 'tscrollx', 02:48:45 INFO - 'cart']}, 02:48:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:45 INFO - 'tsvgr_opacity', 02:48:45 INFO - 'tart', 02:48:45 INFO - 'tscrollx', 02:48:45 INFO - 'cart']}, 02:48:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'talos_options': ['--disable-e10s'], 02:48:45 INFO - 'tests': ['tp5o']}, 02:48:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'tests': ['tp5o']}, 02:48:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'talos_options': ['--disable-e10s', 02:48:45 INFO - '--xperf_path', 02:48:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:45 INFO - 'tests': ['tp5n']}, 02:48:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:45 INFO - 'talos_options': ['--xperf_path', 02:48:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:45 INFO - 'tests': ['tp5n']}}, 02:48:45 INFO - 'talos.zip': {'path': '', 02:48:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:45 INFO - Running post-action listener: _resource_record_post_action 02:48:45 INFO - ##### 02:48:45 INFO - ##### Finished populate-webroot step (success) 02:48:45 INFO - ##### 02:48:45 INFO - ##### 02:48:45 INFO - ##### Running create-virtualenv step. 02:48:45 INFO - ##### 02:48:45 INFO - Running pre-action listener: _resource_record_pre_action 02:48:45 INFO - Running main action method: create_virtualenv 02:48:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:45 INFO - Using real prefix '/usr' 02:48:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:48 INFO - Installing pip.................done. 02:48:48 INFO - Return code: 0 02:48:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:48 INFO - Using env: {'DISPLAY': ':0', 02:48:48 INFO - 'HOME': '/home/cltbld', 02:48:48 INFO - 'LANG': 'en_US.UTF-8', 02:48:48 INFO - 'LANGUAGE': 'en_US:en', 02:48:48 INFO - 'LOGNAME': 'cltbld', 02:48:48 INFO - 'MAIL': '/var/mail/cltbld', 02:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:48 INFO - 'MOZ_NO_REMOTE': '1', 02:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:48 INFO - 'NO_EM_RESTART': '1', 02:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:48 INFO - 'PWD': '/builds/slave/test', 02:48:48 INFO - 'SHELL': '/bin/bash', 02:48:48 INFO - 'SHLVL': '1', 02:48:48 INFO - 'TERM': 'linux', 02:48:48 INFO - 'TMOUT': '86400', 02:48:48 INFO - 'USER': 'cltbld', 02:48:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:48 INFO - '_': '/tools/buildbot/bin/python'} 02:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:48:48 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:48:48 INFO - Using env: {'DISPLAY': ':0', 02:48:48 INFO - 'HOME': '/home/cltbld', 02:48:48 INFO - 'LANG': 'en_US.UTF-8', 02:48:48 INFO - 'LANGUAGE': 'en_US:en', 02:48:48 INFO - 'LOGNAME': 'cltbld', 02:48:48 INFO - 'MAIL': '/var/mail/cltbld', 02:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:48 INFO - 'MOZ_NO_REMOTE': '1', 02:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:48 INFO - 'NO_EM_RESTART': '1', 02:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:48 INFO - 'PWD': '/builds/slave/test', 02:48:48 INFO - 'SHELL': '/bin/bash', 02:48:48 INFO - 'SHLVL': '1', 02:48:48 INFO - 'TERM': 'linux', 02:48:48 INFO - 'TMOUT': '86400', 02:48:48 INFO - 'USER': 'cltbld', 02:48:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:48 INFO - '_': '/tools/buildbot/bin/python'} 02:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:48 INFO - Downloading/unpacking psutil>=0.7.1 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:50 INFO - Installing collected packages: psutil 02:48:50 INFO - Running setup.py install for psutil 02:48:50 INFO - building 'psutil._psutil_linux' extension 02:48:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:48:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:48:50 INFO - building 'psutil._psutil_posix' extension 02:48:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:48:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:51 INFO - Successfully installed psutil 02:48:51 INFO - Cleaning up... 02:48:51 INFO - Return code: 0 02:48:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:48:51 INFO - Using env: {'DISPLAY': ':0', 02:48:51 INFO - 'HOME': '/home/cltbld', 02:48:51 INFO - 'LANG': 'en_US.UTF-8', 02:48:51 INFO - 'LANGUAGE': 'en_US:en', 02:48:51 INFO - 'LOGNAME': 'cltbld', 02:48:51 INFO - 'MAIL': '/var/mail/cltbld', 02:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:51 INFO - 'MOZ_NO_REMOTE': '1', 02:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:51 INFO - 'NO_EM_RESTART': '1', 02:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:51 INFO - 'PWD': '/builds/slave/test', 02:48:51 INFO - 'SHELL': '/bin/bash', 02:48:51 INFO - 'SHLVL': '1', 02:48:51 INFO - 'TERM': 'linux', 02:48:51 INFO - 'TMOUT': '86400', 02:48:51 INFO - 'USER': 'cltbld', 02:48:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:51 INFO - '_': '/tools/buildbot/bin/python'} 02:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:53 INFO - Installing collected packages: mozsystemmonitor 02:48:53 INFO - Running setup.py install for mozsystemmonitor 02:48:53 INFO - Successfully installed mozsystemmonitor 02:48:53 INFO - Cleaning up... 02:48:53 INFO - Return code: 0 02:48:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:53 INFO - Using env: {'DISPLAY': ':0', 02:48:53 INFO - 'HOME': '/home/cltbld', 02:48:53 INFO - 'LANG': 'en_US.UTF-8', 02:48:53 INFO - 'LANGUAGE': 'en_US:en', 02:48:53 INFO - 'LOGNAME': 'cltbld', 02:48:53 INFO - 'MAIL': '/var/mail/cltbld', 02:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:53 INFO - 'MOZ_NO_REMOTE': '1', 02:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:53 INFO - 'NO_EM_RESTART': '1', 02:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:53 INFO - 'PWD': '/builds/slave/test', 02:48:53 INFO - 'SHELL': '/bin/bash', 02:48:53 INFO - 'SHLVL': '1', 02:48:53 INFO - 'TERM': 'linux', 02:48:53 INFO - 'TMOUT': '86400', 02:48:53 INFO - 'USER': 'cltbld', 02:48:53 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:53 INFO - '_': '/tools/buildbot/bin/python'} 02:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - Downloading docopt-0.6.1.tar.gz 02:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:56 INFO - Running setup.py install for blobuploader 02:48:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:56 INFO - Running setup.py install for requests 02:48:56 INFO - Running setup.py install for docopt 02:48:56 INFO - Successfully installed blobuploader requests docopt 02:48:56 INFO - Cleaning up... 02:48:56 INFO - Return code: 0 02:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:56 INFO - Using env: {'DISPLAY': ':0', 02:48:56 INFO - 'HOME': '/home/cltbld', 02:48:56 INFO - 'LANG': 'en_US.UTF-8', 02:48:56 INFO - 'LANGUAGE': 'en_US:en', 02:48:56 INFO - 'LOGNAME': 'cltbld', 02:48:56 INFO - 'MAIL': '/var/mail/cltbld', 02:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:56 INFO - 'MOZ_NO_REMOTE': '1', 02:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:56 INFO - 'NO_EM_RESTART': '1', 02:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:56 INFO - 'PWD': '/builds/slave/test', 02:48:56 INFO - 'SHELL': '/bin/bash', 02:48:56 INFO - 'SHLVL': '1', 02:48:56 INFO - 'TERM': 'linux', 02:48:56 INFO - 'TMOUT': '86400', 02:48:56 INFO - 'USER': 'cltbld', 02:48:56 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:56 INFO - '_': '/tools/buildbot/bin/python'} 02:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:57 INFO - Running setup.py (path:/tmp/pip-Jyu65T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:57 INFO - Running setup.py (path:/tmp/pip-gV9XoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:57 INFO - Running setup.py (path:/tmp/pip-mGbIiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:57 INFO - Running setup.py (path:/tmp/pip-5Lae3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:57 INFO - Running setup.py (path:/tmp/pip-moG40w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:57 INFO - Running setup.py (path:/tmp/pip-ayIvwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:57 INFO - Running setup.py (path:/tmp/pip-ICxrBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:57 INFO - Running setup.py (path:/tmp/pip-e5CI9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:57 INFO - Running setup.py (path:/tmp/pip-FH1zul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:57 INFO - Running setup.py (path:/tmp/pip-Tv5l1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:57 INFO - Running setup.py (path:/tmp/pip-lY63wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:57 INFO - Running setup.py (path:/tmp/pip-VgcJI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:58 INFO - Running setup.py (path:/tmp/pip-bU6ZoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:58 INFO - Running setup.py (path:/tmp/pip-nv9JtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:58 INFO - Running setup.py (path:/tmp/pip-_yo6ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:58 INFO - Running setup.py (path:/tmp/pip-VmkLTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:58 INFO - Running setup.py (path:/tmp/pip-3FzlMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:58 INFO - Running setup.py install for manifestparser 02:48:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:58 INFO - Running setup.py install for mozcrash 02:48:58 INFO - Running setup.py install for mozdebug 02:48:58 INFO - Running setup.py install for mozdevice 02:48:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:58 INFO - Running setup.py install for mozfile 02:48:58 INFO - Running setup.py install for mozhttpd 02:48:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozinfo 02:48:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozInstall 02:48:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozleak 02:48:59 INFO - Running setup.py install for mozlog 02:48:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for moznetwork 02:48:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozprocess 02:48:59 INFO - Running setup.py install for mozprofile 02:48:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozrunner 02:48:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:59 INFO - Running setup.py install for mozscreenshot 02:48:59 INFO - Running setup.py install for moztest 02:49:00 INFO - Running setup.py install for mozversion 02:49:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:49:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:49:00 INFO - Cleaning up... 02:49:00 INFO - Return code: 0 02:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:49:00 INFO - Using env: {'DISPLAY': ':0', 02:49:00 INFO - 'HOME': '/home/cltbld', 02:49:00 INFO - 'LANG': 'en_US.UTF-8', 02:49:00 INFO - 'LANGUAGE': 'en_US:en', 02:49:00 INFO - 'LOGNAME': 'cltbld', 02:49:00 INFO - 'MAIL': '/var/mail/cltbld', 02:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:00 INFO - 'MOZ_NO_REMOTE': '1', 02:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:00 INFO - 'NO_EM_RESTART': '1', 02:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:00 INFO - 'PWD': '/builds/slave/test', 02:49:00 INFO - 'SHELL': '/bin/bash', 02:49:00 INFO - 'SHLVL': '1', 02:49:00 INFO - 'TERM': 'linux', 02:49:00 INFO - 'TMOUT': '86400', 02:49:00 INFO - 'USER': 'cltbld', 02:49:00 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:00 INFO - '_': '/tools/buildbot/bin/python'} 02:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:49:00 INFO - Running setup.py (path:/tmp/pip-LRe5kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:49:00 INFO - Running setup.py (path:/tmp/pip-MmtvTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:49:00 INFO - Running setup.py (path:/tmp/pip-wbwAvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:49:00 INFO - Running setup.py (path:/tmp/pip-XJTLg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:49:00 INFO - Running setup.py (path:/tmp/pip-A4gPh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:49:00 INFO - Running setup.py (path:/tmp/pip-D5L2fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:49:00 INFO - Running setup.py (path:/tmp/pip-lPuZTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:49:00 INFO - Running setup.py (path:/tmp/pip-yxn1Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:49:01 INFO - Running setup.py (path:/tmp/pip-X4J9VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:49:01 INFO - Running setup.py (path:/tmp/pip-9eUPGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:49:01 INFO - Running setup.py (path:/tmp/pip-DIVzrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:49:01 INFO - Running setup.py (path:/tmp/pip-ayL4RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:49:01 INFO - Running setup.py (path:/tmp/pip-tG3Da6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:49:01 INFO - Running setup.py (path:/tmp/pip-7MHm9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:01 INFO - Running setup.py (path:/tmp/pip-HJEDEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:49:01 INFO - Running setup.py (path:/tmp/pip-3qdgwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:49:01 INFO - Running setup.py (path:/tmp/pip-rWJ8yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:49:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:03 INFO - Downloading blessings-1.6.tar.gz 02:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:49:03 INFO - Installing collected packages: blessings 02:49:03 INFO - Running setup.py install for blessings 02:49:03 INFO - Successfully installed blessings 02:49:03 INFO - Cleaning up... 02:49:03 INFO - Return code: 0 02:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:04 INFO - Reading from file tmpfile_stdout 02:49:04 INFO - Current package versions: 02:49:04 INFO - argparse == 1.2.1 02:49:04 INFO - blessings == 1.6 02:49:04 INFO - blobuploader == 1.2.4 02:49:04 INFO - docopt == 0.6.1 02:49:04 INFO - manifestparser == 1.1 02:49:04 INFO - mozInstall == 1.12 02:49:04 INFO - mozcrash == 0.17 02:49:04 INFO - mozdebug == 0.1 02:49:04 INFO - mozdevice == 0.48 02:49:04 INFO - mozfile == 1.2 02:49:04 INFO - mozhttpd == 0.7 02:49:04 INFO - mozinfo == 0.9 02:49:04 INFO - mozleak == 0.1 02:49:04 INFO - mozlog == 3.1 02:49:04 INFO - moznetwork == 0.27 02:49:04 INFO - mozprocess == 0.22 02:49:04 INFO - mozprofile == 0.28 02:49:04 INFO - mozrunner == 6.11 02:49:04 INFO - mozscreenshot == 0.1 02:49:04 INFO - mozsystemmonitor == 0.0 02:49:04 INFO - moztest == 0.7 02:49:04 INFO - mozversion == 1.4 02:49:04 INFO - psutil == 3.1.1 02:49:04 INFO - requests == 1.2.3 02:49:04 INFO - wsgiref == 0.1.2 02:49:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:49:04 INFO - Using env: {'DISPLAY': ':0', 02:49:04 INFO - 'HOME': '/home/cltbld', 02:49:04 INFO - 'LANG': 'en_US.UTF-8', 02:49:04 INFO - 'LANGUAGE': 'en_US:en', 02:49:04 INFO - 'LOGNAME': 'cltbld', 02:49:04 INFO - 'MAIL': '/var/mail/cltbld', 02:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:04 INFO - 'MOZ_NO_REMOTE': '1', 02:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:04 INFO - 'NO_EM_RESTART': '1', 02:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:04 INFO - 'PWD': '/builds/slave/test', 02:49:04 INFO - 'SHELL': '/bin/bash', 02:49:04 INFO - 'SHLVL': '1', 02:49:04 INFO - 'TERM': 'linux', 02:49:04 INFO - 'TMOUT': '86400', 02:49:04 INFO - 'USER': 'cltbld', 02:49:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:04 INFO - '_': '/tools/buildbot/bin/python'} 02:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:49:04 INFO - Cleaning up... 02:49:04 INFO - Return code: 0 02:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:49:04 INFO - Using env: {'DISPLAY': ':0', 02:49:04 INFO - 'HOME': '/home/cltbld', 02:49:04 INFO - 'LANG': 'en_US.UTF-8', 02:49:04 INFO - 'LANGUAGE': 'en_US:en', 02:49:04 INFO - 'LOGNAME': 'cltbld', 02:49:04 INFO - 'MAIL': '/var/mail/cltbld', 02:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:04 INFO - 'MOZ_NO_REMOTE': '1', 02:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:04 INFO - 'NO_EM_RESTART': '1', 02:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:04 INFO - 'PWD': '/builds/slave/test', 02:49:04 INFO - 'SHELL': '/bin/bash', 02:49:04 INFO - 'SHLVL': '1', 02:49:04 INFO - 'TERM': 'linux', 02:49:04 INFO - 'TMOUT': '86400', 02:49:04 INFO - 'USER': 'cltbld', 02:49:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:04 INFO - '_': '/tools/buildbot/bin/python'} 02:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:04 INFO - Downloading/unpacking jsonschema 02:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:49:06 INFO - Downloading/unpacking functools32 (from jsonschema) 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:49:06 INFO - warning: no files found matching '*.txt' 02:49:06 INFO - no previously-included directories found matching 'build' 02:49:06 INFO - no previously-included directories found matching 'dist' 02:49:06 INFO - no previously-included directories found matching '.git*' 02:49:06 INFO - Installing collected packages: jsonschema, functools32 02:49:06 INFO - Running setup.py install for functools32 02:49:06 INFO - warning: no files found matching '*.txt' 02:49:06 INFO - no previously-included directories found matching 'build' 02:49:06 INFO - no previously-included directories found matching 'dist' 02:49:06 INFO - no previously-included directories found matching '.git*' 02:49:06 INFO - Successfully installed jsonschema functools32 02:49:06 INFO - Cleaning up... 02:49:06 INFO - Return code: 0 02:49:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa790561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:49:06 INFO - Using env: {'DISPLAY': ':0', 02:49:06 INFO - 'HOME': '/home/cltbld', 02:49:06 INFO - 'LANG': 'en_US.UTF-8', 02:49:06 INFO - 'LANGUAGE': 'en_US:en', 02:49:06 INFO - 'LOGNAME': 'cltbld', 02:49:06 INFO - 'MAIL': '/var/mail/cltbld', 02:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:06 INFO - 'MOZ_NO_REMOTE': '1', 02:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:06 INFO - 'NO_EM_RESTART': '1', 02:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:06 INFO - 'PWD': '/builds/slave/test', 02:49:06 INFO - 'SHELL': '/bin/bash', 02:49:06 INFO - 'SHLVL': '1', 02:49:06 INFO - 'TERM': 'linux', 02:49:06 INFO - 'TMOUT': '86400', 02:49:06 INFO - 'USER': 'cltbld', 02:49:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:06 INFO - '_': '/tools/buildbot/bin/python'} 02:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:06 INFO - Downloading/unpacking flake8 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:49:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:49:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:49:09 INFO - no previously-included directories found matching 'docs/_build' 02:49:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:49:09 INFO - Running setup.py install for pep8 02:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:49:09 INFO - no previously-included directories found matching 'docs/_build' 02:49:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:49:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:49:09 INFO - Cleaning up... 02:49:09 INFO - Return code: 0 02:49:09 INFO - Running post-action listener: _resource_record_post_action 02:49:09 INFO - Running post-action listener: _start_resource_monitoring 02:49:09 INFO - Starting resource monitoring. 02:49:09 INFO - ##### 02:49:09 INFO - ##### Finished create-virtualenv step (success) 02:49:09 INFO - ##### 02:49:09 INFO - ##### 02:49:09 INFO - ##### Running install step. 02:49:09 INFO - ##### 02:49:09 INFO - Running pre-action listener: _resource_record_pre_action 02:49:09 INFO - Running main action method: install 02:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:10 INFO - Reading from file tmpfile_stdout 02:49:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:49:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:49:10 INFO - Reading from file tmpfile_stdout 02:49:10 INFO - Output received: 02:49:10 INFO - Usage: mozinstall [options] installer 02:49:10 INFO - Options: 02:49:10 INFO - -h, --help show this help message and exit 02:49:10 INFO - -d DEST, --destination=DEST 02:49:10 INFO - Directory to install application into. [default: 02:49:10 INFO - "/builds/slave/test"] 02:49:10 INFO - --app=APP Application being installed. [default: firefox] 02:49:10 INFO - mkdir: /builds/slave/test/build/application 02:49:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:49:25 INFO - Reading from file tmpfile_stdout 02:49:25 INFO - Output received: 02:49:25 INFO - /builds/slave/test/build/application/firefox/firefox 02:49:25 INFO - Running post-action listener: _resource_record_post_action 02:49:25 INFO - ##### 02:49:25 INFO - ##### Finished install step (success) 02:49:25 INFO - ##### 02:49:25 INFO - ##### 02:49:25 INFO - ##### Running run-tests step. 02:49:25 INFO - ##### 02:49:25 INFO - Running pre-action listener: _resource_record_pre_action 02:49:25 INFO - Running main action method: run_tests 02:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:25 INFO - Python 2.7.3 02:49:25 INFO - Return code: 0 02:49:25 INFO - grabbing minidump binary from tooltool 02:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:49:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:25 INFO - Return code: 0 02:49:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:26 INFO - Return code: 0 02:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:49:26 INFO - Using env: {'DISPLAY': ':0', 02:49:26 INFO - 'HOME': '/home/cltbld', 02:49:26 INFO - 'LANG': 'en_US.UTF-8', 02:49:26 INFO - 'LANGUAGE': 'en_US:en', 02:49:26 INFO - 'LOGNAME': 'cltbld', 02:49:26 INFO - 'MAIL': '/var/mail/cltbld', 02:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:26 INFO - 'MOZ_NO_REMOTE': '1', 02:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:26 INFO - 'NO_EM_RESTART': '1', 02:49:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:26 INFO - 'PWD': '/builds/slave/test', 02:49:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:26 INFO - 'SHELL': '/bin/bash', 02:49:26 INFO - 'SHLVL': '1', 02:49:26 INFO - 'TERM': 'linux', 02:49:26 INFO - 'TMOUT': '86400', 02:49:26 INFO - 'USER': 'cltbld', 02:49:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385', 02:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:26 INFO - '_': '/tools/buildbot/bin/python'} 02:49:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:49:27 INFO - mozversion application_buildid: 20160509020948 02:49:27 INFO - mozversion application_changeset: 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 02:49:27 INFO - mozversion application_display_name: Nightly 02:49:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:27 INFO - mozversion application_name: Firefox 02:49:27 INFO - mozversion application_remotingname: firefox 02:49:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:27 INFO - mozversion application_vendor: Mozilla 02:49:27 INFO - mozversion application_version: 49.0a1 02:49:27 INFO - mozversion platform_buildid: 20160509020948 02:49:27 INFO - mozversion platform_changeset: 8deb0d7312e5688d4a2e8cb7837b1a9bca2f9006 02:49:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:27 INFO - mozversion platform_version: 49.0a1 02:49:27 INFO - using testdate: 1462787367 02:49:27 INFO - actual date: 1462787367 02:49:27 INFO - starting webserver on 'localhost:54941' 02:49:27 INFO - SUITE-START | Running 2 tests 02:49:27 INFO - TEST-START | dromaeo_css 02:49:27 INFO - operating with platform_type : linux_ 02:49:27 INFO - Initialising browser for dromaeo_css test... 02:49:27 INFO - TEST-INFO | started process 4794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibz_ZB/profile http://localhost:54941/getInfo.html) 02:49:31 INFO - PROCESS | 4794 | __metrics Screen width/height:1600/1200 02:49:31 INFO - PROCESS | 4794 | colorDepth:24 02:49:31 INFO - PROCESS | 4794 | Browser inner width/height: 1024/697 02:49:31 INFO - PROCESS | 4794 | __metrics 02:49:33 ERROR - PROCESS | 4794 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:49:33 INFO - TEST-INFO | 4794: exit 0 02:49:33 INFO - Browser initialized. 02:49:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:33 INFO - TEST-INFO | started process 4875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibz_ZB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:45 INFO - PROCESS | 4875 | RSS: Main: 153968640 02:49:45 INFO - PROCESS | 4875 | 02:50:37 INFO - PROCESS | 4875 | 1462787437176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:52:48 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54941/tests/dromaeo/cssquery-ext.html) 02:52:50 INFO - PROCESS | 4875 | RSS: Main: 267382784 02:52:50 INFO - PROCESS | 4875 | 02:55:52 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-ext.html (next: http://localhost:54941/tests/dromaeo/cssquery-jquery.html) 02:55:53 INFO - PROCESS | 4875 | RSS: Main: 230092800 02:55:53 INFO - PROCESS | 4875 | 02:58:55 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54941/tests/dromaeo/cssquery-mootools.html) 02:58:56 INFO - PROCESS | 4875 | RSS: Main: 244740096 02:58:56 INFO - PROCESS | 4875 | 03:01:58 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54941/tests/dromaeo/cssquery-prototype.html) 03:01:59 INFO - PROCESS | 4875 | RSS: Main: 226959360 03:01:59 INFO - PROCESS | 4875 | 03:05:01 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54941/tests/dromaeo/cssquery-yui.html) 03:05:02 INFO - PROCESS | 4875 | RSS: Main: 204652544 03:05:02 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | Cycle 1(1): loaded http://localhost:54941/tests/dromaeo/cssquery-yui.html (next: http://localhost:54941/tests/dromaeo/cssquery-dojo.html) 03:08:05 INFO - PROCESS | 4875 | RSS: Main: 269889536 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | __start_tp_report 03:08:05 INFO - PROCESS | 4875 | _x_x_mozilla_page_load 03:08:05 INFO - PROCESS | 4875 | _x_x_mozilla_page_load_details 03:08:05 INFO - PROCESS | 4875 | |i|pagename|runs| 03:08:05 INFO - PROCESS | 4875 | |0;dojo.html;2559.0787316566034;2582.3673200065987;2615.50305441966;2633.2100369889026;2634.881430335635;4516.232240519112;4536.954630453694;4556.088782243556;4571.2228921083415;4605.516420775821;4496.752678602676;4516;4517.4804897436725;4568.132054909564;4606.83876064337;4100.528439229497;4190.979045104786;4198.9370159447635;4236.724612900167;4389.868303950887;4310.48274207094;4333.046729719473;4345.109252603209;4372.3878656988045;4390.97804510977;4159.188958153161;4203.096334288112;4205.558416366299;4214.157168566268;4247.532771395144;4247.851325203603;4258.893527661802;4259.659227261843;4315.395844581761;4328.264195086843;4249.851255206053;4259.3610958356185;4270.124624452011;4271.039016221325;4305.418768466248;4395.538468460798;4444.977775111104;4477.082198149372;4549;4589.380433641482;4915.262710593403;4978.701277923336;4983.6760610560195;4994.550490455877;4998.7250701211415;4965.900681986376;4967.826126085606;4983.476734942851;5010.599152067826;5013.498650134994;4472.262076757331;4615.30770384445;4648.209804333272;4658.673892827537;4687.062587482483;5067.467915868854;5129.487051294916;5142.254373115952;5142.280080788692;5149.2276158576515;4894.167991441393;4931.605471562339;4939.87650308738;4950.5544500994365;4955.4796746341835;4757.024809913959;4900.387451568554;4907.214845624683;4919.557239848431;4975.179095449211;4892.779824907817;4913.06651736169;4920.089783390084;4931.556159945622;4980.228064649985;4708.858734237979;4904.828331008398;4905.141600219948;4909.926351104737;4959.479254678279;4085.816138273785;4135.669146468275;4173.478315210598;4183.937240941388;4219.43037689914;3678.6137455567314;3685.3182161300247;3690.538682664667;3727.3290807654885;3748.681362084199;4225.9577404226175;4229.2175947449205;4236.195122926634;4259.659227261812;4273.786310684453;4754.690945088558;4865.683730557503;4892.094962431962;4895.143349913751;4926.408830940239;4192.601702838226;4198.832046718097;4203.600657937491;4206.41110244566;4232.555581663881;4483.50681425043;4484.977575112169;4488.955110448919;4518.096380723869;4531.682782205214;4465.464144302705;4565.452145742533;4612.123696497655;4630.930536042029;4644.953550464587;4989.501049894981;4994.350734404649;4994.4755800640405;5004.274380214775;5024.246363045572;4458.933116003198;4610.354550362885;4620.399348084862;4626.37543931565;4676.275177347517;4750.026244619914;4758.04839032188;4784.832530861403;4787.54518320759;4796.136695394863;4830.686005409637;4833.3958255218095;4849.442314133919;4860.65975381734;4916.606671466346;4664.953350466452;4694.554017368345;4715.905681886412;4721.811127554859;4766.285057241442;4645.140648979949;4662.650301227353;4686.92969605463;4710.24636058229;4726.787294571821;4680.929786053144;4683.110209060404;4717.457492388282;4723.055388922298;4724.220503616864;4672.719636821802;4675.509071547439;4765.5949244314625;4812.783424745825;4816.15717249487;4563.908721825611;4605.171069207441;4641.535846415331;4673.7429441381055;4683.8360657376825 03:08:05 INFO - PROCESS | 4875 | |1;ext.html;575.9251297331347;610.2189197826782;610.2707264818541;611.339753066688;621.4375989729295;27510;40947.79526102369;41054.17891642165;42140;42329.788351058276;38639.42040869389;38930.22139557207;43357.349639755426;43369.132617347634;43431.78284108575;7507.361874240669;8094.43338966274;8227.95886020569;8235.38234632402;8238.176182381743;10118.747031324203;10379.48102594871;10393.220508461858;10633.096186824128;10697.144228461744;10291.33106348085;10381.273310868242;10391.480425978709;10394.532246048946;10395.116415104725;10219.540120694512;10229.846552301722;10265.948670256676;10319.277650564463;10328.328658637201;10240.334378265463;10324.535395907202;10328.896711032869;10332.225083118796;10337.0696637303;38395;38447.615523844965;38455.61544384548;38789.612103878884;38918;3298.7690861639694;3334.1664583854035;3356.56364672591;3395.643457436958;3411.9147021324416;29671.851640741876;30460.69539304623;30683.232919176975;30698.69301307003;30934.53598196029;3373.645767194458;3443.724502039831;3448.4654878493625;3551.1122219445137;3562.1985053363046;183976;184863;184884;184894;185124;55063.44936550583;56032.439675603535;56058.159127613115;56072.719636401554;56238;59597.40402596005;59623;59791;59830.40169598335;60022.39977600255;15243.695126097417;15577.84422155764;15579.14314712679;15653.217339132998;15671.216439177995;10124.696259112092;10127.949360253151;10301;10569.048785609331;11640.417979101012;17319.826801732073;17469.21388537519;17552.210150543255;17694.469165925042;17793.822061779218;6233.906491402633;6286.465650419674;6287.308396076428;6441.0982462455295;6510.967445162744;864.8443280209497;896.4845214001975;994.3387647214666;1048.501961568249;1089.1722291058852;26373.96699379596;28247.43505129886;28358;28499.28751781222;28766.424671506873;1045.320541647935;1061.1510791366875;1065.2010991756183;1087.7389426537575;1170.3270619393882;14326;14949.775753363709;14959.92520037393;15098.635430865423;15201;326263;328810;331485;331689;331952;50580;50704.23943640848;50714.23928641073;50738;50866.237006444935;1151.5451396698256;1272.401971073594;1307.607717684691;1321.1082519299243;1330.6606815262046;28229.43541129207;29461.263468412602;29684;30039;30435.391292174474;42205.155896881275;42318;42898.78550607227;42902;42990.35514467223;205528;206346;206514;207053;207413;22838.31485055451;23577.646335305326;25334.239972800846;26126.73873261243;26155.869220653774;43366;43379.132417352106;43464.56535434605;43760.343594845464;44276.33585496156;36771;36848.63151368452;36952;36953.630463695015;37158.6284137166;36324.63675363213;36517.634823651424;36745.265094698494;36788.264234715694;37136;35942.640573594974;35980.28039439144;36191.27617447584;36526;37000.44499332566;32200.19499512531;32601.836990814892;33053.33033864909;33680.15799604932;33706.325873482885;25381.74618253794;25525.61711574291;26564;26715.19854404371;28242.293942650776 03:08:05 INFO - PROCESS | 4875 | |2;jquery.html;370.1763576043304;376.9868054618088;385.695300712437;394.6290486942272;401.2817057467134;16076.196190190487;17368.652626947453;17549.298028078876;17991.73012404815;18048.81951180488;16718.16409179542;17108.74336884948;17401.3039478421;17487.387941422054;17522.12389380532;5092.337996060507;5255.474452554752;5255.710935898524;5277.261183434322;5282.154855223165;3591.856325746967;5344.786208551673;6108.450239478446;6110.755569777203;6111.541634377417;6011.338752737217;6037.094435834616;6048.183495228154;6063.514918806485;6079.817605471843;5828.125781132821;6144.692765361714;6144.969275153618;6154.26148862135;6156.045812898986;5171.482851714836;5372.623916325859;5373.570114390839;5377.731113444352;5380.677159370412;11524.19330646855;12165.756684866254;21032.894835525723;21148.894255528623;21202.575948480942;1845.5478407790042;1928.2479832865195;1935.1775495414533;1964.2732189089986;2290.8052815510537;9221.30840186982;9275.58259878307;9410.294227932933;9735.464549449778;9843.114119729258;1628.2496316459853;1676;1680.1095419427722;1771.7430972508914;1802.8828126171888;48155;52149.73925130388;54834.72582637061;65183.67408162929;66262.33737662659;8801.295896328278;9405.623775049058;9505.809883802285;9685.17675997534;10462.233595905467;13096.279704616338;13108;13125.54060607874;13143.07998440119;13158.802617960739;7068.505204635626;7204.56772593646;7373.8156546086775;7489.887651685229;7534.35957943581;6309.400606942333;6406.6476343800605;7032.226455089936;7049.189343225492;7049.224585295613;3962.7574644738875;4227.534971153171;4399.340098985178;4545.818167273272;4592.586667199968;1836.173721825184;1850.5096149520389;1863.2174486715612;1868.6169335286233;1889.998300900525;865.3985480091402;985.7437066362797;1001.9551557906054;1006.884208316053;1012.4684540616236;16910;17285.222165002604;17372.47882563525;17615.559611009827;17884.642307153783;885.6059053721033;901.9052999434965;931.1712575807537;939.5302348825587;958.8226178157063;9341.766455838522;9663.951680241555;9759.438489841734;9952.552135153936;9962.252831037556;322174;390414;406810;419279;419884;79537;79579.60210198912;79888.600556998;80461;80606.59696701597;814.4461765999059;900.527223207808;917.1195652173988;963.4893506441738;966.4974213408988;15836.52490425289;15941.521754347388;15960.20198990069;16091.67816643684;16230.67538649244;35227;35355.46966795449;35449;36729.816350918074;36888.81555592205;49300;49337.75331123322;49415.25877111918;49527.75236123797;50211;4708.670393072452;7116.43068554504;7828.138904720362;7878.133405325295;8035.035795704319;10233.437160956219;10839.187060970617;10986.945065274942;11006.504707288032;11180.273282236629;9572.856407154037;9593.664221752206;9779.315447918578;9812.313138080552;10163.390196588229;9575.281853860848;10055.49722513886;10097.848532271875;10110.898891010997;10131.189504839742;9808.215342772419;10067.798644027225;10072.0935115837;10072.597096116073;10377.636782712569;7752.0697516298405;7806.336461400618;7872.2914937653595;7874.251946065115;8084.353251739729;8947.373683842068;9976.850347244943;10109.797804044025;10135.189184865341;10460.424676642857 03:08:05 INFO - PROCESS | 4875 | |3;mootools.html;1283.0761851466953;1480.0379753160444;1504.1727050122433;1679.252732534023;1828.6525560143564;6464.547481676284;7263.055802745643;7473.588952607612;7486.513376630529;7675.6545955432;7409.666565004588;7537.585432801194;7550.848983020336;7558.546487210771;7559.206283340252;2203.933881983543;2228.3760547046854;2233.597952368573;2234.754177040524;2235.4970131720397;2062.185436752482;2102.8002339777695;2104.968425473619;2108.293721603257;2109.072008316336;2175.434387059368;2185.49733561281;2201.1415547936317;2203.537257175995;2222.066731972567;2129.3824790810645;2133.114757375687;2136.113512892148;2137.508373074194;2137.6579747240444;1900.2399040383818;1929.1608150454597;1945.114972687438;1951.6487032334173;1952.492351988479;7233.385162261214;7271.600061996588;7294.489385743;7303.780886573411;7490.5131166474;4387.670924680661;4483.14820184164;4485.6860019798305;4506.571875671806;4508.842190523316;2762.392273699783;2832.61759662445;2865.684774674784;2866.3550701092295;2873.195505258531;909.7816524034184;919.4115765909823;924.4591913730409;932.5989824375516;934.0799312677008;9715.562799674031;9722.708318750449;9747.220222382193;9773.364731292444;9787.314887957846;3876.2247550490015;3925.9214815703526;4015.8996025099605;4029.9194016119513;4040.91918161641;7845.490043147177;7860.646270917822;7865.292123708894;7891.289783919475;7895.289423951757;4369.694121411534;4384.802683879233;4415.933760993587;4416.381706561084;4423.159599676052;3637.454381842692;3995.700322475826;4046.5953404659886;4073.837046518106;4178;3329.433996220648;3362.613299470592;3399.5240666306736;3414.6243913169533;3442.9483557746653;962.0667952086465;1008.9949550252348;1017.8829434614966;1018.5314755212537;1018.8217062014267;784.4783219159195;823.4935514658442;864.4208380385157;871.5642178910545;916.4638686368415;5194.584433245407;5212.139996900545;5239.266502689627;5248.107821670249;5312.5484333832055;438.3928259360745;444.9621782148554;446.6181414890222;452.10934459116146;453.82754553269547;3540.2211513466996;3565.7682250653625;3572.6605972432576;3601.5318008658705;3623.4927110204594;8706.956465217634;9086.636534538677;9088.636454541876;9210.03294654065;9261.44431334122;8990.28077753778;9022.819543609092;9074.092590741006;9133.634654613874;9148;6515.348465153542;6722.058911752359;6757;6858.417034552119;6913.792586222421;5055.16589762685;5184.300119483822;5240.973795131;5303.124984377689;5366.195070739421;8441.198086181803;8525.019622743464;8570.314374849871;8605.311575073854;8717.084706106021;8472.576371181292;8647.827043459221;8720.302375810046;8733.432326898732;8746.825063498822;5784.132380143013;6353.237611486466;6391.424771770563;6434.742610295536;6468.579542329733;7126.216116227314;7390;7392.7042918284815;7393.519421237603;7408.777736667908;6409.423151916163;6603.900941485786;6636.070950067091;6657.3009833966735;6678.7328506859185;6325.652089135142;6519.315471875385;6596.571222870498;6640.236372817188;6724.29394913527;6181.505479561534;6253.687315634291;6256.124142619946;6268.216472940882;6297.433231009231;4531.207038768136;4531.25234336344;4694.108119457293;4729.36153619257;4755.904881902274;4227.894302642459;4247.51153617338;4293.270144075577;4369.519352871245;4375.365571992107 03:08:05 INFO - PROCESS | 4875 | |4;prototype.html;304.3502122967465;306.52641668621976;309.35653840012776;309.40748466686296;316.33569504041515;4710.693804902688;4753.405824271966;4778.187708089625;4792.9281060784115;4803.1354356215825;4648.953510464894;4662.347271382009;4664.743439110847;4688.413948256468;4716.693414928036;3502.3870822606004;3631.2918980798754;3642.235130622559;3749.7000239980734;3774.8112594370173;3717.8512859485586;3742.5321834770652;3746.6253374662588;3754.155315054118;3761.8495260189698;3497.422925217336;3702.7225607165483;3726.3292607330804;3733.626637336272;3749.8375503593975;3592.4790905318714;3725;3728.2357116791263;3737.5328083989502;3745.1198968242443;3293.357795229931;3298.65364136767;3298.884539041146;3303.4219011672863;3318.668133186686;4465.129299786543;4470.910581788378;4480.8879778005485;4490.7979140938405;4494.337095274769;3940.940885886714;4212.389203565496;4221.767802770846;4245.469316335458;4262.2754131797665;4949.628777841676;4949.975250123763;4951.876203094916;4969.229769385751;4977.800887964477;3534.5581802274714;3552.182997910495;3555.6799888010205;3564.48314994327;3581.4627805829073;5006.874828129289;5136;5148.433672296044;5151.175811870083;5152.201408781645;3569.625189355132;3578.874739384109;3599.280143971164;3600.243948770735;3612.096975756061;3625.2386998730035;3646.690031347312;3649.1789347397153;3656.3601369760186;3658.5975542690285;4180.143070670505;4180.393842892763;4184.581541845791;4197.853075142355;4199.70602057853;4831.535916682517;4886.462489126193;4909.386326709161;4921;4949.133901567211;1202.5189924030283;1210.5157936825165;1216.391804097951;1224.2899118511243;1228.5515786737956;753.5102183580607;836.4646626159263;836.5984327522701;850.9659613615386;852.0159216105408;4085.4076158957378;4140.302475984832;4193.5387107418155;4201.222773786859;4232.978835105805;4865.56209941107;4871.14754917888;4873.805047798049;4877.317175595419;4889.608831293488;3969;4164.3961625564125;4197.706160568731;4202.768847713344;4212.304969679968;2557.399011232359;2594.2476681762455;2602.3884387169;2608.960865587018;2614.9409489156924;4566.657500687395;4578.793954272066;4591.311303304531;4593.770311484413;4613.209008549846;4672.883177920579;4995.800167993312;5003.324551185616;5007.674501157413;5028.17035189197;4543.1822271990695;4554;4602.677812553089;4617.330487079287;4644.396228490275;4806.47128815823;4866.29438731389;4910.435299940553;4919.262110683426;4923.187674033888;4614.638681588872;4777.3311736356245;4806.903861922672;4808.302796094476;4849.854504364875;4571.428571428572;4589.58693717567;4590.540945905383;4595.126925884205;4621.376114224537;3499.9650003499637;3514.4903988921974;3514.5941623350864;3528;3541.9114522136124;4818.891654919318;4882.853514394574;4889;4918.827841025547;4952.340965776505;4471.821127154877;4799.208130658402;4814.831480898151;4821.300911367902;4821.445533763662;4795.136875362468;4797.232442809273;4828.444728856086;4831.396075490564;4833.854984350475;4653.441097232465;4735.763211839326;4753.053107073498;4761.785744635096;4778.426588809365;4590.517995610547;4698.671093023592;4845.345878306383;4920.72935988524;4951;4849.781759820746;4855.975720121377;4859.854204373874;4870.099031679009;4889.682170659038 03:08:05 INFO - PROCESS | 4875 | |5;yui.html;780.8399278147979;808.7614153824621;811.9512829230243;814.8655471847145;816.3958670583766;12274.938625306871;12390.566330178446;12399.132060755763;12407.131500794949;12692.428840702167;12121.212121212115;12430.12989090764;12642.936785316084;12646.93676531616;12653.17754345967;671.4561205423598;829.2619568583965;842.338764070205;852.3820230333021;858.9527575983318;849.9787505312355;857.1300130367682;858.0989960541407;859.1108203009886;860.0023972192258;903.891533016039;910.0762725833284;910.9817803643923;911.0934620053057;911.1571796088625;701.1025886864795;888.1739981816908;888.4358432395443;894.3739382432291;914.7987442762582;637.5282291104595;639.0446282807186;641.2977789320686;641.5509143599452;641.7946257197699;13033.283169425678;13039.86960130396;13052.28212448315;13057.86942130576;13070.477180912847;12133.817992730115;12219.694507637292;12549.184303020274;13021;13036.543720969816;9793.461359625218;9901.900980990242;11250.987411133037;11435.714107147305;11581.594644187497;3375.240570871534;3375.443051896434;3389.6779805918645;3481.0775144586705;3519.1729943463265;39226;39786.60213397887;39805.402918956235;46077.30884036742;47071.764641176575;10054.29619926598;10068.748281293027;10071.093601575893;10144.594216231415;10613.9469302653;16610.66778664444;16618.836681432185;16636.08501532403;16647.667046659;17495.737563936553;7078.6106764127435;7108.07595012645;7132.821679458055;7189.422777065515;7425.443091768139;3668.486411902336;3825.1202223488754;3929.941050884239;3938.330483817758;3986.4219688145636;2840.9715902840708;2995.355998460298;2995.550667399864;2998.9100326990224;3002.0693584988285;513.3634293476063;520.4977197004908;521.6452812087741;523.0193387398627;525.9158534634516;477.68711493971506;560.8978357527478;614.6342925959048;623.0778447897047;640.3916279534461;7750.379969602418;7872.803179920434;7897.447178697551;8040.5979701015885;8088.676452941816;530.4271386902136;533.3067012883237;580.6806256558875;604.2869414091414;649.1301655781276;3602.945955810665;3695.796731179811;3727.6086010969;3728.142527218755;3808.6572208500816;50190.49809501931;51056;51539;51601.2259816103;51623.48376516262;46347.30479042817;46459.30311045337;46685.06629867384;46921.53078469171;48274.517254827006;42760.14479710389;42852.1429571413;43207.13585728268;43452;44119.77940110279;7367.6261637670295;7575.962120189364;7675.654595543102;7738.613069346397;7808.921910780819;28532.42935141327;29405.11784646464;29838.85080574583;29906.401871962003;29908;35748.28503429969;38313.616863831005;38406.423903642026;38433.42349864698;38706.6129338703;10191.592336306465;10226.28416010872;10458.163346932075;10529.631462898762;10709.196810239107;10558.155347572329;10568.788624227625;10787.730306742395;11316.37759923212;11414.885851141715;9430.10414010668;9677.4193548388;9725.4650994196;9739.464329461947;10051.69844904654;10171.23715721309;10304.484775761332;10721.30311529748;10753;10940;10473.266871318934;10773.622923197963;10784.784304314027;10839.241253112521;10916.836247456136;8011.639476223468;8015;8042.67829286822;8108.39187060961;8485.787855303666;8062.435629505878;8170.305524030524;8216.712415065444;8430.367722420966;8738.519381434082 03:08:05 INFO - PROCESS | 4875 | __end_tp_report 03:08:05 INFO - PROCESS | 4875 | __start_cc_report 03:08:05 INFO - PROCESS | 4875 | _x_x_mozilla_cycle_collect,1078 03:08:05 INFO - PROCESS | 4875 | __end_cc_report 03:08:05 INFO - PROCESS | 4875 | __startTimestamp1462788485820__endTimestamp 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | ------- Summary: start ------- 03:08:05 INFO - PROCESS | 4875 | Number of tests: 6 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#0] dojo.html Cycles:165 Average:4541.02 Median:4641.54 stddev:466.47 (10.0%) stddev-sans-first:441.23 03:08:05 INFO - PROCESS | 4875 | Values: 2559.1 2582.4 2615.5 2633.2 2634.9 4516.2 4537.0 4556.1 4571.2 4605.5 4496.8 4516.0 4517.5 4568.1 4606.8 4100.5 4191.0 4198.9 4236.7 4389.9 4310.5 4333.0 4345.1 4372.4 4391.0 4159.2 4203.1 4205.6 4214.2 4247.5 4247.9 4258.9 4259.7 4315.4 4328.3 4249.9 4259.4 4270.1 4271.0 4305.4 4395.5 4445.0 4477.1 4549.0 4589.4 4915.3 4978.7 4983.7 4994.6 4998.7 4965.9 4967.8 4983.5 5010.6 5013.5 4472.3 4615.3 4648.2 4658.7 4687.1 5067.5 5129.5 5142.3 5142.3 5149.2 4894.2 4931.6 4939.9 4950.6 4955.5 4757.0 4900.4 4907.2 4919.6 4975.2 4892.8 4913.1 4920.1 4931.6 4980.2 4708.9 4904.8 4905.1 4909.9 4959.5 4085.8 4135.7 4173.5 4183.9 4219.4 3678.6 3685.3 3690.5 3727.3 3748.7 4226.0 4229.2 4236.2 4259.7 4273.8 4754.7 4865.7 4892.1 4895.1 4926.4 4192.6 4198.8 4203.6 4206.4 4232.6 4483.5 4485.0 4489.0 4518.1 4531.7 4465.5 4565.5 4612.1 4630.9 4645.0 4989.5 4994.4 4994.5 5004.3 5024.2 4458.9 4610.4 4620.4 4626.4 4676.3 4750.0 4758.0 4784.8 4787.5 4796.1 4830.7 4833.4 4849.4 4860.7 4916.6 4665.0 4694.6 4715.9 4721.8 4766.3 4645.1 4662.7 4686.9 4710.2 4726.8 4680.9 4683.1 4717.5 4723.1 4724.2 4672.7 4675.5 4765.6 4812.8 4816.2 4563.9 4605.2 4641.5 4673.7 4683.8 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#1] ext.html Cycles:180 Average:41682.86 Median:327536.50 stddev:65035.85 (19.9%) stddev-sans-first:65145.05 03:08:05 INFO - PROCESS | 4875 | Values: 575.9 610.2 610.3 611.3 621.4 27510.0 40947.8 41054.2 42140.0 42329.8 38639.4 38930.2 43357.3 43369.1 43431.8 7507.4 8094.4 8228.0 8235.4 8238.2 10118.7 10379.5 10393.2 10633.1 10697.1 10291.3 10381.3 10391.5 10394.5 10395.1 10219.5 10229.8 10265.9 10319.3 10328.3 10240.3 10324.5 10328.9 10332.2 10337.1 38395.0 38447.6 38455.6 38789.6 38918.0 3298.8 3334.2 3356.6 3395.6 3411.9 29671.9 30460.7 30683.2 30698.7 30934.5 3373.6 3443.7 3448.5 3551.1 3562.2 183976.0 184863.0 184884.0 184894.0 185124.0 55063.4 56032.4 56058.2 56072.7 56238.0 59597.4 59623.0 59791.0 59830.4 60022.4 15243.7 15577.8 15579.1 15653.2 15671.2 10124.7 10127.9 10301.0 10569.0 11640.4 17319.8 17469.2 17552.2 17694.5 17793.8 6233.9 6286.5 6287.3 6441.1 6511.0 864.8 896.5 994.3 1048.5 1089.2 26374.0 28247.4 28358.0 28499.3 28766.4 1045.3 1061.2 1065.2 1087.7 1170.3 14326.0 14949.8 14959.9 15098.6 15201.0 326263.0 328810.0 331485.0 331689.0 331952.0 50580.0 50704.2 50714.2 50738.0 50866.2 1151.5 1272.4 1307.6 1321.1 1330.7 28229.4 29461.3 29684.0 30039.0 30435.4 42205.2 42318.0 42898.8 42902.0 42990.4 205528.0 206346.0 206514.0 207053.0 207413.0 22838.3 23577.6 25334.2 26126.7 26155.9 43366.0 43379.1 43464.6 43760.3 44276.3 36771.0 36848.6 36952.0 36953.6 37158.6 36324.6 36517.6 36745.3 36788.3 37136.0 35942.6 35980.3 36191.3 36526.0 37000.4 32200.2 32601.8 33053.3 33680.2 33706.3 25381.7 25525.6 26564.0 26715.2 28242.3 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#2] jquery.html Cycles:180 Average:23970.82 Median:49376.51 stddev:64819.93 (131.3%) stddev-sans-first:64977.54 03:08:05 INFO - PROCESS | 4875 | Values: 370.2 377.0 385.7 394.6 401.3 16076.2 17368.7 17549.3 17991.7 18048.8 16718.2 17108.7 17401.3 17487.4 17522.1 5092.3 5255.5 5255.7 5277.3 5282.2 3591.9 5344.8 6108.5 6110.8 6111.5 6011.3 6037.1 6048.2 6063.5 6079.8 5828.1 6144.7 6145.0 6154.3 6156.0 5171.5 5372.6 5373.6 5377.7 5380.7 11524.2 12165.8 21032.9 21148.9 21202.6 1845.5 1928.2 1935.2 1964.3 2290.8 9221.3 9275.6 9410.3 9735.5 9843.1 1628.2 1676.0 1680.1 1771.7 1802.9 48155.0 52149.7 54834.7 65183.7 66262.3 8801.3 9405.6 9505.8 9685.2 10462.2 13096.3 13108.0 13125.5 13143.1 13158.8 7068.5 7204.6 7373.8 7489.9 7534.4 6309.4 6406.6 7032.2 7049.2 7049.2 3962.8 4227.5 4399.3 4545.8 4592.6 1836.2 1850.5 1863.2 1868.6 1890.0 865.4 985.7 1002.0 1006.9 1012.5 16910.0 17285.2 17372.5 17615.6 17884.6 885.6 901.9 931.2 939.5 958.8 9341.8 9664.0 9759.4 9952.6 9962.3 322174.0 390414.0 406810.0 419279.0 419884.0 79537.0 79579.6 79888.6 80461.0 80606.6 814.4 900.5 917.1 963.5 966.5 15836.5 15941.5 15960.2 16091.7 16230.7 35227.0 35355.5 35449.0 36729.8 36888.8 49300.0 49337.8 49415.3 49527.8 50211.0 4708.7 7116.4 7828.1 7878.1 8035.0 10233.4 10839.2 10986.9 11006.5 11180.3 9572.9 9593.7 9779.3 9812.3 10163.4 9575.3 10055.5 10097.8 10110.9 10131.2 9808.2 10067.8 10072.1 10072.6 10377.6 7752.1 7806.3 7872.3 7874.3 8084.4 8947.4 9976.9 10109.8 10135.2 10460.4 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#3] mootools.html Cycles:180 Average:4898.82 Median:5275.62 stddev:2697.95 (51.1%) stddev-sans-first:2691.83 03:08:05 INFO - PROCESS | 4875 | Values: 1283.1 1480.0 1504.2 1679.3 1828.7 6464.5 7263.1 7473.6 7486.5 7675.7 7409.7 7537.6 7550.8 7558.5 7559.2 2203.9 2228.4 2233.6 2234.8 2235.5 2062.2 2102.8 2105.0 2108.3 2109.1 2175.4 2185.5 2201.1 2203.5 2222.1 2129.4 2133.1 2136.1 2137.5 2137.7 1900.2 1929.2 1945.1 1951.6 1952.5 7233.4 7271.6 7294.5 7303.8 7490.5 4387.7 4483.1 4485.7 4506.6 4508.8 2762.4 2832.6 2865.7 2866.4 2873.2 909.8 919.4 924.5 932.6 934.1 9715.6 9722.7 9747.2 9773.4 9787.3 3876.2 3925.9 4015.9 4029.9 4040.9 7845.5 7860.6 7865.3 7891.3 7895.3 4369.7 4384.8 4415.9 4416.4 4423.2 3637.5 3995.7 4046.6 4073.8 4178.0 3329.4 3362.6 3399.5 3414.6 3442.9 962.1 1009.0 1017.9 1018.5 1018.8 784.5 823.5 864.4 871.6 916.5 5194.6 5212.1 5239.3 5248.1 5312.5 438.4 445.0 446.6 452.1 453.8 3540.2 3565.8 3572.7 3601.5 3623.5 8707.0 9086.6 9088.6 9210.0 9261.4 8990.3 9022.8 9074.1 9133.6 9148.0 6515.3 6722.1 6757.0 6858.4 6913.8 5055.2 5184.3 5241.0 5303.1 5366.2 8441.2 8525.0 8570.3 8605.3 8717.1 8472.6 8647.8 8720.3 8733.4 8746.8 5784.1 6353.2 6391.4 6434.7 6468.6 7126.2 7390.0 7392.7 7393.5 7408.8 6409.4 6603.9 6636.1 6657.3 6678.7 6325.7 6519.3 6596.6 6640.2 6724.3 6181.5 6253.7 6256.1 6268.2 6297.4 4531.2 4531.3 4694.1 4729.4 4755.9 4227.9 4247.5 4293.3 4369.5 4375.4 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#4] prototype.html Cycles:180 Average:4029.24 Median:4584.19 stddev:1151.85 (25.1%) stddev-sans-first:1120.64 03:08:05 INFO - PROCESS | 4875 | Values: 304.4 306.5 309.4 309.4 316.3 4710.7 4753.4 4778.2 4792.9 4803.1 4649.0 4662.3 4664.7 4688.4 4716.7 3502.4 3631.3 3642.2 3749.7 3774.8 3717.9 3742.5 3746.6 3754.2 3761.8 3497.4 3702.7 3726.3 3733.6 3749.8 3592.5 3725.0 3728.2 3737.5 3745.1 3293.4 3298.7 3298.9 3303.4 3318.7 4465.1 4470.9 4480.9 4490.8 4494.3 3940.9 4212.4 4221.8 4245.5 4262.3 4949.6 4950.0 4951.9 4969.2 4977.8 3534.6 3552.2 3555.7 3564.5 3581.5 5006.9 5136.0 5148.4 5151.2 5152.2 3569.6 3578.9 3599.3 3600.2 3612.1 3625.2 3646.7 3649.2 3656.4 3658.6 4180.1 4180.4 4184.6 4197.9 4199.7 4831.5 4886.5 4909.4 4921.0 4949.1 1202.5 1210.5 1216.4 1224.3 1228.6 753.5 836.5 836.6 851.0 852.0 4085.4 4140.3 4193.5 4201.2 4233.0 4865.6 4871.1 4873.8 4877.3 4889.6 3969.0 4164.4 4197.7 4202.8 4212.3 2557.4 2594.2 2602.4 2609.0 2614.9 4566.7 4578.8 4591.3 4593.8 4613.2 4672.9 4995.8 5003.3 5007.7 5028.2 4543.2 4554.0 4602.7 4617.3 4644.4 4806.5 4866.3 4910.4 4919.3 4923.2 4614.6 4777.3 4806.9 4808.3 4849.9 4571.4 4589.6 4590.5 4595.1 4621.4 3500.0 3514.5 3514.6 3528.0 3541.9 4818.9 4882.9 4889.0 4918.8 4952.3 4471.8 4799.2 4814.8 4821.3 4821.4 4795.1 4797.2 4828.4 4831.4 4833.9 4653.4 4735.8 4753.1 4761.8 4778.4 4590.5 4698.7 4845.3 4920.7 4951.0 4849.8 4856.0 4859.9 4870.1 4889.7 03:08:05 INFO - PROCESS | 4875 | 03:08:05 INFO - PROCESS | 4875 | [#5] yui.html Cycles:180 Average:12549.22 Median:43785.89 stddev:14187.34 (32.4%) stddev-sans-first:14199.62 03:08:05 INFO - PROCESS | 4875 | Values: 780.8 808.8 812.0 814.9 816.4 12274.9 12390.6 12399.1 12407.1 12692.4 12121.2 12430.1 12642.9 12646.9 12653.2 671.5 829.3 842.3 852.4 859.0 850.0 857.1 858.1 859.1 860.0 903.9 910.1 911.0 911.1 911.2 701.1 888.2 888.4 894.4 914.8 637.5 639.0 641.3 641.6 641.8 13033.3 13039.9 13052.3 13057.9 13070.5 12133.8 12219.7 12549.2 13021.0 13036.5 9793.5 9901.9 11251.0 11435.7 11581.6 3375.2 3375.4 3389.7 3481.1 3519.2 39226.0 39786.6 39805.4 46077.3 47071.8 10054.3 10068.7 10071.1 10144.6 10613.9 16610.7 16618.8 16636.1 16647.7 17495.7 7078.6 7108.1 7132.8 7189.4 7425.4 3668.5 3825.1 3929.9 3938.3 3986.4 2841.0 2995.4 2995.6 2998.9 3002.1 513.4 520.5 521.6 523.0 525.9 477.7 560.9 614.6 623.1 640.4 7750.4 7872.8 7897.4 8040.6 8088.7 530.4 533.3 580.7 604.3 649.1 3602.9 3695.8 3727.6 3728.1 3808.7 50190.5 51056.0 51539.0 51601.2 51623.5 46347.3 46459.3 46685.1 46921.5 48274.5 42760.1 42852.1 43207.1 43452.0 44119.8 7367.6 7576.0 7675.7 7738.6 7808.9 28532.4 29405.1 29838.9 29906.4 29908.0 35748.3 38313.6 38406.4 38433.4 38706.6 10191.6 10226.3 10458.2 10529.6 10709.2 10558.2 10568.8 10787.7 11316.4 11414.9 9430.1 9677.4 9725.5 9739.5 10051.7 10171.2 10304.5 10721.3 10753.0 10940.0 10473.3 10773.6 10784.8 10839.2 10916.8 8011.6 8015.0 8042.7 8108.4 8485.8 8062.4 8170.3 8216.7 8430.4 8738.5 03:08:05 INFO - PROCESS | 4875 | -------- Summary: end -------- 03:08:05 INFO - PROCESS | 4875 | 03:08:06 INFO - TEST-INFO | 4875: exit 0 03:08:06 INFO - TEST-OK | dromaeo_css | took 1119465ms 03:08:06 INFO - TEST-START | kraken 03:08:06 INFO - operating with platform_type : linux_ 03:08:06 INFO - Initialising browser for kraken test... 03:08:06 INFO - TEST-INFO | started process 5058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbEeVGc/profile http://localhost:54941/getInfo.html) 03:08:11 INFO - PROCESS | 5058 | __metrics Screen width/height:1600/1200 03:08:11 INFO - PROCESS | 5058 | colorDepth:24 03:08:11 INFO - PROCESS | 5058 | Browser inner width/height: 1024/697 03:08:11 INFO - PROCESS | 5058 | __metrics 03:08:12 ERROR - PROCESS | 5058 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:08:12 INFO - TEST-INFO | 5058: exit 0 03:08:12 INFO - Browser initialized. 03:08:12 INFO - Running cycle 1/1 for kraken test... 03:08:12 INFO - TEST-INFO | started process 5139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbEeVGc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:24 INFO - PROCESS | 5139 | RSS: Main: 153825280 03:08:24 INFO - PROCESS | 5139 | 03:08:27 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54941/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:28 INFO - PROCESS | 5139 | RSS: Main: 209448960 03:08:28 INFO - PROCESS | 5139 | 03:08:31 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54941/tests/kraken/driver.html?testName=audio-dft) 03:08:31 INFO - PROCESS | 5139 | RSS: Main: 199188480 03:08:31 INFO - PROCESS | 5139 | 03:08:35 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54941/tests/kraken/driver.html?testName=audio-fft) 03:08:35 INFO - PROCESS | 5139 | RSS: Main: 266088448 03:08:35 INFO - PROCESS | 5139 | 03:08:37 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54941/tests/kraken/driver.html?testName=audio-oscillator) 03:08:38 INFO - PROCESS | 5139 | RSS: Main: 174936064 03:08:38 INFO - PROCESS | 5139 | 03:08:40 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:41 INFO - PROCESS | 5139 | RSS: Main: 178925568 03:08:41 INFO - PROCESS | 5139 | 03:08:44 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54941/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:45 INFO - PROCESS | 5139 | RSS: Main: 214945792 03:08:45 INFO - PROCESS | 5139 | 03:08:48 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54941/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:49 INFO - PROCESS | 5139 | RSS: Main: 216510464 03:08:49 INFO - PROCESS | 5139 | 03:08:52 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54941/tests/kraken/driver.html?testName=json-parse-financial) 03:08:52 INFO - PROCESS | 5139 | RSS: Main: 216539136 03:08:52 INFO - PROCESS | 5139 | 03:08:54 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:54 INFO - PROCESS | 5139 | RSS: Main: 203956224 03:08:54 INFO - PROCESS | 5139 | 03:08:56 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:57 INFO - PROCESS | 5139 | RSS: Main: 210370560 03:08:57 INFO - PROCESS | 5139 | 03:08:59 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:00 INFO - PROCESS | 5139 | RSS: Main: 217063424 03:09:00 INFO - PROCESS | 5139 | 03:09:03 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:03 INFO - PROCESS | 5139 | RSS: Main: 222961664 03:09:03 INFO - PROCESS | 5139 | 03:09:06 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:07 INFO - PROCESS | 5139 | RSS: Main: 221315072 03:09:07 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | Cycle 1(1): loaded http://localhost:54941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54941/tests/kraken/driver.html?testName=ai-astar) 03:09:09 INFO - PROCESS | 5139 | RSS: Main: 267022336 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | __start_tp_report 03:09:09 INFO - PROCESS | 5139 | _x_x_mozilla_page_load 03:09:09 INFO - PROCESS | 5139 | _x_x_mozilla_page_load_details 03:09:09 INFO - PROCESS | 5139 | |i|pagename|runs| 03:09:09 INFO - PROCESS | 5139 | |0;ai-astar;114;110;114;113;113;114;114;113;113;113 03:09:09 INFO - PROCESS | 5139 | |1;audio-beat-detection;155;129;156;186;139;156;158;132;191;139 03:09:09 INFO - PROCESS | 5139 | |2;audio-dft;162;162;161;159;161;162;162;161;161;163 03:09:09 INFO - PROCESS | 5139 | |3;audio-fft;79;76;86;129;75;75;76;75;136;77 03:09:09 INFO - PROCESS | 5139 | |4;audio-oscillator;94;94;118;93;94;93;120;93;93;125 03:09:09 INFO - PROCESS | 5139 | |5;imaging-gaussian-blur;116;117;116;116;117;116;118;117;117;116 03:09:09 INFO - PROCESS | 5139 | |6;imaging-darkroom;146;147;146;145;145;145;146;145;146;145 03:09:09 INFO - PROCESS | 5139 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;94 03:09:09 INFO - PROCESS | 5139 | |8;json-parse-financial;66;65;67;66;67;67;67;83;66;68 03:09:09 INFO - PROCESS | 5139 | |9;json-stringify-tinderbox;66;65;64;64;65;65;64;65;65;64 03:09:09 INFO - PROCESS | 5139 | |10;stanford-crypto-aes;83;82;83;83;82;84;83;84;84;83 03:09:09 INFO - PROCESS | 5139 | |11;stanford-crypto-ccm;133;137;144;131;152;128;139;139;221;136 03:09:09 INFO - PROCESS | 5139 | |12;stanford-crypto-pbkdf2;172;178;176;177;173;182;177;174;175;173 03:09:09 INFO - PROCESS | 5139 | |13;stanford-crypto-sha256-iterative;68;73;67;67;67;72;67;71;68;67 03:09:09 INFO - PROCESS | 5139 | __end_tp_report 03:09:09 INFO - PROCESS | 5139 | __start_cc_report 03:09:09 INFO - PROCESS | 5139 | _x_x_mozilla_cycle_collect,1832 03:09:09 INFO - PROCESS | 5139 | __end_cc_report 03:09:09 INFO - PROCESS | 5139 | __startTimestamp1462788549466__endTimestamp 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | ------- Summary: start ------- 03:09:09 INFO - PROCESS | 5139 | Number of tests: 14 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.20 (1.1%) stddev-sans-first:1.22 03:09:09 INFO - PROCESS | 5139 | Values: 114.0 110.0 114.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:156.00 stddev:21.02 (13.5%) stddev-sans-first:22.29 03:09:09 INFO - PROCESS | 5139 | Values: 155.0 129.0 156.0 186.0 139.0 156.0 158.0 132.0 191.0 139.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 03:09:09 INFO - PROCESS | 5139 | Values: 162.0 162.0 161.0 159.0 161.0 162.0 162.0 161.0 161.0 163.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#3] audio-fft Cycles:10 Average:88.40 Median:76.00 stddev:23.53 (31.0%) stddev-sans-first:24.71 03:09:09 INFO - PROCESS | 5139 | Values: 79.0 76.0 86.0 129.0 75.0 75.0 76.0 75.0 136.0 77.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:93.00 stddev:13.43 (14.4%) stddev-sans-first:13.96 03:09:09 INFO - PROCESS | 5139 | Values: 94.0 94.0 118.0 93.0 94.0 93.0 120.0 93.0 93.0 125.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:09:09 INFO - PROCESS | 5139 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 118.0 117.0 117.0 116.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:09:09 INFO - PROCESS | 5139 | Values: 146.0 147.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:09:09 INFO - PROCESS | 5139 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:67.00 stddev:5.27 (7.9%) stddev-sans-first:5.53 03:09:09 INFO - PROCESS | 5139 | Values: 66.0 65.0 67.0 66.0 67.0 67.0 67.0 83.0 66.0 68.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 03:09:09 INFO - PROCESS | 5139 | Values: 66.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 03:09:09 INFO - PROCESS | 5139 | Values: 83.0 82.0 83.0 83.0 82.0 84.0 83.0 84.0 84.0 83.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:139.00 stddev:27.21 (19.6%) stddev-sans-first:28.45 03:09:09 INFO - PROCESS | 5139 | Values: 133.0 137.0 144.0 131.0 152.0 128.0 139.0 139.0 221.0 136.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.50 stddev:2.98 (1.7%) stddev-sans-first:2.85 03:09:09 INFO - PROCESS | 5139 | Values: 172.0 178.0 176.0 177.0 173.0 182.0 177.0 174.0 175.0 173.0 03:09:09 INFO - PROCESS | 5139 | 03:09:09 INFO - PROCESS | 5139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:2.36 (3.5%) stddev-sans-first:2.49 03:09:09 INFO - PROCESS | 5139 | Values: 68.0 73.0 67.0 67.0 67.0 72.0 67.0 71.0 68.0 67.0 03:09:09 INFO - PROCESS | 5139 | -------- Summary: end -------- 03:09:09 INFO - PROCESS | 5139 | 03:09:10 INFO - TEST-INFO | 5139: exit 0 03:09:10 INFO - TEST-OK | kraken | took 63957ms 03:09:10 INFO - SUITE-END | took 1183s 03:09:10 INFO - Completed test suite (00:19:43) 03:09:10 INFO - javascript benchmark 03:09:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2559.0787316566034, 2582.3673200065987, 2615.50305441966, 2633.2100369889026, 2634.881430335635, 4516.232240519112, 4536.954630453694, 4556.088782243556, 4571.2228921083415, 4605.516420775821, 4496.752678602676, 4516.0, 4517.4804897436725, 4568.132054909564, 4606.83876064337, 4100.528439229497, 4190.979045104786, 4198.9370159447635, 4236.724612900167, 4389.868303950887, 4310.48274207094, 4333.046729719473, 4345.109252603209, 4372.3878656988045, 4390.97804510977, 4159.188958153161, 4203.096334288112, 4205.558416366299, 4214.157168566268, 4247.532771395144, 4247.851325203603, 4258.893527661802, 4259.659227261843, 4315.395844581761, 4328.264195086843, 4249.851255206053, 4259.3610958356185, 4270.124624452011, 4271.039016221325, 4305.418768466248, 4395.538468460798, 4444.977775111104, 4477.082198149372, 4549.0, 4589.380433641482, 4915.262710593403, 4978.701277923336, 4983.6760610560195, 4994.550490455877, 4998.7250701211415, 4965.900681986376, 4967.826126085606, 4983.476734942851, 5010.599152067826, 5013.498650134994, 4472.262076757331, 4615.30770384445, 4648.209804333272, 4658.673892827537, 4687.062587482483, 5067.467915868854, 5129.487051294916, 5142.254373115952, 5142.280080788692, 5149.2276158576515, 4894.167991441393, 4931.605471562339, 4939.87650308738, 4950.5544500994365, 4955.4796746341835, 4757.024809913959, 4900.387451568554, 4907.214845624683, 4919.557239848431, 4975.179095449211, 4892.779824907817, 4913.06651736169, 4920.089783390084, 4931.556159945622, 4980.228064649985, 4708.858734237979, 4904.828331008398, 4905.141600219948, 4909.926351104737, 4959.479254678279, 4085.816138273785, 4135.669146468275, 4173.478315210598, 4183.937240941388, 4219.43037689914, 3678.6137455567314, 3685.3182161300247, 3690.538682664667, 3727.3290807654885, 3748.681362084199, 4225.9577404226175, 4229.2175947449205, 4236.195122926634, 4259.659227261812, 4273.786310684453, 4754.690945088558, 4865.683730557503, 4892.094962431962, 4895.143349913751, 4926.408830940239, 4192.601702838226, 4198.832046718097, 4203.600657937491, 4206.41110244566, 4232.555581663881, 4483.50681425043, 4484.977575112169, 4488.955110448919, 4518.096380723869, 4531.682782205214, 4465.464144302705, 4565.452145742533, 4612.123696497655, 4630.930536042029, 4644.953550464587, 4989.501049894981, 4994.350734404649, 4994.4755800640405, 5004.274380214775, 5024.246363045572, 4458.933116003198, 4610.354550362885, 4620.399348084862, 4626.37543931565, 4676.275177347517, 4750.026244619914, 4758.04839032188, 4784.832530861403, 4787.54518320759, 4796.136695394863, 4830.686005409637, 4833.3958255218095, 4849.442314133919, 4860.65975381734, 4916.606671466346, 4664.953350466452, 4694.554017368345, 4715.905681886412, 4721.811127554859, 4766.285057241442, 4645.140648979949, 4662.650301227353, 4686.92969605463, 4710.24636058229, 4726.787294571821, 4680.929786053144, 4683.110209060404, 4717.457492388282, 4723.055388922298, 4724.220503616864, 4672.719636821802, 4675.509071547439, 4765.5949244314625, 4812.783424745825, 4816.15717249487, 4563.908721825611, 4605.171069207441, 4641.535846415331, 4673.7429441381055, 4683.8360657376825], "value": 4512.1358191280715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9251297331347, 610.2189197826782, 610.2707264818541, 611.339753066688, 621.4375989729295, 27510.0, 40947.79526102369, 41054.17891642165, 42140.0, 42329.788351058276, 38639.42040869389, 38930.22139557207, 43357.349639755426, 43369.132617347634, 43431.78284108575, 7507.361874240669, 8094.43338966274, 8227.95886020569, 8235.38234632402, 8238.176182381743, 10118.747031324203, 10379.48102594871, 10393.220508461858, 10633.096186824128, 10697.144228461744, 10291.33106348085, 10381.273310868242, 10391.480425978709, 10394.532246048946, 10395.116415104725, 10219.540120694512, 10229.846552301722, 10265.948670256676, 10319.277650564463, 10328.328658637201, 10240.334378265463, 10324.535395907202, 10328.896711032869, 10332.225083118796, 10337.0696637303, 38395.0, 38447.615523844965, 38455.61544384548, 38789.612103878884, 38918.0, 3298.7690861639694, 3334.1664583854035, 3356.56364672591, 3395.643457436958, 3411.9147021324416, 29671.851640741876, 30460.69539304623, 30683.232919176975, 30698.69301307003, 30934.53598196029, 3373.645767194458, 3443.724502039831, 3448.4654878493625, 3551.1122219445137, 3562.1985053363046, 183976.0, 184863.0, 184884.0, 184894.0, 185124.0, 55063.44936550583, 56032.439675603535, 56058.159127613115, 56072.719636401554, 56238.0, 59597.40402596005, 59623.0, 59791.0, 59830.40169598335, 60022.39977600255, 15243.695126097417, 15577.84422155764, 15579.14314712679, 15653.217339132998, 15671.216439177995, 10124.696259112092, 10127.949360253151, 10301.0, 10569.048785609331, 11640.417979101012, 17319.826801732073, 17469.21388537519, 17552.210150543255, 17694.469165925042, 17793.822061779218, 6233.906491402633, 6286.465650419674, 6287.308396076428, 6441.0982462455295, 6510.967445162744, 864.8443280209497, 896.4845214001975, 994.3387647214666, 1048.501961568249, 1089.1722291058852, 26373.96699379596, 28247.43505129886, 28358.0, 28499.28751781222, 28766.424671506873, 1045.320541647935, 1061.1510791366875, 1065.2010991756183, 1087.7389426537575, 1170.3270619393882, 14326.0, 14949.775753363709, 14959.92520037393, 15098.635430865423, 15201.0, 326263.0, 328810.0, 331485.0, 331689.0, 331952.0, 50580.0, 50704.23943640848, 50714.23928641073, 50738.0, 50866.237006444935, 1151.5451396698256, 1272.401971073594, 1307.607717684691, 1321.1082519299243, 1330.6606815262046, 28229.43541129207, 29461.263468412602, 29684.0, 30039.0, 30435.391292174474, 42205.155896881275, 42318.0, 42898.78550607227, 42902.0, 42990.35514467223, 205528.0, 206346.0, 206514.0, 207053.0, 207413.0, 22838.31485055451, 23577.646335305326, 25334.239972800846, 26126.73873261243, 26155.869220653774, 43366.0, 43379.132417352106, 43464.56535434605, 43760.343594845464, 44276.33585496156, 36771.0, 36848.63151368452, 36952.0, 36953.630463695015, 37158.6284137166, 36324.63675363213, 36517.634823651424, 36745.265094698494, 36788.264234715694, 37136.0, 35942.640573594974, 35980.28039439144, 36191.27617447584, 36526.0, 37000.44499332566, 32200.19499512531, 32601.836990814892, 33053.33033864909, 33680.15799604932, 33706.325873482885, 25381.74618253794, 25525.61711574291, 26564.0, 26715.19854404371, 28242.293942650776], "value": 18024.862117579964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1763576043304, 376.9868054618088, 385.695300712437, 394.6290486942272, 401.2817057467134, 16076.196190190487, 17368.652626947453, 17549.298028078876, 17991.73012404815, 18048.81951180488, 16718.16409179542, 17108.74336884948, 17401.3039478421, 17487.387941422054, 17522.12389380532, 5092.337996060507, 5255.474452554752, 5255.710935898524, 5277.261183434322, 5282.154855223165, 3591.856325746967, 5344.786208551673, 6108.450239478446, 6110.755569777203, 6111.541634377417, 6011.338752737217, 6037.094435834616, 6048.183495228154, 6063.514918806485, 6079.817605471843, 5828.125781132821, 6144.692765361714, 6144.969275153618, 6154.26148862135, 6156.045812898986, 5171.482851714836, 5372.623916325859, 5373.570114390839, 5377.731113444352, 5380.677159370412, 11524.19330646855, 12165.756684866254, 21032.894835525723, 21148.894255528623, 21202.575948480942, 1845.5478407790042, 1928.2479832865195, 1935.1775495414533, 1964.2732189089986, 2290.8052815510537, 9221.30840186982, 9275.58259878307, 9410.294227932933, 9735.464549449778, 9843.114119729258, 1628.2496316459853, 1676.0, 1680.1095419427722, 1771.7430972508914, 1802.8828126171888, 48155.0, 52149.73925130388, 54834.72582637061, 65183.67408162929, 66262.33737662659, 8801.295896328278, 9405.623775049058, 9505.809883802285, 9685.17675997534, 10462.233595905467, 13096.279704616338, 13108.0, 13125.54060607874, 13143.07998440119, 13158.802617960739, 7068.505204635626, 7204.56772593646, 7373.8156546086775, 7489.887651685229, 7534.35957943581, 6309.400606942333, 6406.6476343800605, 7032.226455089936, 7049.189343225492, 7049.224585295613, 3962.7574644738875, 4227.534971153171, 4399.340098985178, 4545.818167273272, 4592.586667199968, 1836.173721825184, 1850.5096149520389, 1863.2174486715612, 1868.6169335286233, 1889.998300900525, 865.3985480091402, 985.7437066362797, 1001.9551557906054, 1006.884208316053, 1012.4684540616236, 16910.0, 17285.222165002604, 17372.47882563525, 17615.559611009827, 17884.642307153783, 885.6059053721033, 901.9052999434965, 931.1712575807537, 939.5302348825587, 958.8226178157063, 9341.766455838522, 9663.951680241555, 9759.438489841734, 9952.552135153936, 9962.252831037556, 322174.0, 390414.0, 406810.0, 419279.0, 419884.0, 79537.0, 79579.60210198912, 79888.600556998, 80461.0, 80606.59696701597, 814.4461765999059, 900.527223207808, 917.1195652173988, 963.4893506441738, 966.4974213408988, 15836.52490425289, 15941.521754347388, 15960.20198990069, 16091.67816643684, 16230.67538649244, 35227.0, 35355.46966795449, 35449.0, 36729.816350918074, 36888.81555592205, 49300.0, 49337.75331123322, 49415.25877111918, 49527.75236123797, 50211.0, 4708.670393072452, 7116.43068554504, 7828.138904720362, 7878.133405325295, 8035.035795704319, 10233.437160956219, 10839.187060970617, 10986.945065274942, 11006.504707288032, 11180.273282236629, 9572.856407154037, 9593.664221752206, 9779.315447918578, 9812.313138080552, 10163.390196588229, 9575.281853860848, 10055.49722513886, 10097.848532271875, 10110.898891010997, 10131.189504839742, 9808.215342772419, 10067.798644027225, 10072.0935115837, 10072.597096116073, 10377.636782712569, 7752.0697516298405, 7806.336461400618, 7872.2914937653595, 7874.251946065115, 8084.353251739729, 8947.373683842068, 9976.850347244943, 10109.797804044025, 10135.189184865341, 10460.424676642857], "value": 8199.681673862782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.0761851466953, 1480.0379753160444, 1504.1727050122433, 1679.252732534023, 1828.6525560143564, 6464.547481676284, 7263.055802745643, 7473.588952607612, 7486.513376630529, 7675.6545955432, 7409.666565004588, 7537.585432801194, 7550.848983020336, 7558.546487210771, 7559.206283340252, 2203.933881983543, 2228.3760547046854, 2233.597952368573, 2234.754177040524, 2235.4970131720397, 2062.185436752482, 2102.8002339777695, 2104.968425473619, 2108.293721603257, 2109.072008316336, 2175.434387059368, 2185.49733561281, 2201.1415547936317, 2203.537257175995, 2222.066731972567, 2129.3824790810645, 2133.114757375687, 2136.113512892148, 2137.508373074194, 2137.6579747240444, 1900.2399040383818, 1929.1608150454597, 1945.114972687438, 1951.6487032334173, 1952.492351988479, 7233.385162261214, 7271.600061996588, 7294.489385743, 7303.780886573411, 7490.5131166474, 4387.670924680661, 4483.14820184164, 4485.6860019798305, 4506.571875671806, 4508.842190523316, 2762.392273699783, 2832.61759662445, 2865.684774674784, 2866.3550701092295, 2873.195505258531, 909.7816524034184, 919.4115765909823, 924.4591913730409, 932.5989824375516, 934.0799312677008, 9715.562799674031, 9722.708318750449, 9747.220222382193, 9773.364731292444, 9787.314887957846, 3876.2247550490015, 3925.9214815703526, 4015.8996025099605, 4029.9194016119513, 4040.91918161641, 7845.490043147177, 7860.646270917822, 7865.292123708894, 7891.289783919475, 7895.289423951757, 4369.694121411534, 4384.802683879233, 4415.933760993587, 4416.381706561084, 4423.159599676052, 3637.454381842692, 3995.700322475826, 4046.5953404659886, 4073.837046518106, 4178.0, 3329.433996220648, 3362.613299470592, 3399.5240666306736, 3414.6243913169533, 3442.9483557746653, 962.0667952086465, 1008.9949550252348, 1017.8829434614966, 1018.5314755212537, 1018.8217062014267, 784.4783219159195, 823.4935514658442, 864.4208380385157, 871.5642178910545, 916.4638686368415, 5194.584433245407, 5212.139996900545, 5239.266502689627, 5248.107821670249, 5312.5484333832055, 438.3928259360745, 444.9621782148554, 446.6181414890222, 452.10934459116146, 453.82754553269547, 3540.2211513466996, 3565.7682250653625, 3572.6605972432576, 3601.5318008658705, 3623.4927110204594, 8706.956465217634, 9086.636534538677, 9088.636454541876, 9210.03294654065, 9261.44431334122, 8990.28077753778, 9022.819543609092, 9074.092590741006, 9133.634654613874, 9148.0, 6515.348465153542, 6722.058911752359, 6757.0, 6858.417034552119, 6913.792586222421, 5055.16589762685, 5184.300119483822, 5240.973795131, 5303.124984377689, 5366.195070739421, 8441.198086181803, 8525.019622743464, 8570.314374849871, 8605.311575073854, 8717.084706106021, 8472.576371181292, 8647.827043459221, 8720.302375810046, 8733.432326898732, 8746.825063498822, 5784.132380143013, 6353.237611486466, 6391.424771770563, 6434.742610295536, 6468.579542329733, 7126.216116227314, 7390.0, 7392.7042918284815, 7393.519421237603, 7408.777736667908, 6409.423151916163, 6603.900941485786, 6636.070950067091, 6657.3009833966735, 6678.7328506859185, 6325.652089135142, 6519.315471875385, 6596.571222870498, 6640.236372817188, 6724.29394913527, 6181.505479561534, 6253.687315634291, 6256.124142619946, 6268.216472940882, 6297.433231009231, 4531.207038768136, 4531.25234336344, 4694.108119457293, 4729.36153619257, 4755.904881902274, 4227.894302642459, 4247.51153617338, 4293.270144075577, 4369.519352871245, 4375.365571992107], "value": 3915.6471652004593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3502122967465, 306.52641668621976, 309.35653840012776, 309.40748466686296, 316.33569504041515, 4710.693804902688, 4753.405824271966, 4778.187708089625, 4792.9281060784115, 4803.1354356215825, 4648.953510464894, 4662.347271382009, 4664.743439110847, 4688.413948256468, 4716.693414928036, 3502.3870822606004, 3631.2918980798754, 3642.235130622559, 3749.7000239980734, 3774.8112594370173, 3717.8512859485586, 3742.5321834770652, 3746.6253374662588, 3754.155315054118, 3761.8495260189698, 3497.422925217336, 3702.7225607165483, 3726.3292607330804, 3733.626637336272, 3749.8375503593975, 3592.4790905318714, 3725.0, 3728.2357116791263, 3737.5328083989502, 3745.1198968242443, 3293.357795229931, 3298.65364136767, 3298.884539041146, 3303.4219011672863, 3318.668133186686, 4465.129299786543, 4470.910581788378, 4480.8879778005485, 4490.7979140938405, 4494.337095274769, 3940.940885886714, 4212.389203565496, 4221.767802770846, 4245.469316335458, 4262.2754131797665, 4949.628777841676, 4949.975250123763, 4951.876203094916, 4969.229769385751, 4977.800887964477, 3534.5581802274714, 3552.182997910495, 3555.6799888010205, 3564.48314994327, 3581.4627805829073, 5006.874828129289, 5136.0, 5148.433672296044, 5151.175811870083, 5152.201408781645, 3569.625189355132, 3578.874739384109, 3599.280143971164, 3600.243948770735, 3612.096975756061, 3625.2386998730035, 3646.690031347312, 3649.1789347397153, 3656.3601369760186, 3658.5975542690285, 4180.143070670505, 4180.393842892763, 4184.581541845791, 4197.853075142355, 4199.70602057853, 4831.535916682517, 4886.462489126193, 4909.386326709161, 4921.0, 4949.133901567211, 1202.5189924030283, 1210.5157936825165, 1216.391804097951, 1224.2899118511243, 1228.5515786737956, 753.5102183580607, 836.4646626159263, 836.5984327522701, 850.9659613615386, 852.0159216105408, 4085.4076158957378, 4140.302475984832, 4193.5387107418155, 4201.222773786859, 4232.978835105805, 4865.56209941107, 4871.14754917888, 4873.805047798049, 4877.317175595419, 4889.608831293488, 3969.0, 4164.3961625564125, 4197.706160568731, 4202.768847713344, 4212.304969679968, 2557.399011232359, 2594.2476681762455, 2602.3884387169, 2608.960865587018, 2614.9409489156924, 4566.657500687395, 4578.793954272066, 4591.311303304531, 4593.770311484413, 4613.209008549846, 4672.883177920579, 4995.800167993312, 5003.324551185616, 5007.674501157413, 5028.17035189197, 4543.1822271990695, 4554.0, 4602.677812553089, 4617.330487079287, 4644.396228490275, 4806.47128815823, 4866.29438731389, 4910.435299940553, 4919.262110683426, 4923.187674033888, 4614.638681588872, 4777.3311736356245, 4806.903861922672, 4808.302796094476, 4849.854504364875, 4571.428571428572, 4589.58693717567, 4590.540945905383, 4595.126925884205, 4621.376114224537, 3499.9650003499637, 3514.4903988921974, 3514.5941623350864, 3528.0, 3541.9114522136124, 4818.891654919318, 4882.853514394574, 4889.0, 4918.827841025547, 4952.340965776505, 4471.821127154877, 4799.208130658402, 4814.831480898151, 4821.300911367902, 4821.445533763662, 4795.136875362468, 4797.232442809273, 4828.444728856086, 4831.396075490564, 4833.854984350475, 4653.441097232465, 4735.763211839326, 4753.053107073498, 4761.785744635096, 4778.426588809365, 4590.517995610547, 4698.671093023592, 4845.345878306383, 4920.72935988524, 4951.0, 4849.781759820746, 4855.975720121377, 4859.854204373874, 4870.099031679009, 4889.682170659038], "value": 3667.3701672169855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.8399278147979, 808.7614153824621, 811.9512829230243, 814.8655471847145, 816.3958670583766, 12274.938625306871, 12390.566330178446, 12399.132060755763, 12407.131500794949, 12692.428840702167, 12121.212121212115, 12430.12989090764, 12642.936785316084, 12646.93676531616, 12653.17754345967, 671.4561205423598, 829.2619568583965, 842.338764070205, 852.3820230333021, 858.9527575983318, 849.9787505312355, 857.1300130367682, 858.0989960541407, 859.1108203009886, 860.0023972192258, 903.891533016039, 910.0762725833284, 910.9817803643923, 911.0934620053057, 911.1571796088625, 701.1025886864795, 888.1739981816908, 888.4358432395443, 894.3739382432291, 914.7987442762582, 637.5282291104595, 639.0446282807186, 641.2977789320686, 641.5509143599452, 641.7946257197699, 13033.283169425678, 13039.86960130396, 13052.28212448315, 13057.86942130576, 13070.477180912847, 12133.817992730115, 12219.694507637292, 12549.184303020274, 13021.0, 13036.543720969816, 9793.461359625218, 9901.900980990242, 11250.987411133037, 11435.714107147305, 11581.594644187497, 3375.240570871534, 3375.443051896434, 3389.6779805918645, 3481.0775144586705, 3519.1729943463265, 39226.0, 39786.60213397887, 39805.402918956235, 46077.30884036742, 47071.764641176575, 10054.29619926598, 10068.748281293027, 10071.093601575893, 10144.594216231415, 10613.9469302653, 16610.66778664444, 16618.836681432185, 16636.08501532403, 16647.667046659, 17495.737563936553, 7078.6106764127435, 7108.07595012645, 7132.821679458055, 7189.422777065515, 7425.443091768139, 3668.486411902336, 3825.1202223488754, 3929.941050884239, 3938.330483817758, 3986.4219688145636, 2840.9715902840708, 2995.355998460298, 2995.550667399864, 2998.9100326990224, 3002.0693584988285, 513.3634293476063, 520.4977197004908, 521.6452812087741, 523.0193387398627, 525.9158534634516, 477.68711493971506, 560.8978357527478, 614.6342925959048, 623.0778447897047, 640.3916279534461, 7750.379969602418, 7872.803179920434, 7897.447178697551, 8040.5979701015885, 8088.676452941816, 530.4271386902136, 533.3067012883237, 580.6806256558875, 604.2869414091414, 649.1301655781276, 3602.945955810665, 3695.796731179811, 3727.6086010969, 3728.142527218755, 3808.6572208500816, 50190.49809501931, 51056.0, 51539.0, 51601.2259816103, 51623.48376516262, 46347.30479042817, 46459.30311045337, 46685.06629867384, 46921.53078469171, 48274.517254827006, 42760.14479710389, 42852.1429571413, 43207.13585728268, 43452.0, 44119.77940110279, 7367.6261637670295, 7575.962120189364, 7675.654595543102, 7738.613069346397, 7808.921910780819, 28532.42935141327, 29405.11784646464, 29838.85080574583, 29906.401871962003, 29908.0, 35748.28503429969, 38313.616863831005, 38406.423903642026, 38433.42349864698, 38706.6129338703, 10191.592336306465, 10226.28416010872, 10458.163346932075, 10529.631462898762, 10709.196810239107, 10558.155347572329, 10568.788624227625, 10787.730306742395, 11316.37759923212, 11414.885851141715, 9430.10414010668, 9677.4193548388, 9725.4650994196, 9739.464329461947, 10051.69844904654, 10171.23715721309, 10304.484775761332, 10721.30311529748, 10753.0, 10940.0, 10473.266871318934, 10773.622923197963, 10784.784304314027, 10839.241253112521, 10916.836247456136, 8011.639476223468, 8015.0, 8042.67829286822, 8108.39187060961, 8485.787855303666, 8062.435629505878, 8170.305524030524, 8216.712415065444, 8430.367722420966, 8738.519381434082], "value": 5918.0077199037605, "unit": "score"}], "name": "dromaeo_css", "value": 6197.8360758441695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 156.0, 186.0, 139.0, 156.0, 158.0, 132.0, 191.0, 139.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 86.0, 129.0, 75.0, 75.0, 76.0, 75.0, 136.0, 77.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 118.0, 93.0, 94.0, 93.0, 120.0, 93.0, 93.0, 125.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 67.0, 67.0, 67.0, 83.0, 66.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 82.0, 84.0, 83.0, 84.0, 84.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 144.0, 131.0, 152.0, 128.0, 139.0, 139.0, 221.0, 136.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 176.0, 177.0, 173.0, 182.0, 177.0, 174.0, 175.0, 173.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 67.0, 67.0, 67.0, 72.0, 67.0, 71.0, 68.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1582.0000000000002, "alertThreshold": 2.0}]} 03:09:10 INFO - Return code: 0 03:09:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:09:10 ERROR - # TBPL SUCCESS # 03:09:10 INFO - Running post-action listener: _resource_record_post_action 03:09:10 INFO - ##### 03:09:10 INFO - ##### Finished run-tests step (success) 03:09:10 INFO - ##### 03:09:10 INFO - Running post-run listener: _resource_record_post_run 03:09:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526016512; Read time: 32; Write time: 881788 03:09:11 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 246972416; Read time: 0; Write time: 575152 03:09:11 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279044096; Read time: 32; Write time: 306636 03:09:11 INFO - Running post-run listener: _upload_blobber_files 03:09:11 INFO - Blob upload gear active. 03:09:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:13 INFO - (blobuploader) - INFO - Done attempting. 03:09:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:13 INFO - (blobuploader) - INFO - Done attempting. 03:09:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:13 INFO - Return code: 0 03:09:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8533dba4913275e79dfe9c26f1cc64d9ae11be630046dd627fddfba48e960570caf4844213cc0d6631a85183e8e81827536c6e07b01286635099fe281e626b0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3443411ede4808cfbb59cfc5c45e64541fdda58a5f96f206ad74888644a7dc21db26ad6d29848817056c43203ae2c0a6d56d53fd1179021018b37cf72c925ac4"} 03:09:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:13 INFO - Contents: 03:09:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8533dba4913275e79dfe9c26f1cc64d9ae11be630046dd627fddfba48e960570caf4844213cc0d6631a85183e8e81827536c6e07b01286635099fe281e626b0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3443411ede4808cfbb59cfc5c45e64541fdda58a5f96f206ad74888644a7dc21db26ad6d29848817056c43203ae2c0a6d56d53fd1179021018b37cf72c925ac4"} 03:09:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:13 INFO - Copying logs to upload dir... 03:09:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.695755 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 03:09:13.471391) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:09:13.475145) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8533dba4913275e79dfe9c26f1cc64d9ae11be630046dd627fddfba48e960570caf4844213cc0d6631a85183e8e81827536c6e07b01286635099fe281e626b0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3443411ede4808cfbb59cfc5c45e64541fdda58a5f96f206ad74888644a7dc21db26ad6d29848817056c43203ae2c0a6d56d53fd1179021018b37cf72c925ac4"} build_url:https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/WqMDO3fiScaK6F01xh-IYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8533dba4913275e79dfe9c26f1cc64d9ae11be630046dd627fddfba48e960570caf4844213cc0d6631a85183e8e81827536c6e07b01286635099fe281e626b0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3443411ede4808cfbb59cfc5c45e64541fdda58a5f96f206ad74888644a7dc21db26ad6d29848817056c43203ae2c0a6d56d53fd1179021018b37cf72c925ac4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:09:13.503661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:09:13.504392) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462785814.598443-641424385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:09:13.586125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:09:13.586532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:09:13.587190) ========= ========= Total master_lag: 0.18 =========