builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1462655132.83 results: success (0) buildid: 20160507113042 builduid: dd6d9e3f56e645d9bac4e8ba9e189c43 revision: 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:32.833113) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:32.833617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:32.833902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.243370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.243672) ========= 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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-07 14:05:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-07 14:05:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093234 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.366775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.367069) ========= 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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017096 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.454923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:33.455249) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 --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 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 --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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-07 14:05:33,605 truncating revision to first 12 chars 2016-05-07 14:05:33,606 Setting DEBUG logging. 2016-05-07 14:05:33,606 attempt 1/10 2016-05-07 14:05:33,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/52749e84bf25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 14:05:33,852 unpacking tar archive at: fx-team-52749e84bf25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520347 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:34.010917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:34.011250) ========= script_repo_revision: 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:34.011694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:34.011983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 14:05:34.022013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-07 14:05:34.022498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:05:34 INFO - MultiFileLogger online at 20160507 14:05:34 in /builds/slave/test 14:05:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:34 INFO - {'append_to_log': False, 14:05:34 INFO - 'base_work_dir': '/builds/slave/test', 14:05:34 INFO - 'blob_upload_branch': 'Fx-Team', 14:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:34 INFO - 'branch': 'Fx-Team', 14:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:34 INFO - 'config_files': ('talos/linux_config.py',), 14:05:34 INFO - 'default_actions': ('clobber', 14:05:34 INFO - 'read-buildbot-config', 14:05:34 INFO - 'download-and-extract', 14:05:34 INFO - 'populate-webroot', 14:05:34 INFO - 'create-virtualenv', 14:05:34 INFO - 'install', 14:05:34 INFO - 'run-tests'), 14:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:34 INFO - 'download_minidump_stackwalk': True, 14:05:34 INFO - 'download_symbols': 'ondemand', 14:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:34 INFO - 'installer_path': 'installer.exe', 14:05:34 INFO - 'log_level': 'info', 14:05:34 INFO - 'log_name': 'talos', 14:05:34 INFO - 'log_to_console': True, 14:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:05:34 INFO - 'opt_config_files': (), 14:05:34 INFO - 'pip_index': False, 14:05:34 INFO - 'sps_profile': False, 14:05:34 INFO - 'sps_profile_interval': 0, 14:05:34 INFO - 'suite': 'dromaeojs', 14:05:34 INFO - 'system_bits': '32', 14:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:34 INFO - 'title': 'talos-linux64-ix-008', 14:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:34 INFO - 'use_talos_json': True, 14:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:34 INFO - 'work_dir': 'build'} 14:05:34 INFO - ##### 14:05:34 INFO - ##### Running clobber step. 14:05:34 INFO - ##### 14:05:34 INFO - Running pre-action listener: _resource_record_pre_action 14:05:34 INFO - Running main action method: clobber 14:05:34 INFO - rmtree: /builds/slave/test/build 14:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:35 INFO - Running post-action listener: _resource_record_post_action 14:05:35 INFO - ##### 14:05:35 INFO - ##### Finished clobber step (success) 14:05:35 INFO - ##### 14:05:35 INFO - ##### 14:05:35 INFO - ##### Running read-buildbot-config step. 14:05:35 INFO - ##### 14:05:35 INFO - Running pre-action listener: _resource_record_pre_action 14:05:35 INFO - Running main action method: read_buildbot_config 14:05:35 INFO - Using buildbot properties: 14:05:35 INFO - { 14:05:35 INFO - "project": "", 14:05:35 INFO - "product": "firefox", 14:05:35 INFO - "script_repo_revision": "production", 14:05:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:05:35 INFO - "repository": "", 14:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:05:35 INFO - "buildid": "20160507113042", 14:05:35 INFO - "pgo_build": "True", 14:05:35 INFO - "basedir": "/builds/slave/test", 14:05:35 INFO - "buildnumber": 652, 14:05:35 INFO - "slavename": "talos-linux64-ix-008", 14:05:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:05:35 INFO - "platform": "ubuntu64_hw", 14:05:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:05:35 INFO - "branch": "fx-team", 14:05:35 INFO - "repo_path": "integration/fx-team", 14:05:35 INFO - "revision": "52749e84bf25fb6aed91ab1339b74cc0e7aae5e7", 14:05:35 INFO - "stage_platform": "linux64-pgo", 14:05:35 INFO - "builduid": "dd6d9e3f56e645d9bac4e8ba9e189c43", 14:05:35 INFO - "slavebuilddir": "test" 14:05:35 INFO - } 14:05:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:05:35 INFO - Running post-action listener: _resource_record_post_action 14:05:35 INFO - ##### 14:05:35 INFO - ##### Finished read-buildbot-config step (success) 14:05:35 INFO - ##### 14:05:35 INFO - ##### 14:05:35 INFO - ##### Running download-and-extract step. 14:05:35 INFO - ##### 14:05:35 INFO - Running pre-action listener: _resource_record_pre_action 14:05:35 INFO - Running main action method: download_and_extract 14:05:35 INFO - mkdir: /builds/slave/test/build/tests 14:05:35 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')]} 14:05:35 INFO - https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:35 INFO - Downloaded 1361 bytes. 14:05:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:05:35 INFO - Using the following test package requirements: 14:05:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:05:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:05:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'jsshell-linux-x86_64.zip'], 14:05:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:05:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:05:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:05:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:05:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:05:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:05:35 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')]} 14:05:35 INFO - https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:36 INFO - Downloaded 23894091 bytes. 14:05:36 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'] 14:05:36 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 14:05:38 INFO - Return code: 0 14:05: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 14:05: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')]} 14:05:38 INFO - https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:39 INFO - Downloaded 23894091 bytes. 14:05:39 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'] 14:05:39 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 14:05:40 INFO - Return code: 0 14:05:40 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')]} 14:05:40 INFO - https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:42 INFO - Downloaded 10840152 bytes. 14:05: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'] 14:05: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 14:05:42 INFO - Return code: 0 14:05: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')]} 14:05:42 INFO - https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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 14:05:44 INFO - Downloaded 58431319 bytes. 14:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:05:44 INFO - mkdir: /builds/slave/test/properties 14:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:44 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:44 INFO - Contents: 14:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:05:45 INFO - Running post-action listener: _resource_record_post_action 14:05:45 INFO - Running post-action listener: set_extra_try_arguments 14:05:45 INFO - ##### 14:05:45 INFO - ##### Finished download-and-extract step (success) 14:05:45 INFO - ##### 14:05:45 INFO - ##### 14:05:45 INFO - ##### Running populate-webroot step. 14:05:45 INFO - ##### 14:05:45 INFO - Running pre-action listener: _resource_record_pre_action 14:05:45 INFO - Running main action method: populate_webroot 14:05:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:45 INFO - '--tppagecycles', 14:05:45 INFO - '7'], 14:05:45 INFO - 'tests': ['tsvgm']}}, 14:05:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['damp', 'tps']}, 14:05:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['damp', 'tps']}, 14:05:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['dromaeo_dom']}, 14:05:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tsvgx', 14:05:45 INFO - 'tsvgr_opacity', 14:05:45 INFO - 'tart', 14:05:45 INFO - 'tscrollx', 14:05:45 INFO - 'cart']}, 14:05:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:45 INFO - 'tsvgr_opacity', 14:05:45 INFO - 'tart', 14:05:45 INFO - 'tscrollx', 14:05:45 INFO - 'cart']}, 14:05:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tp5o']}, 14:05:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['tp5o']}, 14:05:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s', 14:05:45 INFO - '--xperf_path', 14:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:45 INFO - 'tests': ['tp5n']}, 14:05:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--xperf_path', 14:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:45 INFO - 'tests': ['tp5n']}}, 14:05:45 INFO - 'talos.zip': {'path': '', 14:05:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:45 INFO - Running post-action listener: _resource_record_post_action 14:05:45 INFO - ##### 14:05:45 INFO - ##### Finished populate-webroot step (success) 14:05:45 INFO - ##### 14:05:45 INFO - ##### 14:05:45 INFO - ##### Running create-virtualenv step. 14:05:45 INFO - ##### 14:05:45 INFO - Running pre-action listener: _resource_record_pre_action 14:05:45 INFO - Running main action method: create_virtualenv 14:05:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05: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 14:05:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:45 INFO - Using real prefix '/usr' 14:05:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:48 INFO - Installing pip.................done. 14:05:48 INFO - Return code: 0 14:05:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:05: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 14:05: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 14:05:48 INFO - Using env: {'DISPLAY': ':0', 14:05:48 INFO - 'HOME': '/home/cltbld', 14:05:48 INFO - 'LANG': 'en_US.UTF-8', 14:05:48 INFO - 'LANGUAGE': 'en_US:en', 14:05:48 INFO - 'LOGNAME': 'cltbld', 14:05:48 INFO - 'MAIL': '/var/mail/cltbld', 14:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:48 INFO - 'MOZ_NO_REMOTE': '1', 14:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:48 INFO - 'NO_EM_RESTART': '1', 14:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:48 INFO - 'PWD': '/builds/slave/test', 14:05:48 INFO - 'SHELL': '/bin/bash', 14:05:48 INFO - 'SHLVL': '1', 14:05:48 INFO - 'TERM': 'linux', 14:05:48 INFO - 'TMOUT': '86400', 14:05:48 INFO - 'USER': 'cltbld', 14:05:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:48 INFO - '_': '/tools/buildbot/bin/python'} 14:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05: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 14:05:48 INFO - Cleaning up... 14:05:48 INFO - Return code: 0 14:05:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:05: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 14:05: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 14:05:48 INFO - Using env: {'DISPLAY': ':0', 14:05:48 INFO - 'HOME': '/home/cltbld', 14:05:48 INFO - 'LANG': 'en_US.UTF-8', 14:05:48 INFO - 'LANGUAGE': 'en_US:en', 14:05:48 INFO - 'LOGNAME': 'cltbld', 14:05:48 INFO - 'MAIL': '/var/mail/cltbld', 14:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:48 INFO - 'MOZ_NO_REMOTE': '1', 14:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:48 INFO - 'NO_EM_RESTART': '1', 14:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:48 INFO - 'PWD': '/builds/slave/test', 14:05:48 INFO - 'SHELL': '/bin/bash', 14:05:48 INFO - 'SHLVL': '1', 14:05:48 INFO - 'TERM': 'linux', 14:05:48 INFO - 'TMOUT': '86400', 14:05:48 INFO - 'USER': 'cltbld', 14:05:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:48 INFO - '_': '/tools/buildbot/bin/python'} 14:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:48 INFO - Downloading/unpacking psutil>=0.7.1 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:50 INFO - Installing collected packages: psutil 14:05:50 INFO - Running setup.py install for psutil 14:05:50 INFO - building 'psutil._psutil_linux' extension 14:05: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 14:05: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 14:05:50 INFO - building 'psutil._psutil_posix' extension 14:05: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 14:05: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:51 INFO - Successfully installed psutil 14:05:51 INFO - Cleaning up... 14:05:51 INFO - Return code: 0 14:05:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:05: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 14:05: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 14:05:51 INFO - Using env: {'DISPLAY': ':0', 14:05:51 INFO - 'HOME': '/home/cltbld', 14:05:51 INFO - 'LANG': 'en_US.UTF-8', 14:05:51 INFO - 'LANGUAGE': 'en_US:en', 14:05:51 INFO - 'LOGNAME': 'cltbld', 14:05:51 INFO - 'MAIL': '/var/mail/cltbld', 14:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:51 INFO - 'MOZ_NO_REMOTE': '1', 14:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:51 INFO - 'NO_EM_RESTART': '1', 14:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:51 INFO - 'PWD': '/builds/slave/test', 14:05:51 INFO - 'SHELL': '/bin/bash', 14:05:51 INFO - 'SHLVL': '1', 14:05:51 INFO - 'TERM': 'linux', 14:05:51 INFO - 'TMOUT': '86400', 14:05:51 INFO - 'USER': 'cltbld', 14:05:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:51 INFO - '_': '/tools/buildbot/bin/python'} 14:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05: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) 14:05:53 INFO - Installing collected packages: mozsystemmonitor 14:05:53 INFO - Running setup.py install for mozsystemmonitor 14:05:53 INFO - Successfully installed mozsystemmonitor 14:05:53 INFO - Cleaning up... 14:05:53 INFO - Return code: 0 14:05:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:05: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 14:05: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 14:05:53 INFO - Using env: {'DISPLAY': ':0', 14:05:53 INFO - 'HOME': '/home/cltbld', 14:05:53 INFO - 'LANG': 'en_US.UTF-8', 14:05:53 INFO - 'LANGUAGE': 'en_US:en', 14:05:53 INFO - 'LOGNAME': 'cltbld', 14:05:53 INFO - 'MAIL': '/var/mail/cltbld', 14:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:53 INFO - 'MOZ_NO_REMOTE': '1', 14:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:53 INFO - 'NO_EM_RESTART': '1', 14:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:53 INFO - 'PWD': '/builds/slave/test', 14:05:53 INFO - 'SHELL': '/bin/bash', 14:05:53 INFO - 'SHLVL': '1', 14:05:53 INFO - 'TERM': 'linux', 14:05:53 INFO - 'TMOUT': '86400', 14:05:53 INFO - 'USER': 'cltbld', 14:05:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:53 INFO - '_': '/tools/buildbot/bin/python'} 14:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:56 INFO - Downloading docopt-0.6.1.tar.gz 14:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:56 INFO - Running setup.py install for blobuploader 14:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:56 INFO - Running setup.py install for requests 14:05:56 INFO - Running setup.py install for docopt 14:05:56 INFO - Successfully installed blobuploader requests docopt 14:05:56 INFO - Cleaning up... 14:05:56 INFO - Return code: 0 14:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:05: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 14:05: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 14:05:56 INFO - Using env: {'DISPLAY': ':0', 14:05:56 INFO - 'HOME': '/home/cltbld', 14:05:56 INFO - 'LANG': 'en_US.UTF-8', 14:05:56 INFO - 'LANGUAGE': 'en_US:en', 14:05:56 INFO - 'LOGNAME': 'cltbld', 14:05:56 INFO - 'MAIL': '/var/mail/cltbld', 14:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:56 INFO - 'MOZ_NO_REMOTE': '1', 14:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:56 INFO - 'NO_EM_RESTART': '1', 14:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:56 INFO - 'PWD': '/builds/slave/test', 14:05:56 INFO - 'SHELL': '/bin/bash', 14:05:56 INFO - 'SHLVL': '1', 14:05:56 INFO - 'TERM': 'linux', 14:05:56 INFO - 'TMOUT': '86400', 14:05:56 INFO - 'USER': 'cltbld', 14:05:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:56 INFO - '_': '/tools/buildbot/bin/python'} 14:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:57 INFO - Running setup.py (path:/tmp/pip-M28LMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:57 INFO - Running setup.py (path:/tmp/pip-YfbPuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:57 INFO - Running setup.py (path:/tmp/pip-ObMjp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:57 INFO - Running setup.py (path:/tmp/pip-jnqm3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:57 INFO - Running setup.py (path:/tmp/pip-0yTdtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:57 INFO - Running setup.py (path:/tmp/pip-bRIE2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:57 INFO - Running setup.py (path:/tmp/pip-t5mI2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:57 INFO - Running setup.py (path:/tmp/pip-U1Wplj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:57 INFO - Running setup.py (path:/tmp/pip-P1CTRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:57 INFO - Running setup.py (path:/tmp/pip-QASSRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:57 INFO - Running setup.py (path:/tmp/pip-ruIibY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:57 INFO - Running setup.py (path:/tmp/pip-rUXeUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:57 INFO - Running setup.py (path:/tmp/pip-xKteO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:58 INFO - Running setup.py (path:/tmp/pip-Le2FWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:58 INFO - Running setup.py (path:/tmp/pip-Kmd1An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:58 INFO - Running setup.py (path:/tmp/pip-Lz5ytJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:58 INFO - Running setup.py (path:/tmp/pip-we50zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:58 INFO - Running setup.py install for manifestparser 14:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:58 INFO - Running setup.py install for mozcrash 14:05:58 INFO - Running setup.py install for mozdebug 14:05:58 INFO - Running setup.py install for mozdevice 14:05:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:58 INFO - Running setup.py install for mozfile 14:05:58 INFO - Running setup.py install for mozhttpd 14:05:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:58 INFO - Running setup.py install for mozinfo 14:05:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:58 INFO - Running setup.py install for mozInstall 14:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozleak 14:05:59 INFO - Running setup.py install for mozlog 14:05:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for moznetwork 14:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozprocess 14:05:59 INFO - Running setup.py install for mozprofile 14:05:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozrunner 14:05:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:05:59 INFO - Running setup.py install for mozscreenshot 14:05:59 INFO - Running setup.py install for moztest 14:05:59 INFO - Running setup.py install for mozversion 14:06:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:00 INFO - Cleaning up... 14:06:00 INFO - Return code: 0 14:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:06: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 14:06: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 14:06:00 INFO - Using env: {'DISPLAY': ':0', 14:06:00 INFO - 'HOME': '/home/cltbld', 14:06:00 INFO - 'LANG': 'en_US.UTF-8', 14:06:00 INFO - 'LANGUAGE': 'en_US:en', 14:06:00 INFO - 'LOGNAME': 'cltbld', 14:06:00 INFO - 'MAIL': '/var/mail/cltbld', 14:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:00 INFO - 'MOZ_NO_REMOTE': '1', 14:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:00 INFO - 'NO_EM_RESTART': '1', 14:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:00 INFO - 'PWD': '/builds/slave/test', 14:06:00 INFO - 'SHELL': '/bin/bash', 14:06:00 INFO - 'SHLVL': '1', 14:06:00 INFO - 'TERM': 'linux', 14:06:00 INFO - 'TMOUT': '86400', 14:06:00 INFO - 'USER': 'cltbld', 14:06:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:00 INFO - '_': '/tools/buildbot/bin/python'} 14:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:00 INFO - Running setup.py (path:/tmp/pip-HG8Jab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:00 INFO - Running setup.py (path:/tmp/pip-9hgRrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:00 INFO - Running setup.py (path:/tmp/pip-cm_f3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:00 INFO - Running setup.py (path:/tmp/pip-sLagia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:00 INFO - Running setup.py (path:/tmp/pip-Gy3426-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:00 INFO - Running setup.py (path:/tmp/pip-OOlWqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:00 INFO - Running setup.py (path:/tmp/pip-JP8ZbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06: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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:00 INFO - Running setup.py (path:/tmp/pip-bK3Ry3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:00 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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:00 INFO - Running setup.py (path:/tmp/pip-GPnBLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:00 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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:00 INFO - Running setup.py (path:/tmp/pip-7Op85z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:00 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)) 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:00 INFO - Running setup.py (path:/tmp/pip-aBn6l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:01 INFO - Running setup.py (path:/tmp/pip-D9sOkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:01 INFO - Running setup.py (path:/tmp/pip-C3EPhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:01 INFO - Running setup.py (path:/tmp/pip-blCsaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:01 INFO - Running setup.py (path:/tmp/pip-88G7n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:01 INFO - Running setup.py (path:/tmp/pip-cWC418-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06: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)) 14:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:01 INFO - Running setup.py (path:/tmp/pip-GOrWjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:03 INFO - Downloading blessings-1.6.tar.gz 14:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:03 INFO - Installing collected packages: blessings 14:06:03 INFO - Running setup.py install for blessings 14:06:03 INFO - Successfully installed blessings 14:06:03 INFO - Cleaning up... 14:06:03 INFO - Return code: 0 14:06:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:03 INFO - Reading from file tmpfile_stdout 14:06:03 INFO - Current package versions: 14:06:03 INFO - argparse == 1.2.1 14:06:03 INFO - blessings == 1.6 14:06:03 INFO - blobuploader == 1.2.4 14:06:03 INFO - docopt == 0.6.1 14:06:03 INFO - manifestparser == 1.1 14:06:03 INFO - mozInstall == 1.12 14:06:03 INFO - mozcrash == 0.17 14:06:03 INFO - mozdebug == 0.1 14:06:03 INFO - mozdevice == 0.48 14:06:03 INFO - mozfile == 1.2 14:06:03 INFO - mozhttpd == 0.7 14:06:03 INFO - mozinfo == 0.9 14:06:03 INFO - mozleak == 0.1 14:06:03 INFO - mozlog == 3.1 14:06:03 INFO - moznetwork == 0.27 14:06:03 INFO - mozprocess == 0.22 14:06:03 INFO - mozprofile == 0.28 14:06:03 INFO - mozrunner == 6.11 14:06:03 INFO - mozscreenshot == 0.1 14:06:03 INFO - mozsystemmonitor == 0.0 14:06:03 INFO - moztest == 0.7 14:06:03 INFO - mozversion == 1.4 14:06:03 INFO - psutil == 3.1.1 14:06:03 INFO - requests == 1.2.3 14:06:03 INFO - wsgiref == 0.1.2 14:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:03 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')]} 14:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:03 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')]} 14:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:03 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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:06:03 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 14:06:03 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 14:06:03 INFO - Using env: {'DISPLAY': ':0', 14:06:03 INFO - 'HOME': '/home/cltbld', 14:06:03 INFO - 'LANG': 'en_US.UTF-8', 14:06:03 INFO - 'LANGUAGE': 'en_US:en', 14:06:03 INFO - 'LOGNAME': 'cltbld', 14:06:03 INFO - 'MAIL': '/var/mail/cltbld', 14:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:03 INFO - 'MOZ_NO_REMOTE': '1', 14:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:03 INFO - 'NO_EM_RESTART': '1', 14:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:03 INFO - 'PWD': '/builds/slave/test', 14:06:03 INFO - 'SHELL': '/bin/bash', 14:06:03 INFO - 'SHLVL': '1', 14:06:03 INFO - 'TERM': 'linux', 14:06:03 INFO - 'TMOUT': '86400', 14:06:03 INFO - 'USER': 'cltbld', 14:06:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:03 INFO - '_': '/tools/buildbot/bin/python'} 14:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06: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)) 14:06:04 INFO - Cleaning up... 14:06:04 INFO - Return code: 0 14:06:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:06: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 14:06: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 14:06:04 INFO - Using env: {'DISPLAY': ':0', 14:06:04 INFO - 'HOME': '/home/cltbld', 14:06:04 INFO - 'LANG': 'en_US.UTF-8', 14:06:04 INFO - 'LANGUAGE': 'en_US:en', 14:06:04 INFO - 'LOGNAME': 'cltbld', 14:06:04 INFO - 'MAIL': '/var/mail/cltbld', 14:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:04 INFO - 'MOZ_NO_REMOTE': '1', 14:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:04 INFO - 'NO_EM_RESTART': '1', 14:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:04 INFO - 'PWD': '/builds/slave/test', 14:06:04 INFO - 'SHELL': '/bin/bash', 14:06:04 INFO - 'SHLVL': '1', 14:06:04 INFO - 'TERM': 'linux', 14:06:04 INFO - 'TMOUT': '86400', 14:06:04 INFO - 'USER': 'cltbld', 14:06:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:04 INFO - '_': '/tools/buildbot/bin/python'} 14:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:04 INFO - Downloading/unpacking jsonschema 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:06 INFO - Downloading/unpacking functools32 (from jsonschema) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:06 INFO - warning: no files found matching '*.txt' 14:06:06 INFO - no previously-included directories found matching 'build' 14:06:06 INFO - no previously-included directories found matching 'dist' 14:06:06 INFO - no previously-included directories found matching '.git*' 14:06:06 INFO - Installing collected packages: jsonschema, functools32 14:06:06 INFO - Running setup.py install for functools32 14:06:06 INFO - warning: no files found matching '*.txt' 14:06:06 INFO - no previously-included directories found matching 'build' 14:06:06 INFO - no previously-included directories found matching 'dist' 14:06:06 INFO - no previously-included directories found matching '.git*' 14:06:06 INFO - Successfully installed jsonschema functools32 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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 0x7fb343922f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2804770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, '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': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', '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 14:06: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 14:06: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 14:06:06 INFO - Using env: {'DISPLAY': ':0', 14:06:06 INFO - 'HOME': '/home/cltbld', 14:06:06 INFO - 'LANG': 'en_US.UTF-8', 14:06:06 INFO - 'LANGUAGE': 'en_US:en', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MAIL': '/var/mail/cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SHLVL': '1', 14:06:06 INFO - 'TERM': 'linux', 14:06:06 INFO - 'TMOUT': '86400', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - '_': '/tools/buildbot/bin/python'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Downloading/unpacking flake8 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:06:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:06:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:09 INFO - no previously-included directories found matching 'docs/_build' 14:06:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:06:09 INFO - Running setup.py install for pep8 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:09 INFO - no previously-included directories found matching 'docs/_build' 14:06:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:06:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Running post-action listener: _resource_record_post_action 14:06:09 INFO - Running post-action listener: _start_resource_monitoring 14:06:09 INFO - Starting resource monitoring. 14:06:09 INFO - ##### 14:06:09 INFO - ##### Finished create-virtualenv step (success) 14:06:09 INFO - ##### 14:06:09 INFO - ##### 14:06:09 INFO - ##### Running install step. 14:06:09 INFO - ##### 14:06:09 INFO - Running pre-action listener: _resource_record_pre_action 14:06:09 INFO - Running main action method: install 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:09 INFO - Reading from file tmpfile_stdout 14:06:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:09 INFO - Reading from file tmpfile_stdout 14:06:09 INFO - Output received: 14:06:09 INFO - Usage: mozinstall [options] installer 14:06:09 INFO - Options: 14:06:09 INFO - -h, --help show this help message and exit 14:06:09 INFO - -d DEST, --destination=DEST 14:06:09 INFO - Directory to install application into. [default: 14:06:09 INFO - "/builds/slave/test"] 14:06:09 INFO - --app=APP Application being installed. [default: firefox] 14:06:09 INFO - mkdir: /builds/slave/test/build/application 14:06:09 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'] 14:06:09 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 14:06:26 INFO - Reading from file tmpfile_stdout 14:06:26 INFO - Output received: 14:06:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - ##### 14:06:26 INFO - ##### Finished install step (success) 14:06:26 INFO - ##### 14:06:26 INFO - ##### 14:06:26 INFO - ##### Running run-tests step. 14:06:26 INFO - ##### 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: run_tests 14:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:26 INFO - Python 2.7.3 14:06:26 INFO - Return code: 0 14:06:26 INFO - grabbing minidump binary from tooltool 14:06:26 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')]} 14:06:26 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 0x28939c0>, '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 0x28948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2894d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:26 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 14:06:26 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 14:06:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:26 INFO - Return code: 0 14:06:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:06:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:06:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:06:27 INFO - Return code: 0 14:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 14:06:27 INFO - Using env: {'DISPLAY': ':0', 14:06:27 INFO - 'HOME': '/home/cltbld', 14:06:27 INFO - 'LANG': 'en_US.UTF-8', 14:06:27 INFO - 'LANGUAGE': 'en_US:en', 14:06:27 INFO - 'LOGNAME': 'cltbld', 14:06:27 INFO - 'MAIL': '/var/mail/cltbld', 14:06:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:27 INFO - 'MOZ_NO_REMOTE': '1', 14:06:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:27 INFO - 'NO_EM_RESTART': '1', 14:06:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:27 INFO - 'PWD': '/builds/slave/test', 14:06:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:27 INFO - 'SHELL': '/bin/bash', 14:06:27 INFO - 'SHLVL': '1', 14:06:27 INFO - 'TERM': 'linux', 14:06:27 INFO - 'TMOUT': '86400', 14:06:27 INFO - 'USER': 'cltbld', 14:06:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789', 14:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:27 INFO - '_': '/tools/buildbot/bin/python'} 14:06:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:06:27 INFO - mozversion application_buildid: 20160507113042 14:06:27 INFO - mozversion application_changeset: 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 14:06:27 INFO - mozversion application_display_name: Nightly 14:06:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:27 INFO - mozversion application_name: Firefox 14:06:27 INFO - mozversion application_remotingname: firefox 14:06:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:06:27 INFO - mozversion application_vendor: Mozilla 14:06:27 INFO - mozversion application_version: 49.0a1 14:06:27 INFO - mozversion platform_buildid: 20160507113042 14:06:27 INFO - mozversion platform_changeset: 52749e84bf25fb6aed91ab1339b74cc0e7aae5e7 14:06:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:06:27 INFO - mozversion platform_version: 49.0a1 14:06:27 INFO - using testdate: 1462655187 14:06:27 INFO - actual date: 1462655187 14:06:27 INFO - starting webserver on 'localhost:43075' 14:06:27 INFO - SUITE-START | Running 2 tests 14:06:27 INFO - TEST-START | dromaeo_css 14:06:27 INFO - operating with platform_type : linux_ 14:06:27 INFO - Initialising browser for dromaeo_css test... 14:06:27 INFO - TEST-INFO | started process 20077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiB4R8V/profile http://localhost:43075/getInfo.html) 14:06:31 INFO - PROCESS | 20077 | __metrics Screen width/height:1600/1200 14:06:31 INFO - PROCESS | 20077 | colorDepth:24 14:06:31 INFO - PROCESS | 20077 | Browser inner width/height: 1024/697 14:06:31 INFO - PROCESS | 20077 | __metrics 14:06:32 ERROR - PROCESS | 20077 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:06:33 INFO - TEST-INFO | 20077: exit 0 14:06:33 INFO - Browser initialized. 14:06:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:33 INFO - TEST-INFO | started process 20156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiB4R8V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:45 INFO - PROCESS | 20156 | RSS: Main: 151818240 14:06:45 INFO - PROCESS | 20156 | 14:07:36 INFO - PROCESS | 20156 | 1462655256016 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] 14:09:44 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43075/tests/dromaeo/cssquery-ext.html) 14:09:45 INFO - PROCESS | 20156 | RSS: Main: 277786624 14:09:45 INFO - PROCESS | 20156 | 14:12:47 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-ext.html (next: http://localhost:43075/tests/dromaeo/cssquery-jquery.html) 14:12:48 INFO - PROCESS | 20156 | RSS: Main: 246251520 14:12:48 INFO - PROCESS | 20156 | 14:15:50 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43075/tests/dromaeo/cssquery-mootools.html) 14:15:50 INFO - PROCESS | 20156 | RSS: Main: 238133248 14:15:50 INFO - PROCESS | 20156 | 14:18:52 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43075/tests/dromaeo/cssquery-prototype.html) 14:18:53 INFO - PROCESS | 20156 | RSS: Main: 235302912 14:18:53 INFO - PROCESS | 20156 | 14:21:56 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43075/tests/dromaeo/cssquery-yui.html) 14:21:56 INFO - PROCESS | 20156 | RSS: Main: 203952128 14:21:56 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | Cycle 1(1): loaded http://localhost:43075/tests/dromaeo/cssquery-yui.html (next: http://localhost:43075/tests/dromaeo/cssquery-dojo.html) 14:24:59 INFO - PROCESS | 20156 | RSS: Main: 291897344 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | __start_tp_report 14:24:59 INFO - PROCESS | 20156 | _x_x_mozilla_page_load 14:24:59 INFO - PROCESS | 20156 | _x_x_mozilla_page_load_details 14:24:59 INFO - PROCESS | 20156 | |i|pagename|runs| 14:24:59 INFO - PROCESS | 20156 | |0;dojo.html;3102.286474110953;3130.1235654016878;3156.068959656902;3179.252875574241;3207.1501052221165;5229.137192363265;5294.232336311233;5307.416184219737;5380.24676545284;5429.5384892284155;5309.203619457084;5335.253064570963;5344.4922732340365;5415.891682166354;5436.374816896058;4809.110314591811;4821.783019764119;4940.876478088058;4944.579710724574;4986.675866068712;4902.338184345103;4919.655624106314;4965.503449655042;4969.031038947407;4978.377702787152;4779.307000484928;4790.305405716186;4795.592374648159;4825.420949486049;4875.780589873464;4821.975890120562;4831.758412079382;4833.734144622044;4838.540338667821;4876.268559716035;4805.831795887128;4840.878978025577;4879.682820616648;4879.902401951941;4900.58345040672;5175.120229560984;5197.220416937452;5221.190715439113;5229.607779416559;5318.867028324323;5636.718164091779;5660.801871934504;5694.345150307726;5721.599488035839;5722.54219662426;5734.627249228828;5754.6547207167705;5800.941990580082;5806.477417032445;5819.039858423355;5225.843224703265;5353.598480113968;5369.221462887859;5380.515753582157;5382.811601593926;6001.339852616209;6007.609505382224;6018.879622407528;6020.217371741645;6031.60794548353;5730.1404789281105;5753.194552762617;5765.56758243125;5771.913421298684;5774.422557744276;5612.074007788669;5642.774289028393;5661.886762264731;5683.744231509592;5707.315122185364;5645.322561292671;5700.315962084576;5710.371859095496;5714.657120572779;5715.685637289906;5721.884232574691;5727.284089488814;5735.942640573624;5737.88524229513;5741.311042674905;4321.503027151918;4346.847860324873;4353.042330687307;4359.12817436514;4428.114377124588;3884.6698030667144;3926.509186351706;3934.055826601595;3960.4257382679925;3964.742291751027;5479.808206712825;5491.945080549223;5492.752826122834;5500.50495455411;5501;5657.490825825613;5680.602357834912;5707.029804933171;5735.598508104393;5750.827475175752;5453.045716999509;5453.23654688344;5456.399796022434;5461.9453805462235;5468.234447177399;4823;4831.855044348676;4833.32333473314;4839.491853355347;4878;5803.187553742479;5848.239728835224;5915.792947246826;5924;5976.999999999913;5757.251557297692;5771.884562308815;5773.595848290579;5778;5784.884302314014;5769.278840144982;5934.109883517507;5942.821715348547;5943.078822782476;5945.346011938596;5565.4991050804;5568.6658800472105;5602.215689803512;5659.6321239119325;5666.206731057573;5728.942710573007;5738.397468265772;5741.425857414225;5745.1382292656435;5745.166950792195;5450.127979523258;5487.533559647315;5552.69460179694;5593.188987596857;5599;5517.834464966058;5559.694216818114;5573.554115670818;5575.080111781673;5627.8874422512135;5458.590605704509;5462.91805622908;5464.2076898848645;5468.398476167698;5491.643043202179;5392.5416339611575;5562.471565201299;5582.419544419767;5625.09998400254;5663.716814159358;5538.390777014606;5543.584231182596;5546.805861794818;5564.304461942257;5589.944100558942 14:24:59 INFO - PROCESS | 20156 | |1;ext.html;578.4735890339789;642.559846505144;646.9611823290603;648.9805305840821;654.7544670748467;42719.57280427195;44434.11131777366;44530;44531.332030019534;47830.52169478313;43992.12015759683;44709.32936005954;44756.55243447565;44889.77555112228;44896.3265551017;8851.203391694746;8955.641774329019;9000.684976025808;9006.099390060974;9015.684451044215;8795.164459376381;8870.467771933705;8896.06591307913;8896.955515222415;8903.599338029771;8925.70577266296;8945.881764779402;8946.507942063185;8991.865122023175;8993.235574976135;8868.556572171397;8934.910650893473;8941.687040953535;8945.0607686193;8947.105289471066;8720.825583488358;8796.164364385373;8802.163794439519;8814.911850881537;8815.955920220422;40818.18363632711;41098.794506027276;41233.793831030955;41258.793706031574;41259.1748165035;3466.272082862602;3650.34293827111;3665.7617254878614;3677;4269.87190384289;31320.686793132234;32546.18634534132;32555.67444325574;32601.6739832601;32845;4243.596858298488;4315.180115777992;4376.649868010583;4418.072204836988;4473.2842745160615;321373;321567;322529;323091;323908;58744.41255587475;59081;59178;59181;59197.40802592005;57112.71443642755;62669.37330626635;64148;64200;70843.64578177076;13409.731805363837;13584.456621735217;13615.18308901469;13654.180749155083;13659.658508537168;12456.875431245753;12828.80756788649;12837.48650054006;12891.548795792101;12894.355282236038;17447.127643618023;17705.557361066076;17710.20304086319;19229.519262018282;19406.320778772675;6351.96824015877;7043.471739619549;7354;7485.176630570633;7495.43784216175;1035.4512108582464;1080.956761729522;1130.8869113088626;1157.5543415784985;1171.5313874450287;31852.203694907348;32190;32593.348133037205;32744.67255327464;32925.50611740826;1138.3568283919558;1183.331417748969;1223.6757259326287;1234.9135560510858;1242.2918936206277;17279.222434990457;17430.389936352167;17510.387136450165;17535.912320438318;17780.3776867809;461912;465903;465918;466397;468804;57028;57618.711906441036;57687.42312576905;57695.71152144212;57756;1375.8899288057132;1380.9585712428643;1400.8879289656802;1419.6379923119746;1420;30145.69854301429;31430.685693142776;31595.21011974719;31973;32078.839605801822;50258;50802.23796642979;50811.2378314333;50846.237306439696;50984.49015509798;393003;397014;399017;399134;399948;25135.371615709755;27351.45297094007;28132.156035318974;28561.28596785097;28568.428631427672;42273.365899512144;46553.3017004752;46683.29975050445;47471.76264118657;47755.28367074427;39909.80045099756;40274;40700.59299406968;40771.38842917299;41210;39854.60145398509;40298;40588.391174133;40702.59297407106;41015.38476922789;36745.265094697425;37818.62181378151;37819.62180378161;38543.80728096342;39218.607813921495;34814.303713925074;35360.646393536765;36288.27423451569;36325.636743632225;36409.27181456409;27560;27785.166445006682;27949.441011180068;28219.15342539727;28227.71772282251 14:24:59 INFO - PROCESS | 20156 | |2;jquery.html;396.83531334496183;398.298993770963;399.30321588827496;399.7841165770484;419.90552125771706;14146.858531414682;17037.57406064849;17109.82890171098;18552.814471855276;18559.164837582306;15359.462418815343;17010;17473.03898285594;18106.366277180303;18440.907795461004;5438.075527160392;5636.408177141403;5651.802186923438;5675.404082571312;5676.801311954083;4029.6373326400617;5593.496585307322;5610.24261724666;5866.88266234675;6164.7534098636;6086.908696369558;6194.628322300654;6217.533684973645;6231.065340198984;6234.594751341148;6004.729787159588;6130.938690613104;6203.379662033805;6207.379262073801;6216.937830621681;5306.257124002643;5459;5473.698946557938;5483.917741233885;5484.012877682016;21023;22302.553948921093;22470;22714.318570442912;22717.091316347327;2337.298810356886;2439.4877075813924;2450.0567281596536;2680.664916885389;2818.1263808219314;10103.444310562916;10999.670009899715;13315.800262996063;14178.14931104137;14878;1921.9615607687767;1966.9311574094982;1969.7439332886634;1986;2100.779418161086;71410.64294678494;76118;85918.84486930742;87401.25197496077;90749.54625226898;10885.891141088647;10953.17851161166;11184.328940263611;11228.989390954854;11373.94313028446;15036;15095.924520377328;15222.695546089017;15286.770698439532;15583.766243506356;7763.961180194063;7909.881351779728;8075.434719569574;8097.757067287991;8362.205590468895;6639.601623902581;7870.252326029018;7954.482958607672;7970.601469926481;8036.959815200887;4458.197524445631;4520.95479045212;4684.273937539687;4790.808367665324;4845.6123510119105;1791.2924394863956;1877.1177546553372;1926.5472613935715;1996.091778240897;2016.25398602518;900.504722402676;1021.8160731068479;1050.1808589300358;1069.1446842526104;1110.152458942809;18496.560825401808;18644;19114.33099841499;19202;19537.120829562704;1015.5937624950079;1022.8158931392421;1023.1098943918689;1028.3572767020612;1115.6653004098737;10118.949405252926;10443.738906527245;10496.68509944703;10509.2242100649;10587.947060264649;472482;474907;477758;482159;483787;59620;91891.54054229686;91960;93048;93801.06198937923;1092.5138313450439;1103.564092183583;1136.357957753883;1142.3374442823142;1167.9532818687157;16312.67374652524;16313.918430407772;16526.75209871877;16532.917335413247;16557.254923528228;36391.818040910686;37370.626293736714;37793.433098504094;37920.241595168496;42128;51620.74189629178;55026;55687.72156139193;55768.16347754706;55772.44227557672;8590.785230369042;8932.642694292155;8997.235235005099;9010.684626038057;9229.861552076858;10424.635137770141;12386.380680965736;13073.934630326787;13537.864621353661;14116.929415352857;11586.131040171853;11819.468123934272;11861.76276474483;12210.6947326314;12581.119321647397;11991.700207494883;11993.700157496132;12009.159358845147;12011.099167562643;12407.31759753186;12268.263904165779;12384.62846114618;12435;12484.188527745668;12552.309622970824;8932.732018039469;9051.411658242194;9208.401453905475;9216.617507373947;9296.535173241446;12057.216280941711;12386.938065309616;12510;12631.93684031574;12713.491460341853 14:24:59 INFO - PROCESS | 20156 | |3;mootools.html;1337.6054064051104;1480.4152359817876;1523.6190952261934;1669.599296168919;1814.0748218408607;7705.614719264036;8015.557199704051;8034.437589368754;8199.344052475803;8200.91799082009;7943.602819858998;8114.837703245931;8127.796805079876;8131.308838748713;8150.6332215050315;1951.74627298451;2066.813986741193;2138.8395870309787;2214.0368939511322;2252.4706693926914;2265.082641530183;2271.659251112338;2271.772822717723;2272.7045484087043;2276.9203077892275;2203.922862699806;2244.8204143668468;2247.71903512061;2249.6850440938283;2250.909963601454;1942.7571553555806;2160.9891950540305;2215.1360969222014;2218.6561083032157;2232.241038047072;2179.2372669565525;2189.5839790439763;2197.7033100531544;2201.3946164804647;2219.7336319641586;8040.959795200986;8088.069871964682;8091.554964476952;8094.231048050426;8104.1085480597085;4824.107540105057;4991.126552853236;4998.925016124761;5002.074616196015;5003.899922001539;3223.7904536205306;3273.787203831743;3337.5327454156436;3364.629890712044;3383.1880348716377;1074.6399956014745;1087.499750114948;1091.6997825597944;1120.7590368070903;1123.1744667669257;10848.186386021001;10857.891421085767;10860.619878304222;10865.945670271598;10869.782604347947;4356.6950313477755;4382.627476664519;4463.375127482155;4477.417935668407;4503.932441013388;9188.8621670675;9193.218576420946;9230.815383692288;9234.953825230965;9249.90750092504;4558.065596552765;4930.975345123252;4974.701517908937;4979.128652485801;4980.800767969313;4353.172897149595;4442.977785111054;4448.088141930896;4467.754273514988;4477.328400739915;3688.1517251032415;3736.906577335534;3768.6231376862643;3792.943105853414;3827.234553089393;1215.5016443258398;1222.896053835416;1238.4303220518661;1238.8265642810013;1243.8631750507436;921.5300196899495;1025.4821315235758;1028.5937054863286;1037.4294138223947;1039.7452624107143;5722.828315150552;5741.425857414309;5762.9135562966585;5769.076947688433;5967.433093856077;450.9503954564995;452.9864104076883;454.90901819636207;993.6621548673486;1041.95832166714;4137.81379837902;4203.684723645678;4203.726757760735;4211.599898009684;4217.1776503581505;10022.398656080659;10347.482625868826;10484.213683973732;10533.84199237012;10546.525406356732;10226.948865255627;10255.384676919259;10356.741081473023;10422.843657345145;10430.843537346946;7256.709731610782;7818.14000459949;7901.249381308767;7981.760547183594;8010.599470026592;5769.74036168365;5822.73797679097;5935.792247271324;5942.1978032965;5977.9402205977385;8575;9505.144536991704;9585.233181345337;9598;9681.951590242004;8827.735167944971;8958.68644597436;9039.23166530826;9070.546472676471;9143.679971200976;6374.4263016326895;6708;6847;7268.255618651591;7438.44211684115;7814.218578142368;7851.489653172525;7909.52542847431;7925.128235894163;7928.7621371358955;6957.721691132298;7196.568205907663;7216;7297.562146271241;7355.190928997699;6848.280930502425;6884.965575172092;6928.618925959121;7081.716731330689;7247.565146091251;6412.35876412355;6756.087928129639;6771.966140169267;6774.762883299061;6784.151981002375;4861.222204447272;4877.365942427462;4908.484609115992;4935.827246046371;5031.74841257943;4877.6829506081995;4976.427710813303;5017.57350625201;5023.723695196799;5121.231815227746 14:24:59 INFO - PROCESS | 20156 | |4;prototype.html;338.7391708384544;341.49970293519993;349.2212366422877;350.59331175836036;352.7583605230416;5216.504432078951;5248.21276808478;5269.446708095652;5278.469243919269;5286.392064912531;5183.585313174946;5202.895942081156;5214.530692237708;5240.68555886647;5261.97391508656;3801.277757226132;3909.667678247345;3943.2310699413624;3952.1107750756137;4018.8995275118064;4047.4738284023183;4078.4086307485395;4086.7522862425694;4086.836526538935;4113.5269444013875;4068.776217308047;4080.571539988303;4082.5100987881497;4102.897427564305;4104.97947510262;3892.2799282132896;3998.1603863188766;4072.3891416287497;4094.508658960914;4110.630043296118;3642.8360723767228;3645.3073915955883;3662.377395842713;3664.3221004114325;3677.7793332400142;5050.797968081272;5067.657070876221;5068.695878247317;5070.31550740649;5077.847664570068;4727.290906364038;4730.787114579852;4739.099571081483;4786.282057691339;4789.640776941744;5460.180972854064;5483.670979741229;5489.917651235235;5490.423505531941;5505.972470137664;3860.768353898775;3961.227560625679;3974.3442332015184;3983.6215559521797;3985.7807820569856;5431.646942948696;5513.117901135799;5602.411746766612;5640.182173584807;5661.122526008476;4096.774677392772;4100.65144462724;4108.979455102765;4110.301248787713;4121.62905338515;3887.5334959805004;4092.4270602115726;4108.548059713429;4108.77401742907;4161.625453709181;4605.6085232755595;4623.884402889955;4629.305604159403;4638.79125439356;4647.604953578916;5463.306375023755;5473.562115030788;5477.917831232455;5527.143292789624;5539.5014448699;1358.843732970721;1380.9585712428643;1385.1758203868683;1387.4450219911914;1396.1692792788274;949.9050094990446;952.6189524190379;958.6165533786402;961.7355227312405;966.3428868369576;5229.607779416559;5230.450802665665;5232.581393488512;5239.947600523946;5244.842654720364;5451.182322651554;5459.39946605881;5470.398256191816;5473.9452605474235;5496.367917689437;5006.299118123466;5181.523265869209;5203.7918483261;5222.164453687467;5394.163904594794;2859.0422208560367;2912.7378535931443;2928.604638373835;2932.838693871815;2958.2604348912773;5653.547716182696;5660.2075709400715;5681.119426488901;5690.5489100279165;5696.287964004499;5487.259220005249;5600.886873670497;5630.662160270397;5643.435656434323;5646.6612003279115;5678.517326027334;5701.800436984686;5725.652482482245;5736.5410767139365;5803.332616749128;5310.397905026586;5412.675239485643;5597.216389705526;5603.581815092872;5616.943830561642;5491.615586908878;5506.862328441821;5508.512701570634;5593.664380137205;5610.438956104357;5546.972265138648;5757.222774925332;5766.481016708516;5780.364159942319;5782.710864456844;4009.5389030261895;4043.6158564936286;4051;4058.8285267381807;4069.4709687740406;5600.35595906476;5671.943280567141;5678.3186017678145;5692.430756924275;5704.629199102211;5209.6715337590185;5482.424345443671;5508.752106155152;5519.2824932758485;5523.944760552343;5479.726013699379;5487.725613719378;5499.5325397340075;5503.532199763065;5517.448255174611;5401.864953376197;5409.891802164014;5412.161115027177;5413.40452550227;5418.620696551204;5286;5471.398146203835;5483.177523371526;5502.422245664147;5524.309461317335;5360.571154307568;5361.839144825662;5374.785008599612;5386.59600529954;5418.701971391612 14:24:59 INFO - PROCESS | 20156 | |5;yui.html;735.4778107543643;738.4092725819344;751.1812124783985;756.9205233450484;784.4077721320403;12707.936460317696;13460;13509.594712158627;13515.189088654688;13531.564318422692;11271.211015228917;11451.198416110876;11524.71188220295;11574.65276041718;12097.092718046139;686.0669489494284;804.3846457460048;807.168616325186;827.1728271728272;833.2334252487726;821.6425854753202;822.7284995951352;823.1439303124773;824.5918270456102;825.4345773145415;844.1558441558442;852.7484392104344;852.9530875801828;853.1340689200466;853.2576658307281;720.8089856188114;840.306746933779;854.372036553133;859.1623167411786;860.8149247911698;629.0878226571444;629.8393909553081;630.1996464490118;630.3790766095392;630.5586089737202;12247.75504489914;12258.81611775824;12269.631911042594;12272.631821045383;12285.447154877962;13022.283774392405;13152.210867347894;13329.533466328729;13409.262490563015;13622.386992585358;11058.502367393487;11093.445327733582;11245.606403775828;12195.024398048135;12472;4523.050159466516;4528.411306530163;4600.700954437984;4618.49196588375;4688.5545873142;53318.46681533174;53496.73251633756;53965.730171349285;54064.72967635176;54249.45750542523;9722.2708296878;10250.231232657432;10278.537465814057;10571;10664.413457259925;17814.198361073784;17952.19215135322;17955.820441795415;18124.909375453037;18224.908875455538;7845.960770196112;7852.803679907934;7867.6066196689935;7906.327962123169;7928.6828526859435;4413.492448368414;4444.6666500012625;4464.419625448671;4488.64090872736;4711.717296962193;3125.718685318332;3211.213252753044;3226.451503244454;3226.4998925166637;3226.596675415573;520.6485622204997;584.1354794903566;586.4956137721556;605.2736715940889;623.4513628007325;665.354606032148;707.3386383731125;708.8334241453255;710.9324614161646;717.727263639824;8983.865242021375;9066.36535442526;9232.169104780602;9260.397459537018;9296.535173241311;696.8571442854203;707.6673963237271;768.6676427525649;780.4365287928607;789.6249281591198;4203.831846726097;4554.203014472454;4581.908361832745;4616.30755386688;4618.884527886829;63542.36457635457;65121.67439162774;65154.67422662951;65245.347546523924;65637.34362656312;57211;57944.420555793906;57998.42001580015;58657.70671146617;58771;46666;47698.5230147701;47831;50175;52892.206616900774;9262.44425334482;9408.858867117136;9422.764430889283;9439.575219115019;9473.715788526355;30368.84815575908;30433;30990.69009309878;32424.83787581047;32732.50901236531;37990;41882;41967;42064;42325.78837105918;11913.638778154427;12012.579559715718;12018.278903265833;12167.75664486723;12373;12886.48454061827;12900.870991290343;13138.343082846011;13204.405801738752;13352.132111412728;11941.46263418131;11998.880011199777;12084.637460876187;12264.080193985308;12269.263844169378;12188.878111219128;12318.568850090203;12323.50705971751;12326.260424374566;12389.380530973596;12284.938575307066;12341.81473820598;12513.562025329069;12776.169548979287;12806.359682015676;9971.950769107649;10145.9492702536;10256.38461692301;10395.480225988822;10619.575216991234;10205.38767673942;10765.677029689123;10774.084202842847;10820.296680715728;10822.945885270523 14:24:59 INFO - PROCESS | 20156 | __end_tp_report 14:24:59 INFO - PROCESS | 20156 | __start_cc_report 14:24:59 INFO - PROCESS | 20156 | _x_x_mozilla_cycle_collect,1019 14:24:59 INFO - PROCESS | 20156 | __end_cc_report 14:24:59 INFO - PROCESS | 20156 | __startTimestamp1462656299649__endTimestamp 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | ------- Summary: start ------- 14:24:59 INFO - PROCESS | 20156 | Number of tests: 6 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#0] dojo.html Cycles:165 Average:5319.43 Median:5501.00 stddev:601.77 (10.9%) stddev-sans-first:577.94 14:24:59 INFO - PROCESS | 20156 | Values: 3102.3 3130.1 3156.1 3179.3 3207.2 5229.1 5294.2 5307.4 5380.2 5429.5 5309.2 5335.3 5344.5 5415.9 5436.4 4809.1 4821.8 4940.9 4944.6 4986.7 4902.3 4919.7 4965.5 4969.0 4978.4 4779.3 4790.3 4795.6 4825.4 4875.8 4822.0 4831.8 4833.7 4838.5 4876.3 4805.8 4840.9 4879.7 4879.9 4900.6 5175.1 5197.2 5221.2 5229.6 5318.9 5636.7 5660.8 5694.3 5721.6 5722.5 5734.6 5754.7 5800.9 5806.5 5819.0 5225.8 5353.6 5369.2 5380.5 5382.8 6001.3 6007.6 6018.9 6020.2 6031.6 5730.1 5753.2 5765.6 5771.9 5774.4 5612.1 5642.8 5661.9 5683.7 5707.3 5645.3 5700.3 5710.4 5714.7 5715.7 5721.9 5727.3 5735.9 5737.9 5741.3 4321.5 4346.8 4353.0 4359.1 4428.1 3884.7 3926.5 3934.1 3960.4 3964.7 5479.8 5491.9 5492.8 5500.5 5501.0 5657.5 5680.6 5707.0 5735.6 5750.8 5453.0 5453.2 5456.4 5461.9 5468.2 4823.0 4831.9 4833.3 4839.5 4878.0 5803.2 5848.2 5915.8 5924.0 5977.0 5757.3 5771.9 5773.6 5778.0 5784.9 5769.3 5934.1 5942.8 5943.1 5945.3 5565.5 5568.7 5602.2 5659.6 5666.2 5728.9 5738.4 5741.4 5745.1 5745.2 5450.1 5487.5 5552.7 5593.2 5599.0 5517.8 5559.7 5573.6 5575.1 5627.9 5458.6 5462.9 5464.2 5468.4 5491.6 5392.5 5562.5 5582.4 5625.1 5663.7 5538.4 5543.6 5546.8 5564.3 5589.9 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#1] ext.html Cycles:180 Average:56300.66 Median:40736.99 stddev:105490.04 (259.0%) stddev-sans-first:105703.00 14:24:59 INFO - PROCESS | 20156 | Values: 578.5 642.6 647.0 649.0 654.8 42719.6 44434.1 44530.0 44531.3 47830.5 43992.1 44709.3 44756.6 44889.8 44896.3 8851.2 8955.6 9000.7 9006.1 9015.7 8795.2 8870.5 8896.1 8897.0 8903.6 8925.7 8945.9 8946.5 8991.9 8993.2 8868.6 8934.9 8941.7 8945.1 8947.1 8720.8 8796.2 8802.2 8814.9 8816.0 40818.2 41098.8 41233.8 41258.8 41259.2 3466.3 3650.3 3665.8 3677.0 4269.9 31320.7 32546.2 32555.7 32601.7 32845.0 4243.6 4315.2 4376.6 4418.1 4473.3 321373.0 321567.0 322529.0 323091.0 323908.0 58744.4 59081.0 59178.0 59181.0 59197.4 57112.7 62669.4 64148.0 64200.0 70843.6 13409.7 13584.5 13615.2 13654.2 13659.7 12456.9 12828.8 12837.5 12891.5 12894.4 17447.1 17705.6 17710.2 19229.5 19406.3 6352.0 7043.5 7354.0 7485.2 7495.4 1035.5 1081.0 1130.9 1157.6 1171.5 31852.2 32190.0 32593.3 32744.7 32925.5 1138.4 1183.3 1223.7 1234.9 1242.3 17279.2 17430.4 17510.4 17535.9 17780.4 461912.0 465903.0 465918.0 466397.0 468804.0 57028.0 57618.7 57687.4 57695.7 57756.0 1375.9 1381.0 1400.9 1419.6 1420.0 30145.7 31430.7 31595.2 31973.0 32078.8 50258.0 50802.2 50811.2 50846.2 50984.5 393003.0 397014.0 399017.0 399134.0 399948.0 25135.4 27351.5 28132.2 28561.3 28568.4 42273.4 46553.3 46683.3 47471.8 47755.3 39909.8 40274.0 40700.6 40771.4 41210.0 39854.6 40298.0 40588.4 40702.6 41015.4 36745.3 37818.6 37819.6 38543.8 39218.6 34814.3 35360.6 36288.3 36325.6 36409.3 27560.0 27785.2 27949.4 28219.2 28227.7 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#2] jquery.html Cycles:180 Average:28342.72 Median:22386.28 stddev:78798.34 (352.0%) stddev-sans-first:78991.45 14:24:59 INFO - PROCESS | 20156 | Values: 396.8 398.3 399.3 399.8 419.9 14146.9 17037.6 17109.8 18552.8 18559.2 15359.5 17010.0 17473.0 18106.4 18440.9 5438.1 5636.4 5651.8 5675.4 5676.8 4029.6 5593.5 5610.2 5866.9 6164.8 6086.9 6194.6 6217.5 6231.1 6234.6 6004.7 6130.9 6203.4 6207.4 6216.9 5306.3 5459.0 5473.7 5483.9 5484.0 21023.0 22302.6 22470.0 22714.3 22717.1 2337.3 2439.5 2450.1 2680.7 2818.1 10103.4 10999.7 13315.8 14178.1 14878.0 1922.0 1966.9 1969.7 1986.0 2100.8 71410.6 76118.0 85918.8 87401.3 90749.5 10885.9 10953.2 11184.3 11229.0 11373.9 15036.0 15095.9 15222.7 15286.8 15583.8 7764.0 7909.9 8075.4 8097.8 8362.2 6639.6 7870.3 7954.5 7970.6 8037.0 4458.2 4521.0 4684.3 4790.8 4845.6 1791.3 1877.1 1926.5 1996.1 2016.3 900.5 1021.8 1050.2 1069.1 1110.2 18496.6 18644.0 19114.3 19202.0 19537.1 1015.6 1022.8 1023.1 1028.4 1115.7 10118.9 10443.7 10496.7 10509.2 10587.9 472482.0 474907.0 477758.0 482159.0 483787.0 59620.0 91891.5 91960.0 93048.0 93801.1 1092.5 1103.6 1136.4 1142.3 1168.0 16312.7 16313.9 16526.8 16532.9 16557.3 36391.8 37370.6 37793.4 37920.2 42128.0 51620.7 55026.0 55687.7 55768.2 55772.4 8590.8 8932.6 8997.2 9010.7 9229.9 10424.6 12386.4 13073.9 13537.9 14116.9 11586.1 11819.5 11861.8 12210.7 12581.1 11991.7 11993.7 12009.2 12011.1 12407.3 12268.3 12384.6 12435.0 12484.2 12552.3 8932.7 9051.4 9208.4 9216.6 9296.5 12057.2 12386.9 12510.0 12631.9 12713.5 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#3] mootools.html Cycles:180 Average:5419.45 Median:4869.29 stddev:2996.47 (61.5%) stddev-sans-first:2989.17 14:24:59 INFO - PROCESS | 20156 | Values: 1337.6 1480.4 1523.6 1669.6 1814.1 7705.6 8015.6 8034.4 8199.3 8200.9 7943.6 8114.8 8127.8 8131.3 8150.6 1951.7 2066.8 2138.8 2214.0 2252.5 2265.1 2271.7 2271.8 2272.7 2276.9 2203.9 2244.8 2247.7 2249.7 2250.9 1942.8 2161.0 2215.1 2218.7 2232.2 2179.2 2189.6 2197.7 2201.4 2219.7 8041.0 8088.1 8091.6 8094.2 8104.1 4824.1 4991.1 4998.9 5002.1 5003.9 3223.8 3273.8 3337.5 3364.6 3383.2 1074.6 1087.5 1091.7 1120.8 1123.2 10848.2 10857.9 10860.6 10865.9 10869.8 4356.7 4382.6 4463.4 4477.4 4503.9 9188.9 9193.2 9230.8 9235.0 9249.9 4558.1 4931.0 4974.7 4979.1 4980.8 4353.2 4443.0 4448.1 4467.8 4477.3 3688.2 3736.9 3768.6 3792.9 3827.2 1215.5 1222.9 1238.4 1238.8 1243.9 921.5 1025.5 1028.6 1037.4 1039.7 5722.8 5741.4 5762.9 5769.1 5967.4 451.0 453.0 454.9 993.7 1042.0 4137.8 4203.7 4203.7 4211.6 4217.2 10022.4 10347.5 10484.2 10533.8 10546.5 10226.9 10255.4 10356.7 10422.8 10430.8 7256.7 7818.1 7901.2 7981.8 8010.6 5769.7 5822.7 5935.8 5942.2 5977.9 8575.0 9505.1 9585.2 9598.0 9682.0 8827.7 8958.7 9039.2 9070.5 9143.7 6374.4 6708.0 6847.0 7268.3 7438.4 7814.2 7851.5 7909.5 7925.1 7928.8 6957.7 7196.6 7216.0 7297.6 7355.2 6848.3 6885.0 6928.6 7081.7 7247.6 6412.4 6756.1 6772.0 6774.8 6784.2 4861.2 4877.4 4908.5 4935.8 5031.7 4877.7 4976.4 5017.6 5023.7 5121.2 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#4] prototype.html Cycles:180 Average:4600.20 Median:5255.09 stddev:1340.07 (25.5%) stddev-sans-first:1305.10 14:24:59 INFO - PROCESS | 20156 | Values: 338.7 341.5 349.2 350.6 352.8 5216.5 5248.2 5269.4 5278.5 5286.4 5183.6 5202.9 5214.5 5240.7 5262.0 3801.3 3909.7 3943.2 3952.1 4018.9 4047.5 4078.4 4086.8 4086.8 4113.5 4068.8 4080.6 4082.5 4102.9 4105.0 3892.3 3998.2 4072.4 4094.5 4110.6 3642.8 3645.3 3662.4 3664.3 3677.8 5050.8 5067.7 5068.7 5070.3 5077.8 4727.3 4730.8 4739.1 4786.3 4789.6 5460.2 5483.7 5489.9 5490.4 5506.0 3860.8 3961.2 3974.3 3983.6 3985.8 5431.6 5513.1 5602.4 5640.2 5661.1 4096.8 4100.7 4109.0 4110.3 4121.6 3887.5 4092.4 4108.5 4108.8 4161.6 4605.6 4623.9 4629.3 4638.8 4647.6 5463.3 5473.6 5477.9 5527.1 5539.5 1358.8 1381.0 1385.2 1387.4 1396.2 949.9 952.6 958.6 961.7 966.3 5229.6 5230.5 5232.6 5239.9 5244.8 5451.2 5459.4 5470.4 5473.9 5496.4 5006.3 5181.5 5203.8 5222.2 5394.2 2859.0 2912.7 2928.6 2932.8 2958.3 5653.5 5660.2 5681.1 5690.5 5696.3 5487.3 5600.9 5630.7 5643.4 5646.7 5678.5 5701.8 5725.7 5736.5 5803.3 5310.4 5412.7 5597.2 5603.6 5616.9 5491.6 5506.9 5508.5 5593.7 5610.4 5547.0 5757.2 5766.5 5780.4 5782.7 4009.5 4043.6 4051.0 4058.8 4069.5 5600.4 5671.9 5678.3 5692.4 5704.6 5209.7 5482.4 5508.8 5519.3 5523.9 5479.7 5487.7 5499.5 5503.5 5517.4 5401.9 5409.9 5412.2 5413.4 5418.6 5286.0 5471.4 5483.2 5502.4 5524.3 5360.6 5361.8 5374.8 5386.6 5418.7 14:24:59 INFO - PROCESS | 20156 | 14:24:59 INFO - PROCESS | 20156 | [#5] yui.html Cycles:180 Average:14502.27 Median:4568.06 stddev:17152.93 (375.5%) stddev-sans-first:17169.89 14:24:59 INFO - PROCESS | 20156 | Values: 735.5 738.4 751.2 756.9 784.4 12707.9 13460.0 13509.6 13515.2 13531.6 11271.2 11451.2 11524.7 11574.7 12097.1 686.1 804.4 807.2 827.2 833.2 821.6 822.7 823.1 824.6 825.4 844.2 852.7 853.0 853.1 853.3 720.8 840.3 854.4 859.2 860.8 629.1 629.8 630.2 630.4 630.6 12247.8 12258.8 12269.6 12272.6 12285.4 13022.3 13152.2 13329.5 13409.3 13622.4 11058.5 11093.4 11245.6 12195.0 12472.0 4523.1 4528.4 4600.7 4618.5 4688.6 53318.5 53496.7 53965.7 54064.7 54249.5 9722.3 10250.2 10278.5 10571.0 10664.4 17814.2 17952.2 17955.8 18124.9 18224.9 7846.0 7852.8 7867.6 7906.3 7928.7 4413.5 4444.7 4464.4 4488.6 4711.7 3125.7 3211.2 3226.5 3226.5 3226.6 520.6 584.1 586.5 605.3 623.5 665.4 707.3 708.8 710.9 717.7 8983.9 9066.4 9232.2 9260.4 9296.5 696.9 707.7 768.7 780.4 789.6 4203.8 4554.2 4581.9 4616.3 4618.9 63542.4 65121.7 65154.7 65245.3 65637.3 57211.0 57944.4 57998.4 58657.7 58771.0 46666.0 47698.5 47831.0 50175.0 52892.2 9262.4 9408.9 9422.8 9439.6 9473.7 30368.8 30433.0 30990.7 32424.8 32732.5 37990.0 41882.0 41967.0 42064.0 42325.8 11913.6 12012.6 12018.3 12167.8 12373.0 12886.5 12900.9 13138.3 13204.4 13352.1 11941.5 11998.9 12084.6 12264.1 12269.3 12188.9 12318.6 12323.5 12326.3 12389.4 12284.9 12341.8 12513.6 12776.2 12806.4 9972.0 10145.9 10256.4 10395.5 10619.6 10205.4 10765.7 10774.1 10820.3 10822.9 14:24:59 INFO - PROCESS | 20156 | -------- Summary: end -------- 14:24:59 INFO - PROCESS | 20156 | 14:25:00 INFO - TEST-INFO | 20156: exit 0 14:25:00 INFO - TEST-OK | dromaeo_css | took 1112581ms 14:25:00 INFO - TEST-START | kraken 14:25:00 INFO - operating with platform_type : linux_ 14:25:00 INFO - Initialising browser for kraken test... 14:25:00 INFO - TEST-INFO | started process 20344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDQvyOO/profile http://localhost:43075/getInfo.html) 14:25:04 INFO - PROCESS | 20344 | __metrics Screen width/height:1600/1200 14:25:04 INFO - PROCESS | 20344 | colorDepth:24 14:25:04 INFO - PROCESS | 20344 | Browser inner width/height: 1024/697 14:25:04 INFO - PROCESS | 20344 | __metrics 14:25:05 ERROR - PROCESS | 20344 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:25:06 INFO - TEST-INFO | 20344: exit 0 14:25:06 INFO - Browser initialized. 14:25:06 INFO - Running cycle 1/1 for kraken test... 14:25:06 INFO - TEST-INFO | started process 20427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDQvyOO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:17 INFO - PROCESS | 20427 | RSS: Main: 151801856 14:25:17 INFO - PROCESS | 20427 | 14:25:20 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43075/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:21 INFO - PROCESS | 20427 | RSS: Main: 208953344 14:25:21 INFO - PROCESS | 20427 | 14:25:23 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43075/tests/kraken/driver.html?testName=audio-dft) 14:25:24 INFO - PROCESS | 20427 | RSS: Main: 197316608 14:25:24 INFO - PROCESS | 20427 | 14:25:27 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43075/tests/kraken/driver.html?testName=audio-fft) 14:25:28 INFO - PROCESS | 20427 | RSS: Main: 264630272 14:25:28 INFO - PROCESS | 20427 | 14:25:30 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43075/tests/kraken/driver.html?testName=audio-oscillator) 14:25:30 INFO - PROCESS | 20427 | RSS: Main: 173596672 14:25:30 INFO - PROCESS | 20427 | 14:25:33 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43075/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:33 INFO - PROCESS | 20427 | RSS: Main: 178536448 14:25:33 INFO - PROCESS | 20427 | 14:25:36 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43075/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:37 INFO - PROCESS | 20427 | RSS: Main: 213725184 14:25:37 INFO - PROCESS | 20427 | 14:25:40 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43075/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:41 INFO - PROCESS | 20427 | RSS: Main: 214953984 14:25:41 INFO - PROCESS | 20427 | 14:25:44 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43075/tests/kraken/driver.html?testName=json-parse-financial) 14:25:44 INFO - PROCESS | 20427 | RSS: Main: 214867968 14:25:44 INFO - PROCESS | 20427 | 14:25:46 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43075/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:46 INFO - PROCESS | 20427 | RSS: Main: 203513856 14:25:46 INFO - PROCESS | 20427 | 14:25:48 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:49 INFO - PROCESS | 20427 | RSS: Main: 207003648 14:25:49 INFO - PROCESS | 20427 | 14:25:51 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:51 INFO - PROCESS | 20427 | RSS: Main: 215711744 14:25:51 INFO - PROCESS | 20427 | 14:25:54 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:55 INFO - PROCESS | 20427 | RSS: Main: 221036544 14:25:55 INFO - PROCESS | 20427 | 14:25:58 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:58 INFO - PROCESS | 20427 | RSS: Main: 217866240 14:25:58 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:43075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43075/tests/kraken/driver.html?testName=ai-astar) 14:26:00 INFO - PROCESS | 20427 | RSS: Main: 263880704 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | __start_tp_report 14:26:00 INFO - PROCESS | 20427 | _x_x_mozilla_page_load 14:26:00 INFO - PROCESS | 20427 | _x_x_mozilla_page_load_details 14:26:00 INFO - PROCESS | 20427 | |i|pagename|runs| 14:26:00 INFO - PROCESS | 20427 | |0;ai-astar;112;106;113;112;112;114;111;113;111;111 14:26:00 INFO - PROCESS | 20427 | |1;audio-beat-detection;154;130;152;203;128;151;151;127;198;126 14:26:00 INFO - PROCESS | 20427 | |2;audio-dft;160;162;160;162;159;160;161;161;160;161 14:26:00 INFO - PROCESS | 20427 | |3;audio-fft;85;75;78;128;75;74;76;74;135;75 14:26:00 INFO - PROCESS | 20427 | |4;audio-oscillator;91;93;120;92;92;91;130;91;91;127 14:26:00 INFO - PROCESS | 20427 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 14:26:00 INFO - PROCESS | 20427 | |6;imaging-darkroom;145;146;145;145;145;145;146;145;145;145 14:26:00 INFO - PROCESS | 20427 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 14:26:00 INFO - PROCESS | 20427 | |8;json-parse-financial;59;58;59;59;59;59;64;73;58;56 14:26:00 INFO - PROCESS | 20427 | |9;json-stringify-tinderbox;59;59;58;59;59;59;58;58;59;59 14:26:00 INFO - PROCESS | 20427 | |10;stanford-crypto-aes;82;81;78;78;78;80;76;86;79;79 14:26:00 INFO - PROCESS | 20427 | |11;stanford-crypto-ccm;124;124;128;129;132;124;130;127;218;135 14:26:00 INFO - PROCESS | 20427 | |12;stanford-crypto-pbkdf2;172;168;169;171;175;173;167;174;169;172 14:26:00 INFO - PROCESS | 20427 | |13;stanford-crypto-sha256-iterative;66;66;66;64;67;71;64;65;65;64 14:26:00 INFO - PROCESS | 20427 | __end_tp_report 14:26:00 INFO - PROCESS | 20427 | __start_cc_report 14:26:00 INFO - PROCESS | 20427 | _x_x_mozilla_cycle_collect,1612 14:26:00 INFO - PROCESS | 20427 | __end_cc_report 14:26:00 INFO - PROCESS | 20427 | __startTimestamp1462656360584__endTimestamp 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | ------- Summary: start ------- 14:26:00 INFO - PROCESS | 20427 | Number of tests: 14 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.17 (1.9%) stddev-sans-first:2.30 14:26:00 INFO - PROCESS | 20427 | Values: 112.0 106.0 113.0 112.0 112.0 114.0 111.0 113.0 111.0 111.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:151.50 stddev:28.06 (18.5%) stddev-sans-first:29.75 14:26:00 INFO - PROCESS | 20427 | Values: 154.0 130.0 152.0 203.0 128.0 151.0 151.0 127.0 198.0 126.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 14:26:00 INFO - PROCESS | 20427 | Values: 160.0 162.0 160.0 162.0 159.0 160.0 161.0 161.0 160.0 161.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#3] audio-fft Cycles:10 Average:87.50 Median:75.00 stddev:23.47 (31.3%) stddev-sans-first:24.88 14:26:00 INFO - PROCESS | 20427 | Values: 85.0 75.0 78.0 128.0 75.0 74.0 76.0 74.0 135.0 75.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:91.00 stddev:16.66 (18.3%) stddev-sans-first:17.20 14:26:00 INFO - PROCESS | 20427 | Values: 91.0 93.0 120.0 92.0 92.0 91.0 130.0 91.0 91.0 127.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 14:26:00 INFO - PROCESS | 20427 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:26:00 INFO - PROCESS | 20427 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:26:00 INFO - PROCESS | 20427 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:59.00 stddev:4.86 (8.2%) stddev-sans-first:5.13 14:26:00 INFO - PROCESS | 20427 | Values: 59.0 58.0 59.0 59.0 59.0 59.0 64.0 73.0 58.0 56.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:26:00 INFO - PROCESS | 20427 | Values: 59.0 59.0 58.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.79 (3.5%) stddev-sans-first:2.83 14:26:00 INFO - PROCESS | 20427 | Values: 82.0 81.0 78.0 78.0 78.0 80.0 76.0 86.0 79.0 79.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:129.50 stddev:28.66 (22.1%) stddev-sans-first:30.00 14:26:00 INFO - PROCESS | 20427 | Values: 124.0 124.0 128.0 129.0 132.0 124.0 130.0 127.0 218.0 135.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:172.00 stddev:2.67 (1.6%) stddev-sans-first:2.80 14:26:00 INFO - PROCESS | 20427 | Values: 172.0 168.0 169.0 171.0 175.0 173.0 167.0 174.0 169.0 172.0 14:26:00 INFO - PROCESS | 20427 | 14:26:00 INFO - PROCESS | 20427 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.10 (3.2%) stddev-sans-first:2.22 14:26:00 INFO - PROCESS | 20427 | Values: 66.0 66.0 66.0 64.0 67.0 71.0 64.0 65.0 65.0 64.0 14:26:00 INFO - PROCESS | 20427 | -------- Summary: end -------- 14:26:00 INFO - PROCESS | 20427 | 14:26:01 INFO - TEST-INFO | 20427: exit 0 14:26:01 INFO - TEST-OK | kraken | took 61164ms 14:26:01 INFO - SUITE-END | took 1173s 14:26:01 INFO - Completed test suite (00:19:33) 14:26:01 INFO - javascript benchmark 14:26:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.286474110953, 3130.1235654016878, 3156.068959656902, 3179.252875574241, 3207.1501052221165, 5229.137192363265, 5294.232336311233, 5307.416184219737, 5380.24676545284, 5429.5384892284155, 5309.203619457084, 5335.253064570963, 5344.4922732340365, 5415.891682166354, 5436.374816896058, 4809.110314591811, 4821.783019764119, 4940.876478088058, 4944.579710724574, 4986.675866068712, 4902.338184345103, 4919.655624106314, 4965.503449655042, 4969.031038947407, 4978.377702787152, 4779.307000484928, 4790.305405716186, 4795.592374648159, 4825.420949486049, 4875.780589873464, 4821.975890120562, 4831.758412079382, 4833.734144622044, 4838.540338667821, 4876.268559716035, 4805.831795887128, 4840.878978025577, 4879.682820616648, 4879.902401951941, 4900.58345040672, 5175.120229560984, 5197.220416937452, 5221.190715439113, 5229.607779416559, 5318.867028324323, 5636.718164091779, 5660.801871934504, 5694.345150307726, 5721.599488035839, 5722.54219662426, 5734.627249228828, 5754.6547207167705, 5800.941990580082, 5806.477417032445, 5819.039858423355, 5225.843224703265, 5353.598480113968, 5369.221462887859, 5380.515753582157, 5382.811601593926, 6001.339852616209, 6007.609505382224, 6018.879622407528, 6020.217371741645, 6031.60794548353, 5730.1404789281105, 5753.194552762617, 5765.56758243125, 5771.913421298684, 5774.422557744276, 5612.074007788669, 5642.774289028393, 5661.886762264731, 5683.744231509592, 5707.315122185364, 5645.322561292671, 5700.315962084576, 5710.371859095496, 5714.657120572779, 5715.685637289906, 5721.884232574691, 5727.284089488814, 5735.942640573624, 5737.88524229513, 5741.311042674905, 4321.503027151918, 4346.847860324873, 4353.042330687307, 4359.12817436514, 4428.114377124588, 3884.6698030667144, 3926.509186351706, 3934.055826601595, 3960.4257382679925, 3964.742291751027, 5479.808206712825, 5491.945080549223, 5492.752826122834, 5500.50495455411, 5501.0, 5657.490825825613, 5680.602357834912, 5707.029804933171, 5735.598508104393, 5750.827475175752, 5453.045716999509, 5453.23654688344, 5456.399796022434, 5461.9453805462235, 5468.234447177399, 4823.0, 4831.855044348676, 4833.32333473314, 4839.491853355347, 4878.0, 5803.187553742479, 5848.239728835224, 5915.792947246826, 5924.0, 5976.999999999913, 5757.251557297692, 5771.884562308815, 5773.595848290579, 5778.0, 5784.884302314014, 5769.278840144982, 5934.109883517507, 5942.821715348547, 5943.078822782476, 5945.346011938596, 5565.4991050804, 5568.6658800472105, 5602.215689803512, 5659.6321239119325, 5666.206731057573, 5728.942710573007, 5738.397468265772, 5741.425857414225, 5745.1382292656435, 5745.166950792195, 5450.127979523258, 5487.533559647315, 5552.69460179694, 5593.188987596857, 5599.0, 5517.834464966058, 5559.694216818114, 5573.554115670818, 5575.080111781673, 5627.8874422512135, 5458.590605704509, 5462.91805622908, 5464.2076898848645, 5468.398476167698, 5491.643043202179, 5392.5416339611575, 5562.471565201299, 5582.419544419767, 5625.09998400254, 5663.716814159358, 5538.390777014606, 5543.584231182596, 5546.805861794818, 5564.304461942257, 5589.944100558942], "value": 5279.3603439807575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.4735890339789, 642.559846505144, 646.9611823290603, 648.9805305840821, 654.7544670748467, 42719.57280427195, 44434.11131777366, 44530.0, 44531.332030019534, 47830.52169478313, 43992.12015759683, 44709.32936005954, 44756.55243447565, 44889.77555112228, 44896.3265551017, 8851.203391694746, 8955.641774329019, 9000.684976025808, 9006.099390060974, 9015.684451044215, 8795.164459376381, 8870.467771933705, 8896.06591307913, 8896.955515222415, 8903.599338029771, 8925.70577266296, 8945.881764779402, 8946.507942063185, 8991.865122023175, 8993.235574976135, 8868.556572171397, 8934.910650893473, 8941.687040953535, 8945.0607686193, 8947.105289471066, 8720.825583488358, 8796.164364385373, 8802.163794439519, 8814.911850881537, 8815.955920220422, 40818.18363632711, 41098.794506027276, 41233.793831030955, 41258.793706031574, 41259.1748165035, 3466.272082862602, 3650.34293827111, 3665.7617254878614, 3677.0, 4269.87190384289, 31320.686793132234, 32546.18634534132, 32555.67444325574, 32601.6739832601, 32845.0, 4243.596858298488, 4315.180115777992, 4376.649868010583, 4418.072204836988, 4473.2842745160615, 321373.0, 321567.0, 322529.0, 323091.0, 323908.0, 58744.41255587475, 59081.0, 59178.0, 59181.0, 59197.40802592005, 57112.71443642755, 62669.37330626635, 64148.0, 64200.0, 70843.64578177076, 13409.731805363837, 13584.456621735217, 13615.18308901469, 13654.180749155083, 13659.658508537168, 12456.875431245753, 12828.80756788649, 12837.48650054006, 12891.548795792101, 12894.355282236038, 17447.127643618023, 17705.557361066076, 17710.20304086319, 19229.519262018282, 19406.320778772675, 6351.96824015877, 7043.471739619549, 7354.0, 7485.176630570633, 7495.43784216175, 1035.4512108582464, 1080.956761729522, 1130.8869113088626, 1157.5543415784985, 1171.5313874450287, 31852.203694907348, 32190.0, 32593.348133037205, 32744.67255327464, 32925.50611740826, 1138.3568283919558, 1183.331417748969, 1223.6757259326287, 1234.9135560510858, 1242.2918936206277, 17279.222434990457, 17430.389936352167, 17510.387136450165, 17535.912320438318, 17780.3776867809, 461912.0, 465903.0, 465918.0, 466397.0, 468804.0, 57028.0, 57618.711906441036, 57687.42312576905, 57695.71152144212, 57756.0, 1375.8899288057132, 1380.9585712428643, 1400.8879289656802, 1419.6379923119746, 1420.0, 30145.69854301429, 31430.685693142776, 31595.21011974719, 31973.0, 32078.839605801822, 50258.0, 50802.23796642979, 50811.2378314333, 50846.237306439696, 50984.49015509798, 393003.0, 397014.0, 399017.0, 399134.0, 399948.0, 25135.371615709755, 27351.45297094007, 28132.156035318974, 28561.28596785097, 28568.428631427672, 42273.365899512144, 46553.3017004752, 46683.29975050445, 47471.76264118657, 47755.28367074427, 39909.80045099756, 40274.0, 40700.59299406968, 40771.38842917299, 41210.0, 39854.60145398509, 40298.0, 40588.391174133, 40702.59297407106, 41015.38476922789, 36745.265094697425, 37818.62181378151, 37819.62180378161, 38543.80728096342, 39218.607813921495, 34814.303713925074, 35360.646393536765, 36288.27423451569, 36325.636743632225, 36409.27181456409, 27560.0, 27785.166445006682, 27949.441011180068, 28219.15342539727, 28227.71772282251], "value": 19942.311843094423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.83531334496183, 398.298993770963, 399.30321588827496, 399.7841165770484, 419.90552125771706, 14146.858531414682, 17037.57406064849, 17109.82890171098, 18552.814471855276, 18559.164837582306, 15359.462418815343, 17010.0, 17473.03898285594, 18106.366277180303, 18440.907795461004, 5438.075527160392, 5636.408177141403, 5651.802186923438, 5675.404082571312, 5676.801311954083, 4029.6373326400617, 5593.496585307322, 5610.24261724666, 5866.88266234675, 6164.7534098636, 6086.908696369558, 6194.628322300654, 6217.533684973645, 6231.065340198984, 6234.594751341148, 6004.729787159588, 6130.938690613104, 6203.379662033805, 6207.379262073801, 6216.937830621681, 5306.257124002643, 5459.0, 5473.698946557938, 5483.917741233885, 5484.012877682016, 21023.0, 22302.553948921093, 22470.0, 22714.318570442912, 22717.091316347327, 2337.298810356886, 2439.4877075813924, 2450.0567281596536, 2680.664916885389, 2818.1263808219314, 10103.444310562916, 10999.670009899715, 13315.800262996063, 14178.14931104137, 14878.0, 1921.9615607687767, 1966.9311574094982, 1969.7439332886634, 1986.0, 2100.779418161086, 71410.64294678494, 76118.0, 85918.84486930742, 87401.25197496077, 90749.54625226898, 10885.891141088647, 10953.17851161166, 11184.328940263611, 11228.989390954854, 11373.94313028446, 15036.0, 15095.924520377328, 15222.695546089017, 15286.770698439532, 15583.766243506356, 7763.961180194063, 7909.881351779728, 8075.434719569574, 8097.757067287991, 8362.205590468895, 6639.601623902581, 7870.252326029018, 7954.482958607672, 7970.601469926481, 8036.959815200887, 4458.197524445631, 4520.95479045212, 4684.273937539687, 4790.808367665324, 4845.6123510119105, 1791.2924394863956, 1877.1177546553372, 1926.5472613935715, 1996.091778240897, 2016.25398602518, 900.504722402676, 1021.8160731068479, 1050.1808589300358, 1069.1446842526104, 1110.152458942809, 18496.560825401808, 18644.0, 19114.33099841499, 19202.0, 19537.120829562704, 1015.5937624950079, 1022.8158931392421, 1023.1098943918689, 1028.3572767020612, 1115.6653004098737, 10118.949405252926, 10443.738906527245, 10496.68509944703, 10509.2242100649, 10587.947060264649, 472482.0, 474907.0, 477758.0, 482159.0, 483787.0, 59620.0, 91891.54054229686, 91960.0, 93048.0, 93801.06198937923, 1092.5138313450439, 1103.564092183583, 1136.357957753883, 1142.3374442823142, 1167.9532818687157, 16312.67374652524, 16313.918430407772, 16526.75209871877, 16532.917335413247, 16557.254923528228, 36391.818040910686, 37370.626293736714, 37793.433098504094, 37920.241595168496, 42128.0, 51620.74189629178, 55026.0, 55687.72156139193, 55768.16347754706, 55772.44227557672, 8590.785230369042, 8932.642694292155, 8997.235235005099, 9010.684626038057, 9229.861552076858, 10424.635137770141, 12386.380680965736, 13073.934630326787, 13537.864621353661, 14116.929415352857, 11586.131040171853, 11819.468123934272, 11861.76276474483, 12210.6947326314, 12581.119321647397, 11991.700207494883, 11993.700157496132, 12009.159358845147, 12011.099167562643, 12407.31759753186, 12268.263904165779, 12384.62846114618, 12435.0, 12484.188527745668, 12552.309622970824, 8932.732018039469, 9051.411658242194, 9208.401453905475, 9216.617507373947, 9296.535173241446, 12057.216280941711, 12386.938065309616, 12510.0, 12631.93684031574, 12713.491460341853], "value": 9276.118703283582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.6054064051104, 1480.4152359817876, 1523.6190952261934, 1669.599296168919, 1814.0748218408607, 7705.614719264036, 8015.557199704051, 8034.437589368754, 8199.344052475803, 8200.91799082009, 7943.602819858998, 8114.837703245931, 8127.796805079876, 8131.308838748713, 8150.6332215050315, 1951.74627298451, 2066.813986741193, 2138.8395870309787, 2214.0368939511322, 2252.4706693926914, 2265.082641530183, 2271.659251112338, 2271.772822717723, 2272.7045484087043, 2276.9203077892275, 2203.922862699806, 2244.8204143668468, 2247.71903512061, 2249.6850440938283, 2250.909963601454, 1942.7571553555806, 2160.9891950540305, 2215.1360969222014, 2218.6561083032157, 2232.241038047072, 2179.2372669565525, 2189.5839790439763, 2197.7033100531544, 2201.3946164804647, 2219.7336319641586, 8040.959795200986, 8088.069871964682, 8091.554964476952, 8094.231048050426, 8104.1085480597085, 4824.107540105057, 4991.126552853236, 4998.925016124761, 5002.074616196015, 5003.899922001539, 3223.7904536205306, 3273.787203831743, 3337.5327454156436, 3364.629890712044, 3383.1880348716377, 1074.6399956014745, 1087.499750114948, 1091.6997825597944, 1120.7590368070903, 1123.1744667669257, 10848.186386021001, 10857.891421085767, 10860.619878304222, 10865.945670271598, 10869.782604347947, 4356.6950313477755, 4382.627476664519, 4463.375127482155, 4477.417935668407, 4503.932441013388, 9188.8621670675, 9193.218576420946, 9230.815383692288, 9234.953825230965, 9249.90750092504, 4558.065596552765, 4930.975345123252, 4974.701517908937, 4979.128652485801, 4980.800767969313, 4353.172897149595, 4442.977785111054, 4448.088141930896, 4467.754273514988, 4477.328400739915, 3688.1517251032415, 3736.906577335534, 3768.6231376862643, 3792.943105853414, 3827.234553089393, 1215.5016443258398, 1222.896053835416, 1238.4303220518661, 1238.8265642810013, 1243.8631750507436, 921.5300196899495, 1025.4821315235758, 1028.5937054863286, 1037.4294138223947, 1039.7452624107143, 5722.828315150552, 5741.425857414309, 5762.9135562966585, 5769.076947688433, 5967.433093856077, 450.9503954564995, 452.9864104076883, 454.90901819636207, 993.6621548673486, 1041.95832166714, 4137.81379837902, 4203.684723645678, 4203.726757760735, 4211.599898009684, 4217.1776503581505, 10022.398656080659, 10347.482625868826, 10484.213683973732, 10533.84199237012, 10546.525406356732, 10226.948865255627, 10255.384676919259, 10356.741081473023, 10422.843657345145, 10430.843537346946, 7256.709731610782, 7818.14000459949, 7901.249381308767, 7981.760547183594, 8010.599470026592, 5769.74036168365, 5822.73797679097, 5935.792247271324, 5942.1978032965, 5977.9402205977385, 8575.0, 9505.144536991704, 9585.233181345337, 9598.0, 9681.951590242004, 8827.735167944971, 8958.68644597436, 9039.23166530826, 9070.546472676471, 9143.679971200976, 6374.4263016326895, 6708.0, 6847.0, 7268.255618651591, 7438.44211684115, 7814.218578142368, 7851.489653172525, 7909.52542847431, 7925.128235894163, 7928.7621371358955, 6957.721691132298, 7196.568205907663, 7216.0, 7297.562146271241, 7355.190928997699, 6848.280930502425, 6884.965575172092, 6928.618925959121, 7081.716731330689, 7247.565146091251, 6412.35876412355, 6756.087928129639, 6771.966140169267, 6774.762883299061, 6784.151981002375, 4861.222204447272, 4877.365942427462, 4908.484609115992, 4935.827246046371, 5031.74841257943, 4877.6829506081995, 4976.427710813303, 5017.57350625201, 5023.723695196799, 5121.231815227746], "value": 4363.028686160695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.7391708384544, 341.49970293519993, 349.2212366422877, 350.59331175836036, 352.7583605230416, 5216.504432078951, 5248.21276808478, 5269.446708095652, 5278.469243919269, 5286.392064912531, 5183.585313174946, 5202.895942081156, 5214.530692237708, 5240.68555886647, 5261.97391508656, 3801.277757226132, 3909.667678247345, 3943.2310699413624, 3952.1107750756137, 4018.8995275118064, 4047.4738284023183, 4078.4086307485395, 4086.7522862425694, 4086.836526538935, 4113.5269444013875, 4068.776217308047, 4080.571539988303, 4082.5100987881497, 4102.897427564305, 4104.97947510262, 3892.2799282132896, 3998.1603863188766, 4072.3891416287497, 4094.508658960914, 4110.630043296118, 3642.8360723767228, 3645.3073915955883, 3662.377395842713, 3664.3221004114325, 3677.7793332400142, 5050.797968081272, 5067.657070876221, 5068.695878247317, 5070.31550740649, 5077.847664570068, 4727.290906364038, 4730.787114579852, 4739.099571081483, 4786.282057691339, 4789.640776941744, 5460.180972854064, 5483.670979741229, 5489.917651235235, 5490.423505531941, 5505.972470137664, 3860.768353898775, 3961.227560625679, 3974.3442332015184, 3983.6215559521797, 3985.7807820569856, 5431.646942948696, 5513.117901135799, 5602.411746766612, 5640.182173584807, 5661.122526008476, 4096.774677392772, 4100.65144462724, 4108.979455102765, 4110.301248787713, 4121.62905338515, 3887.5334959805004, 4092.4270602115726, 4108.548059713429, 4108.77401742907, 4161.625453709181, 4605.6085232755595, 4623.884402889955, 4629.305604159403, 4638.79125439356, 4647.604953578916, 5463.306375023755, 5473.562115030788, 5477.917831232455, 5527.143292789624, 5539.5014448699, 1358.843732970721, 1380.9585712428643, 1385.1758203868683, 1387.4450219911914, 1396.1692792788274, 949.9050094990446, 952.6189524190379, 958.6165533786402, 961.7355227312405, 966.3428868369576, 5229.607779416559, 5230.450802665665, 5232.581393488512, 5239.947600523946, 5244.842654720364, 5451.182322651554, 5459.39946605881, 5470.398256191816, 5473.9452605474235, 5496.367917689437, 5006.299118123466, 5181.523265869209, 5203.7918483261, 5222.164453687467, 5394.163904594794, 2859.0422208560367, 2912.7378535931443, 2928.604638373835, 2932.838693871815, 2958.2604348912773, 5653.547716182696, 5660.2075709400715, 5681.119426488901, 5690.5489100279165, 5696.287964004499, 5487.259220005249, 5600.886873670497, 5630.662160270397, 5643.435656434323, 5646.6612003279115, 5678.517326027334, 5701.800436984686, 5725.652482482245, 5736.5410767139365, 5803.332616749128, 5310.397905026586, 5412.675239485643, 5597.216389705526, 5603.581815092872, 5616.943830561642, 5491.615586908878, 5506.862328441821, 5508.512701570634, 5593.664380137205, 5610.438956104357, 5546.972265138648, 5757.222774925332, 5766.481016708516, 5780.364159942319, 5782.710864456844, 4009.5389030261895, 4043.6158564936286, 4051.0, 4058.8285267381807, 4069.4709687740406, 5600.35595906476, 5671.943280567141, 5678.3186017678145, 5692.430756924275, 5704.629199102211, 5209.6715337590185, 5482.424345443671, 5508.752106155152, 5519.2824932758485, 5523.944760552343, 5479.726013699379, 5487.725613719378, 5499.5325397340075, 5503.532199763065, 5517.448255174611, 5401.864953376197, 5409.891802164014, 5412.161115027177, 5413.40452550227, 5418.620696551204, 5286.0, 5471.398146203835, 5483.177523371526, 5502.422245664147, 5524.309461317335, 5360.571154307568, 5361.839144825662, 5374.785008599612, 5386.59600529954, 5418.701971391612], "value": 4179.050014499529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.4778107543643, 738.4092725819344, 751.1812124783985, 756.9205233450484, 784.4077721320403, 12707.936460317696, 13460.0, 13509.594712158627, 13515.189088654688, 13531.564318422692, 11271.211015228917, 11451.198416110876, 11524.71188220295, 11574.65276041718, 12097.092718046139, 686.0669489494284, 804.3846457460048, 807.168616325186, 827.1728271728272, 833.2334252487726, 821.6425854753202, 822.7284995951352, 823.1439303124773, 824.5918270456102, 825.4345773145415, 844.1558441558442, 852.7484392104344, 852.9530875801828, 853.1340689200466, 853.2576658307281, 720.8089856188114, 840.306746933779, 854.372036553133, 859.1623167411786, 860.8149247911698, 629.0878226571444, 629.8393909553081, 630.1996464490118, 630.3790766095392, 630.5586089737202, 12247.75504489914, 12258.81611775824, 12269.631911042594, 12272.631821045383, 12285.447154877962, 13022.283774392405, 13152.210867347894, 13329.533466328729, 13409.262490563015, 13622.386992585358, 11058.502367393487, 11093.445327733582, 11245.606403775828, 12195.024398048135, 12472.0, 4523.050159466516, 4528.411306530163, 4600.700954437984, 4618.49196588375, 4688.5545873142, 53318.46681533174, 53496.73251633756, 53965.730171349285, 54064.72967635176, 54249.45750542523, 9722.2708296878, 10250.231232657432, 10278.537465814057, 10571.0, 10664.413457259925, 17814.198361073784, 17952.19215135322, 17955.820441795415, 18124.909375453037, 18224.908875455538, 7845.960770196112, 7852.803679907934, 7867.6066196689935, 7906.327962123169, 7928.6828526859435, 4413.492448368414, 4444.6666500012625, 4464.419625448671, 4488.64090872736, 4711.717296962193, 3125.718685318332, 3211.213252753044, 3226.451503244454, 3226.4998925166637, 3226.596675415573, 520.6485622204997, 584.1354794903566, 586.4956137721556, 605.2736715940889, 623.4513628007325, 665.354606032148, 707.3386383731125, 708.8334241453255, 710.9324614161646, 717.727263639824, 8983.865242021375, 9066.36535442526, 9232.169104780602, 9260.397459537018, 9296.535173241311, 696.8571442854203, 707.6673963237271, 768.6676427525649, 780.4365287928607, 789.6249281591198, 4203.831846726097, 4554.203014472454, 4581.908361832745, 4616.30755386688, 4618.884527886829, 63542.36457635457, 65121.67439162774, 65154.67422662951, 65245.347546523924, 65637.34362656312, 57211.0, 57944.420555793906, 57998.42001580015, 58657.70671146617, 58771.0, 46666.0, 47698.5230147701, 47831.0, 50175.0, 52892.206616900774, 9262.44425334482, 9408.858867117136, 9422.764430889283, 9439.575219115019, 9473.715788526355, 30368.84815575908, 30433.0, 30990.69009309878, 32424.83787581047, 32732.50901236531, 37990.0, 41882.0, 41967.0, 42064.0, 42325.78837105918, 11913.638778154427, 12012.579559715718, 12018.278903265833, 12167.75664486723, 12373.0, 12886.48454061827, 12900.870991290343, 13138.343082846011, 13204.405801738752, 13352.132111412728, 11941.46263418131, 11998.880011199777, 12084.637460876187, 12264.080193985308, 12269.263844169378, 12188.878111219128, 12318.568850090203, 12323.50705971751, 12326.260424374566, 12389.380530973596, 12284.938575307066, 12341.81473820598, 12513.562025329069, 12776.169548979287, 12806.359682015676, 9971.950769107649, 10145.9492702536, 10256.38461692301, 10395.480225988822, 10619.575216991234, 10205.38767673942, 10765.677029689123, 10774.084202842847, 10820.296680715728, 10822.945885270523], "value": 6596.410992903791, "unit": "score"}], "name": "dromaeo_css", "value": 6998.2702349121155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 113.0, 112.0, 112.0, 114.0, 111.0, 113.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 152.0, 203.0, 128.0, 151.0, 151.0, 127.0, 198.0, 126.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 159.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 78.0, 128.0, 75.0, 74.0, 76.0, 74.0, 135.0, 75.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 120.0, 92.0, 92.0, 91.0, 130.0, 91.0, 91.0, 127.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 64.0, 73.0, 58.0, 56.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 78.0, 78.0, 78.0, 80.0, 76.0, 86.0, 79.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 128.0, 129.0, 132.0, 124.0, 130.0, 127.0, 218.0, 135.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 169.0, 171.0, 175.0, 173.0, 167.0, 174.0, 169.0, 172.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 67.0, 71.0, 64.0, 65.0, 65.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1543.2, "alertThreshold": 2.0}]} 14:26:01 INFO - Return code: 0 14:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:26:01 ERROR - # TBPL SUCCESS # 14:26:01 INFO - Running post-action listener: _resource_record_post_action 14:26:01 INFO - ##### 14:26:01 INFO - ##### Finished run-tests step (success) 14:26:01 INFO - ##### 14:26:01 INFO - Running post-run listener: _resource_record_post_run 14:26:02 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 548941824; Read time: 80; Write time: 586644 14:26:02 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 262361088; Read time: 0; Write time: 362364 14:26:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286580736; Read time: 80; Write time: 224280 14:26:02 INFO - Running post-run listener: _upload_blobber_files 14:26:02 INFO - Blob upload gear active. 14:26:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:02 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 14:26:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:26:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:26:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:04 INFO - (blobuploader) - INFO - Done attempting. 14:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:05 INFO - (blobuploader) - INFO - Done attempting. 14:26:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:05 INFO - Return code: 0 14:26:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a21f7bc6dc8af24b9d8ede679c944218824963354134d4a2f345abe010ff93a1e1a58f82f5dce9c6f8784e79567f4c5720bde7d408b90603f27ae54cf5ea7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e58f9cbf35af8e8dbe8df104dfb35ed89e2d552e4f5c0067103b9cfc569f4e6efd331d14d17a13c57c2c99a914dd8eb2fd4879725ec9285a083c5820842451e"} 14:26:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:05 INFO - Contents: 14:26:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a21f7bc6dc8af24b9d8ede679c944218824963354134d4a2f345abe010ff93a1e1a58f82f5dce9c6f8784e79567f4c5720bde7d408b90603f27ae54cf5ea7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e58f9cbf35af8e8dbe8df104dfb35ed89e2d552e4f5c0067103b9cfc569f4e6efd331d14d17a13c57c2c99a914dd8eb2fd4879725ec9285a083c5820842451e"} 14:26:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:05 INFO - Copying logs to upload dir... 14:26:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.377396 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-07 14:26:05.435584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 14:26:05.440045) ========= 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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 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/sha512/3a21f7bc6dc8af24b9d8ede679c944218824963354134d4a2f345abe010ff93a1e1a58f82f5dce9c6f8784e79567f4c5720bde7d408b90603f27ae54cf5ea7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e58f9cbf35af8e8dbe8df104dfb35ed89e2d552e4f5c0067103b9cfc569f4e6efd331d14d17a13c57c2c99a914dd8eb2fd4879725ec9285a083c5820842451e"} build_url:https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/a2cuN0bGTN2Y11EciwpCTQ/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/sha512/3a21f7bc6dc8af24b9d8ede679c944218824963354134d4a2f345abe010ff93a1e1a58f82f5dce9c6f8784e79567f4c5720bde7d408b90603f27ae54cf5ea7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e58f9cbf35af8e8dbe8df104dfb35ed89e2d552e4f5c0067103b9cfc569f4e6efd331d14d17a13c57c2c99a914dd8eb2fd4879725ec9285a083c5820842451e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 14:26:05.465601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:26:05.465986) ========= 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=32c5991c409366f7fec8a718000001d2-1462654278.843798-1065653789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 14:26:05.548185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 14:26:05.550117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 14:26:05.550455) ========= ========= Total master_lag: 0.26 =========