builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1462997398.69 results: success (0) buildid: 20160511053102 builduid: ff72412b3b114d808b5757e6473d93f4 revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.694054) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.694528) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.694803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.709153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.709475) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 13:09:58-- 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% 24.7M=0s 2016-05-11 13:09:58 (24.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.840775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.841084) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017862 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.891917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:58.892516) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 13:09:58,969 truncating revision to first 12 chars 2016-05-11 13:09:58,969 Setting DEBUG logging. 2016-05-11 13:09:58,969 attempt 1/10 2016-05-11 13:09:58,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cf323be5c58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 13:09:59,244 unpacking tar archive at: fx-team-8cf323be5c58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:59.464305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:59.464836) ========= script_repo_revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:59.465510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:59.465966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 13:09:59.477582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-11 13:09:59.478006) ========= /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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:59 INFO - MultiFileLogger online at 20160511 13:09:59 in /builds/slave/test 13:09:59 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 13:09:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:59 INFO - {'append_to_log': False, 13:09:59 INFO - 'base_work_dir': '/builds/slave/test', 13:09:59 INFO - 'blob_upload_branch': 'Fx-Team', 13:09:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:59 INFO - 'branch': 'Fx-Team', 13:09:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:59 INFO - 'config_files': ('talos/linux_config.py',), 13:09:59 INFO - 'default_actions': ('clobber', 13:09:59 INFO - 'read-buildbot-config', 13:09:59 INFO - 'download-and-extract', 13:09:59 INFO - 'populate-webroot', 13:09:59 INFO - 'create-virtualenv', 13:09:59 INFO - 'install', 13:09:59 INFO - 'run-tests'), 13:09:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:59 INFO - 'download_minidump_stackwalk': True, 13:09:59 INFO - 'download_symbols': 'ondemand', 13:09:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:59 INFO - 'installer_path': 'installer.exe', 13:09:59 INFO - 'log_level': 'info', 13:09:59 INFO - 'log_name': 'talos', 13:09:59 INFO - 'log_to_console': True, 13:09:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:59 INFO - 'opt_config_files': (), 13:09:59 INFO - 'pip_index': False, 13:09:59 INFO - 'sps_profile': False, 13:09:59 INFO - 'sps_profile_interval': 0, 13:09:59 INFO - 'suite': 'dromaeojs', 13:09:59 INFO - 'system_bits': '32', 13:09:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:59 INFO - 'title': 'talos-linux64-ix-030', 13:09:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:59 INFO - 'use_talos_json': True, 13:09:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:59 INFO - 'work_dir': 'build'} 13:09:59 INFO - ##### 13:09:59 INFO - ##### Running clobber step. 13:09:59 INFO - ##### 13:09:59 INFO - Running pre-action listener: _resource_record_pre_action 13:09:59 INFO - Running main action method: clobber 13:09:59 INFO - rmtree: /builds/slave/test/build 13:09:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:00 INFO - Running post-action listener: _resource_record_post_action 13:10:00 INFO - ##### 13:10:00 INFO - ##### Finished clobber step (success) 13:10:00 INFO - ##### 13:10:00 INFO - ##### 13:10:00 INFO - ##### Running read-buildbot-config step. 13:10:00 INFO - ##### 13:10:00 INFO - Running pre-action listener: _resource_record_pre_action 13:10:00 INFO - Running main action method: read_buildbot_config 13:10:00 INFO - Using buildbot properties: 13:10:00 INFO - { 13:10:00 INFO - "project": "", 13:10:00 INFO - "product": "firefox", 13:10:00 INFO - "script_repo_revision": "production", 13:10:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:10:00 INFO - "repository": "", 13:10:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:10:00 INFO - "buildid": "20160511053102", 13:10:00 INFO - "pgo_build": "True", 13:10:00 INFO - "basedir": "/builds/slave/test", 13:10:00 INFO - "buildnumber": 664, 13:10:00 INFO - "slavename": "talos-linux64-ix-030", 13:10:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:10:00 INFO - "platform": "ubuntu64_hw", 13:10:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:10:00 INFO - "branch": "fx-team", 13:10:00 INFO - "repo_path": "integration/fx-team", 13:10:00 INFO - "revision": "8cf323be5c58b28d8719401ebb0ef63f1d71d000", 13:10:00 INFO - "stage_platform": "linux64-pgo", 13:10:00 INFO - "builduid": "ff72412b3b114d808b5757e6473d93f4", 13:10:00 INFO - "slavebuilddir": "test" 13:10:00 INFO - } 13:10:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:10:00 INFO - Running post-action listener: _resource_record_post_action 13:10:00 INFO - ##### 13:10:00 INFO - ##### Finished read-buildbot-config step (success) 13:10:00 INFO - ##### 13:10:00 INFO - ##### 13:10:00 INFO - ##### Running download-and-extract step. 13:10:00 INFO - ##### 13:10:00 INFO - Running pre-action listener: _resource_record_pre_action 13:10:00 INFO - Running main action method: download_and_extract 13:10:00 INFO - mkdir: /builds/slave/test/build/tests 13:10: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')]} 13:10:00 INFO - https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:02 INFO - Downloaded 1361 bytes. 13:10:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:10:02 INFO - Using the following test package requirements: 13:10:02 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:10:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:10:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'jsshell-linux-x86_64.zip'], 13:10:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:10:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:10:02 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:10:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:10:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:10:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:10:02 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')]} 13:10:02 INFO - https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:04 INFO - Downloaded 23902241 bytes. 13:10:04 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'] 13:10:04 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 13:10:05 INFO - Return code: 0 13:10:05 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 13:10:05 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')]} 13:10:05 INFO - https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:06 INFO - Downloaded 23902241 bytes. 13:10:06 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'] 13:10:06 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 13:10:08 INFO - Return code: 0 13:10:08 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')]} 13:10:08 INFO - https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:09 INFO - Downloaded 10840152 bytes. 13:10:09 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'] 13:10:09 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 13:10:09 INFO - Return code: 0 13:10:09 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')]} 13:10:09 INFO - https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ja2kUphES8aukwqBa1x3DQ/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 13:10:11 INFO - Downloaded 58326547 bytes. 13:10:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:10:11 INFO - mkdir: /builds/slave/test/properties 13:10:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:10:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:10:11 INFO - Contents: 13:10:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:10:12 INFO - Running post-action listener: _resource_record_post_action 13:10:12 INFO - Running post-action listener: set_extra_try_arguments 13:10:12 INFO - ##### 13:10:12 INFO - ##### Finished download-and-extract step (success) 13:10:12 INFO - ##### 13:10:12 INFO - ##### 13:10:12 INFO - ##### Running populate-webroot step. 13:10:12 INFO - ##### 13:10:12 INFO - Running pre-action listener: _resource_record_pre_action 13:10:12 INFO - Running main action method: populate_webroot 13:10:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:10:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:10:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:10:12 INFO - '--tppagecycles', 13:10:12 INFO - '7'], 13:10:12 INFO - 'tests': ['tsvgm']}}, 13:10:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:10:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:10:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:10:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:10:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['damp', 'tps']}, 13:10:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'tests': ['damp', 'tps']}, 13:10:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['dromaeo_dom']}, 13:10:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:10:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'other-e10s': {'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['a11yr', 13:10:12 INFO - 'ts_paint', 13:10:12 INFO - 'tpaint', 13:10:12 INFO - 'sessionrestore', 13:10:12 INFO - 'sessionrestore_no_auto_restore', 13:10:12 INFO - 'tabpaint']}, 13:10:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['tsvgx', 13:10:12 INFO - 'tsvgr_opacity', 13:10:12 INFO - 'tart', 13:10:12 INFO - 'tscrollx', 13:10:12 INFO - 'cart']}, 13:10:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:10:12 INFO - 'tsvgr_opacity', 13:10:12 INFO - 'tart', 13:10:12 INFO - 'tscrollx', 13:10:12 INFO - 'cart']}, 13:10:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'talos_options': ['--disable-e10s'], 13:10:12 INFO - 'tests': ['tp5o']}, 13:10:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'tests': ['tp5o']}, 13:10:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'talos_options': ['--disable-e10s', 13:10:12 INFO - '--xperf_path', 13:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:12 INFO - 'tests': ['tp5n']}, 13:10:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:12 INFO - 'talos_options': ['--xperf_path', 13:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:12 INFO - 'tests': ['tp5n']}}, 13:10:12 INFO - 'talos.zip': {'path': '', 13:10:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:10:12 INFO - Running post-action listener: _resource_record_post_action 13:10:12 INFO - ##### 13:10:12 INFO - ##### Finished populate-webroot step (success) 13:10:12 INFO - ##### 13:10:12 INFO - ##### 13:10:12 INFO - ##### Running create-virtualenv step. 13:10:12 INFO - ##### 13:10:12 INFO - Running pre-action listener: _resource_record_pre_action 13:10:12 INFO - Running main action method: create_virtualenv 13:10:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:10:12 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 13:10:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:10:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:10:12 INFO - Using real prefix '/usr' 13:10:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:10:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:10:14 INFO - Installing pip.................done. 13:10:14 INFO - Return code: 0 13:10:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:10:14 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')]} 13:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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')]} 13:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:14 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 13:10:14 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 13:10:14 INFO - Using env: {'DISPLAY': ':0', 13:10:14 INFO - 'HOME': '/home/cltbld', 13:10:14 INFO - 'LANG': 'en_US.UTF-8', 13:10:14 INFO - 'LANGUAGE': 'en_US:en', 13:10:14 INFO - 'LOGNAME': 'cltbld', 13:10:14 INFO - 'MAIL': '/var/mail/cltbld', 13:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:14 INFO - 'MOZ_NO_REMOTE': '1', 13:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:14 INFO - 'NO_EM_RESTART': '1', 13:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:14 INFO - 'PWD': '/builds/slave/test', 13:10:14 INFO - 'SHELL': '/bin/bash', 13:10:14 INFO - 'SHLVL': '1', 13:10:14 INFO - 'TERM': 'linux', 13:10:14 INFO - 'TMOUT': '86400', 13:10:14 INFO - 'USER': 'cltbld', 13:10:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:14 INFO - '_': '/tools/buildbot/bin/python'} 13:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:14 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 13:10:14 INFO - Cleaning up... 13:10:14 INFO - Return code: 0 13:10:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:10:14 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')]} 13:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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')]} 13:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:14 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 13:10:14 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 13:10:14 INFO - Using env: {'DISPLAY': ':0', 13:10:14 INFO - 'HOME': '/home/cltbld', 13:10:14 INFO - 'LANG': 'en_US.UTF-8', 13:10:14 INFO - 'LANGUAGE': 'en_US:en', 13:10:14 INFO - 'LOGNAME': 'cltbld', 13:10:14 INFO - 'MAIL': '/var/mail/cltbld', 13:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:14 INFO - 'MOZ_NO_REMOTE': '1', 13:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:14 INFO - 'NO_EM_RESTART': '1', 13:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:14 INFO - 'PWD': '/builds/slave/test', 13:10:14 INFO - 'SHELL': '/bin/bash', 13:10:14 INFO - 'SHLVL': '1', 13:10:14 INFO - 'TERM': 'linux', 13:10:14 INFO - 'TMOUT': '86400', 13:10:14 INFO - 'USER': 'cltbld', 13:10:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:14 INFO - '_': '/tools/buildbot/bin/python'} 13:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:15 INFO - Downloading/unpacking psutil>=0.7.1 13:10:15 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 13:10:15 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 13:10:15 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 13:10:15 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 13:10:15 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 13:10:15 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 13:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:17 INFO - Installing collected packages: psutil 13:10:17 INFO - Running setup.py install for psutil 13:10:17 INFO - building 'psutil._psutil_linux' extension 13:10:17 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 13:10:17 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 13:10:17 INFO - building 'psutil._psutil_posix' extension 13:10:17 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 13:10:17 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 13:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:17 INFO - Successfully installed psutil 13:10:17 INFO - Cleaning up... 13:10:17 INFO - Return code: 0 13:10:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:10:17 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')]} 13:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:17 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')]} 13:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:17 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:17 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 13:10:17 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 13:10:17 INFO - Using env: {'DISPLAY': ':0', 13:10:17 INFO - 'HOME': '/home/cltbld', 13:10:17 INFO - 'LANG': 'en_US.UTF-8', 13:10:17 INFO - 'LANGUAGE': 'en_US:en', 13:10:17 INFO - 'LOGNAME': 'cltbld', 13:10:17 INFO - 'MAIL': '/var/mail/cltbld', 13:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:17 INFO - 'MOZ_NO_REMOTE': '1', 13:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:17 INFO - 'NO_EM_RESTART': '1', 13:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:17 INFO - 'PWD': '/builds/slave/test', 13:10:17 INFO - 'SHELL': '/bin/bash', 13:10:17 INFO - 'SHLVL': '1', 13:10:17 INFO - 'TERM': 'linux', 13:10:17 INFO - 'TMOUT': '86400', 13:10:17 INFO - 'USER': 'cltbld', 13:10:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:17 INFO - '_': '/tools/buildbot/bin/python'} 13:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:10:17 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 13:10:17 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 13:10:17 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 13:10:17 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 13:10:17 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 13:10:17 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 13:10:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:10:19 INFO - Installing collected packages: mozsystemmonitor 13:10:19 INFO - Running setup.py install for mozsystemmonitor 13:10:19 INFO - Successfully installed mozsystemmonitor 13:10:19 INFO - Cleaning up... 13:10:19 INFO - Return code: 0 13:10:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:10:19 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')]} 13:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:19 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')]} 13:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:19 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:19 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 13:10:19 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 13:10:19 INFO - Using env: {'DISPLAY': ':0', 13:10:19 INFO - 'HOME': '/home/cltbld', 13:10:19 INFO - 'LANG': 'en_US.UTF-8', 13:10:19 INFO - 'LANGUAGE': 'en_US:en', 13:10:19 INFO - 'LOGNAME': 'cltbld', 13:10:19 INFO - 'MAIL': '/var/mail/cltbld', 13:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:19 INFO - 'MOZ_NO_REMOTE': '1', 13:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:19 INFO - 'NO_EM_RESTART': '1', 13:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:19 INFO - 'PWD': '/builds/slave/test', 13:10:19 INFO - 'SHELL': '/bin/bash', 13:10:19 INFO - 'SHLVL': '1', 13:10:19 INFO - 'TERM': 'linux', 13:10:19 INFO - 'TMOUT': '86400', 13:10:19 INFO - 'USER': 'cltbld', 13:10:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:19 INFO - '_': '/tools/buildbot/bin/python'} 13:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:10:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 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 13:10:22 INFO - Downloading docopt-0.6.1.tar.gz 13:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:10:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:10:22 INFO - Running setup.py install for blobuploader 13:10:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:10:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:10:22 INFO - Running setup.py install for requests 13:10:23 INFO - Running setup.py install for docopt 13:10:23 INFO - Successfully installed blobuploader requests docopt 13:10:23 INFO - Cleaning up... 13:10:23 INFO - Return code: 0 13:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:23 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')]} 13:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:23 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')]} 13:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:23 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:23 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 13:10:23 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 13:10:23 INFO - Using env: {'DISPLAY': ':0', 13:10:23 INFO - 'HOME': '/home/cltbld', 13:10:23 INFO - 'LANG': 'en_US.UTF-8', 13:10:23 INFO - 'LANGUAGE': 'en_US:en', 13:10:23 INFO - 'LOGNAME': 'cltbld', 13:10:23 INFO - 'MAIL': '/var/mail/cltbld', 13:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:23 INFO - 'MOZ_NO_REMOTE': '1', 13:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:23 INFO - 'NO_EM_RESTART': '1', 13:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:23 INFO - 'PWD': '/builds/slave/test', 13:10:23 INFO - 'SHELL': '/bin/bash', 13:10:23 INFO - 'SHLVL': '1', 13:10:23 INFO - 'TERM': 'linux', 13:10:23 INFO - 'TMOUT': '86400', 13:10:23 INFO - 'USER': 'cltbld', 13:10:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:23 INFO - '_': '/tools/buildbot/bin/python'} 13:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:23 INFO - Running setup.py (path:/tmp/pip-LbuNZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:23 INFO - Running setup.py (path:/tmp/pip-TClrQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:23 INFO - Running setup.py (path:/tmp/pip-Gi5OQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:23 INFO - Running setup.py (path:/tmp/pip-uvRYn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:23 INFO - Running setup.py (path:/tmp/pip-dWZz1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:23 INFO - Running setup.py (path:/tmp/pip-VGYf3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:23 INFO - Running setup.py (path:/tmp/pip-bdH0rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:24 INFO - Running setup.py (path:/tmp/pip-4qfqZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:24 INFO - Running setup.py (path:/tmp/pip-D70fxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:24 INFO - Running setup.py (path:/tmp/pip-LWor0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:24 INFO - Running setup.py (path:/tmp/pip-ljd3wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:24 INFO - Running setup.py (path:/tmp/pip-TAEDbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:24 INFO - Running setup.py (path:/tmp/pip-2o2uLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:24 INFO - Running setup.py (path:/tmp/pip-2ZP3uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:24 INFO - Running setup.py (path:/tmp/pip-aH8YaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:24 INFO - Running setup.py (path:/tmp/pip-zGHzg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:24 INFO - Running setup.py (path:/tmp/pip-p0XWw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:24 INFO - Running setup.py install for manifestparser 13:10:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:10:24 INFO - Running setup.py install for mozcrash 13:10:24 INFO - Running setup.py install for mozdebug 13:10:25 INFO - Running setup.py install for mozdevice 13:10:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for mozfile 13:10:25 INFO - Running setup.py install for mozhttpd 13:10:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for mozinfo 13:10:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for mozInstall 13:10:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for mozleak 13:10:25 INFO - Running setup.py install for mozlog 13:10:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for moznetwork 13:10:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:10:25 INFO - Running setup.py install for mozprocess 13:10:25 INFO - Running setup.py install for mozprofile 13:10:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:10:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:10:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:10:26 INFO - Running setup.py install for mozrunner 13:10:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:10:26 INFO - Running setup.py install for mozscreenshot 13:10:26 INFO - Running setup.py install for moztest 13:10:26 INFO - Running setup.py install for mozversion 13:10:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:10:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:26 INFO - Cleaning up... 13:10:26 INFO - Return code: 0 13:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10: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')]} 13:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10: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')]} 13:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:26 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:26 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 13:10:26 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 13:10:26 INFO - Using env: {'DISPLAY': ':0', 13:10:26 INFO - 'HOME': '/home/cltbld', 13:10:26 INFO - 'LANG': 'en_US.UTF-8', 13:10:26 INFO - 'LANGUAGE': 'en_US:en', 13:10:26 INFO - 'LOGNAME': 'cltbld', 13:10:26 INFO - 'MAIL': '/var/mail/cltbld', 13:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:26 INFO - 'MOZ_NO_REMOTE': '1', 13:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:26 INFO - 'NO_EM_RESTART': '1', 13:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:26 INFO - 'PWD': '/builds/slave/test', 13:10:26 INFO - 'SHELL': '/bin/bash', 13:10:26 INFO - 'SHLVL': '1', 13:10:26 INFO - 'TERM': 'linux', 13:10:26 INFO - 'TMOUT': '86400', 13:10:26 INFO - 'USER': 'cltbld', 13:10:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:26 INFO - '_': '/tools/buildbot/bin/python'} 13:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:26 INFO - Running setup.py (path:/tmp/pip-0SPdQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:26 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)) 13:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:26 INFO - Running setup.py (path:/tmp/pip-Hi7JIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:26 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)) 13:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:26 INFO - Running setup.py (path:/tmp/pip-Sn5pjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:26 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)) 13:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:26 INFO - Running setup.py (path:/tmp/pip-mSsxQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:27 INFO - Running setup.py (path:/tmp/pip-vzigXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:27 INFO - Running setup.py (path:/tmp/pip-_UqMS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:27 INFO - Running setup.py (path:/tmp/pip-PXvV9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:27 INFO - Running setup.py (path:/tmp/pip-v_XbC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:27 INFO - Running setup.py (path:/tmp/pip-S4IgOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:27 INFO - Running setup.py (path:/tmp/pip-ENxh1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:27 INFO - Running setup.py (path:/tmp/pip-OKsMHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:27 INFO - Running setup.py (path:/tmp/pip-EIEPja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:27 INFO - Running setup.py (path:/tmp/pip-isrksZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:27 INFO - Running setup.py (path:/tmp/pip-mbsyaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:27 INFO - Running setup.py (path:/tmp/pip-lPa9R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:27 INFO - Running setup.py (path:/tmp/pip-klZloI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:27 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)) 13:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:27 INFO - Running setup.py (path:/tmp/pip-b5zZ4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:27 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)) 13:10:27 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)) 13:10:27 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)) 13:10:27 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)) 13:10:27 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)) 13:10:27 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)) 13:10:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:29 INFO - Downloading blessings-1.6.tar.gz 13:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:29 INFO - Installing collected packages: blessings 13:10:29 INFO - Running setup.py install for blessings 13:10:30 INFO - Successfully installed blessings 13:10:30 INFO - Cleaning up... 13:10:30 INFO - Return code: 0 13:10:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:30 INFO - Reading from file tmpfile_stdout 13:10:30 INFO - Current package versions: 13:10:30 INFO - argparse == 1.2.1 13:10:30 INFO - blessings == 1.6 13:10:30 INFO - blobuploader == 1.2.4 13:10:30 INFO - docopt == 0.6.1 13:10:30 INFO - manifestparser == 1.1 13:10:30 INFO - mozInstall == 1.12 13:10:30 INFO - mozcrash == 0.17 13:10:30 INFO - mozdebug == 0.1 13:10:30 INFO - mozdevice == 0.48 13:10:30 INFO - mozfile == 1.2 13:10:30 INFO - mozhttpd == 0.7 13:10:30 INFO - mozinfo == 0.9 13:10:30 INFO - mozleak == 0.1 13:10:30 INFO - mozlog == 3.1 13:10:30 INFO - moznetwork == 0.27 13:10:30 INFO - mozprocess == 0.22 13:10:30 INFO - mozprofile == 0.28 13:10:30 INFO - mozrunner == 6.11 13:10:30 INFO - mozscreenshot == 0.1 13:10:30 INFO - mozsystemmonitor == 0.0 13:10:30 INFO - moztest == 0.7 13:10:30 INFO - mozversion == 1.4 13:10:30 INFO - psutil == 3.1.1 13:10:30 INFO - requests == 1.2.3 13:10:30 INFO - wsgiref == 0.1.2 13:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:30 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')]} 13:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 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')]} 13:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:30 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 13:10:30 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 13:10:30 INFO - Using env: {'DISPLAY': ':0', 13:10:30 INFO - 'HOME': '/home/cltbld', 13:10:30 INFO - 'LANG': 'en_US.UTF-8', 13:10:30 INFO - 'LANGUAGE': 'en_US:en', 13:10:30 INFO - 'LOGNAME': 'cltbld', 13:10:30 INFO - 'MAIL': '/var/mail/cltbld', 13:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:30 INFO - 'MOZ_NO_REMOTE': '1', 13:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:30 INFO - 'NO_EM_RESTART': '1', 13:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:30 INFO - 'PWD': '/builds/slave/test', 13:10:30 INFO - 'SHELL': '/bin/bash', 13:10:30 INFO - 'SHLVL': '1', 13:10:30 INFO - 'TERM': 'linux', 13:10:30 INFO - 'TMOUT': '86400', 13:10:30 INFO - 'USER': 'cltbld', 13:10:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:30 INFO - '_': '/tools/buildbot/bin/python'} 13:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 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)) 13:10:30 INFO - Cleaning up... 13:10:30 INFO - Return code: 0 13:10:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:30 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')]} 13:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 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')]} 13:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:30 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 13:10:30 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 13:10:30 INFO - Using env: {'DISPLAY': ':0', 13:10:30 INFO - 'HOME': '/home/cltbld', 13:10:30 INFO - 'LANG': 'en_US.UTF-8', 13:10:30 INFO - 'LANGUAGE': 'en_US:en', 13:10:30 INFO - 'LOGNAME': 'cltbld', 13:10:30 INFO - 'MAIL': '/var/mail/cltbld', 13:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:30 INFO - 'MOZ_NO_REMOTE': '1', 13:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:30 INFO - 'NO_EM_RESTART': '1', 13:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:30 INFO - 'PWD': '/builds/slave/test', 13:10:30 INFO - 'SHELL': '/bin/bash', 13:10:30 INFO - 'SHLVL': '1', 13:10:30 INFO - 'TERM': 'linux', 13:10:30 INFO - 'TMOUT': '86400', 13:10:30 INFO - 'USER': 'cltbld', 13:10:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:30 INFO - '_': '/tools/buildbot/bin/python'} 13:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:30 INFO - Downloading/unpacking jsonschema 13:10:30 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 13:10:30 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 13:10:30 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 13:10:30 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 13:10:30 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 13:10:30 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 13:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:10:32 INFO - Downloading/unpacking functools32 (from jsonschema) 13:10:32 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 13:10:32 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 13:10:32 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 13:10:32 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 13:10:32 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 13:10:32 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 13:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:10:32 INFO - warning: no files found matching '*.txt' 13:10:32 INFO - no previously-included directories found matching 'build' 13:10:32 INFO - no previously-included directories found matching 'dist' 13:10:32 INFO - no previously-included directories found matching '.git*' 13:10:32 INFO - Installing collected packages: jsonschema, functools32 13:10:32 INFO - Running setup.py install for functools32 13:10:32 INFO - warning: no files found matching '*.txt' 13:10:32 INFO - no previously-included directories found matching 'build' 13:10:32 INFO - no previously-included directories found matching 'dist' 13:10:32 INFO - no previously-included directories found matching '.git*' 13:10:33 INFO - Successfully installed jsonschema functools32 13:10:33 INFO - Cleaning up... 13:10:33 INFO - Return code: 0 13:10:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:10:33 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')]} 13:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:33 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')]} 13:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:33 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 0x7f0f1bd1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', '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 13:10:33 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 13:10:33 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 13:10:33 INFO - Using env: {'DISPLAY': ':0', 13:10:33 INFO - 'HOME': '/home/cltbld', 13:10:33 INFO - 'LANG': 'en_US.UTF-8', 13:10:33 INFO - 'LANGUAGE': 'en_US:en', 13:10:33 INFO - 'LOGNAME': 'cltbld', 13:10:33 INFO - 'MAIL': '/var/mail/cltbld', 13:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:33 INFO - 'MOZ_NO_REMOTE': '1', 13:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:33 INFO - 'NO_EM_RESTART': '1', 13:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:33 INFO - 'PWD': '/builds/slave/test', 13:10:33 INFO - 'SHELL': '/bin/bash', 13:10:33 INFO - 'SHLVL': '1', 13:10:33 INFO - 'TERM': 'linux', 13:10:33 INFO - 'TMOUT': '86400', 13:10:33 INFO - 'USER': 'cltbld', 13:10:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:33 INFO - '_': '/tools/buildbot/bin/python'} 13:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:33 INFO - Downloading/unpacking flake8 13:10:33 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 13:10:33 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 13:10:33 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 13:10:33 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 13:10:33 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 13:10:33 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 13:10:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:10:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:10:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 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 13:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:35 INFO - no previously-included directories found matching 'docs/_build' 13:10:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:10:35 INFO - Running setup.py install for pep8 13:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:35 INFO - no previously-included directories found matching 'docs/_build' 13:10:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:10:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:10:36 INFO - Cleaning up... 13:10:36 INFO - Return code: 0 13:10:36 INFO - Running post-action listener: _resource_record_post_action 13:10:36 INFO - Running post-action listener: _start_resource_monitoring 13:10:36 INFO - Starting resource monitoring. 13:10:36 INFO - ##### 13:10:36 INFO - ##### Finished create-virtualenv step (success) 13:10:36 INFO - ##### 13:10:36 INFO - ##### 13:10:36 INFO - ##### Running install step. 13:10:36 INFO - ##### 13:10:36 INFO - Running pre-action listener: _resource_record_pre_action 13:10:36 INFO - Running main action method: install 13:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:36 INFO - Reading from file tmpfile_stdout 13:10:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:36 INFO - Reading from file tmpfile_stdout 13:10:36 INFO - Output received: 13:10:36 INFO - Usage: mozinstall [options] installer 13:10:36 INFO - Options: 13:10:36 INFO - -h, --help show this help message and exit 13:10:36 INFO - -d DEST, --destination=DEST 13:10:36 INFO - Directory to install application into. [default: 13:10:36 INFO - "/builds/slave/test"] 13:10:36 INFO - --app=APP Application being installed. [default: firefox] 13:10:36 INFO - mkdir: /builds/slave/test/build/application 13:10:36 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'] 13:10:36 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 13:10:52 INFO - Reading from file tmpfile_stdout 13:10:52 INFO - Output received: 13:10:52 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:52 INFO - Running post-action listener: _resource_record_post_action 13:10:52 INFO - ##### 13:10:52 INFO - ##### Finished install step (success) 13:10:52 INFO - ##### 13:10:52 INFO - ##### 13:10:52 INFO - ##### Running run-tests step. 13:10:52 INFO - ##### 13:10:52 INFO - Running pre-action listener: _resource_record_pre_action 13:10:52 INFO - Running main action method: run_tests 13:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:52 INFO - Python 2.7.3 13:10:52 INFO - Return code: 0 13:10:52 INFO - grabbing minidump binary from tooltool 13:10:52 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')]} 13:10:52 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227e9c0>, '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 0x227f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:52 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 13:10:52 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 13:10:52 INFO - Calling ['/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'] with output_timeout 600 13:10:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:53 INFO - Return code: 0 13:10:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:10:53 INFO - Return code: 0 13:10:53 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/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 13:10:53 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/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 13:10:53 INFO - Using env: {'DISPLAY': ':0', 13:10:53 INFO - 'HOME': '/home/cltbld', 13:10:53 INFO - 'LANG': 'en_US.UTF-8', 13:10:53 INFO - 'LANGUAGE': 'en_US:en', 13:10:53 INFO - 'LOGNAME': 'cltbld', 13:10:53 INFO - 'MAIL': '/var/mail/cltbld', 13:10:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:53 INFO - 'MOZ_NO_REMOTE': '1', 13:10:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:53 INFO - 'NO_EM_RESTART': '1', 13:10:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:53 INFO - 'PWD': '/builds/slave/test', 13:10:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:53 INFO - 'SHELL': '/bin/bash', 13:10:53 INFO - 'SHLVL': '1', 13:10:53 INFO - 'TERM': 'linux', 13:10:53 INFO - 'TMOUT': '86400', 13:10:53 INFO - 'USER': 'cltbld', 13:10:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643', 13:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:53 INFO - '_': '/tools/buildbot/bin/python'} 13:10:53 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/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 13:10:54 INFO - mozversion application_buildid: 20160511053102 13:10:54 INFO - mozversion application_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 13:10:54 INFO - mozversion application_display_name: Nightly 13:10:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:54 INFO - mozversion application_name: Firefox 13:10:54 INFO - mozversion application_remotingname: firefox 13:10:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:10:54 INFO - mozversion application_vendor: Mozilla 13:10:54 INFO - mozversion application_version: 49.0a1 13:10:54 INFO - mozversion platform_buildid: 20160511053102 13:10:54 INFO - mozversion platform_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 13:10:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:10:54 INFO - mozversion platform_version: 49.0a1 13:10:54 INFO - using testdate: 1462997454 13:10:54 INFO - actual date: 1462997454 13:10:54 INFO - starting webserver on 'localhost:33293' 13:10:54 INFO - SUITE-START | Running 2 tests 13:10:54 INFO - TEST-START | dromaeo_css 13:10:54 INFO - operating with platform_type : linux_ 13:10:54 INFO - Initialising browser for dromaeo_css test... 13:10:54 INFO - TEST-INFO | started process 19352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyI237P/profile http://localhost:33293/getInfo.html) 13:10:58 INFO - PROCESS | 19352 | __metrics Screen width/height:1600/1200 13:10:58 INFO - PROCESS | 19352 | colorDepth:24 13:10:58 INFO - PROCESS | 19352 | Browser inner width/height: 1024/697 13:10:58 INFO - PROCESS | 19352 | __metrics 13:10:59 ERROR - PROCESS | 19352 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:11:00 INFO - TEST-INFO | 19352: exit 0 13:11:00 INFO - Browser initialized. 13:11:00 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:00 INFO - TEST-INFO | started process 19436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyI237P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:12 INFO - PROCESS | 19436 | RSS: Main: 151900160 13:11:12 INFO - PROCESS | 19436 | 13:12:03 INFO - PROCESS | 19436 | 1462997523513 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] 13:14:11 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33293/tests/dromaeo/cssquery-ext.html) 13:14:12 INFO - PROCESS | 19436 | RSS: Main: 261390336 13:14:12 INFO - PROCESS | 19436 | 13:17:14 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-ext.html (next: http://localhost:33293/tests/dromaeo/cssquery-jquery.html) 13:17:15 INFO - PROCESS | 19436 | RSS: Main: 242999296 13:17:15 INFO - PROCESS | 19436 | 13:20:17 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33293/tests/dromaeo/cssquery-mootools.html) 13:20:17 INFO - PROCESS | 19436 | RSS: Main: 234471424 13:20:17 INFO - PROCESS | 19436 | 13:23:19 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33293/tests/dromaeo/cssquery-prototype.html) 13:23:20 INFO - PROCESS | 19436 | RSS: Main: 230277120 13:23:20 INFO - PROCESS | 19436 | 13:26:23 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33293/tests/dromaeo/cssquery-yui.html) 13:26:23 INFO - PROCESS | 19436 | RSS: Main: 222560256 13:26:23 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | Cycle 1(1): loaded http://localhost:33293/tests/dromaeo/cssquery-yui.html (next: http://localhost:33293/tests/dromaeo/cssquery-dojo.html) 13:29:26 INFO - PROCESS | 19436 | RSS: Main: 270602240 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | __start_tp_report 13:29:26 INFO - PROCESS | 19436 | _x_x_mozilla_page_load 13:29:26 INFO - PROCESS | 19436 | _x_x_mozilla_page_load_details 13:29:26 INFO - PROCESS | 19436 | |i|pagename|runs| 13:29:26 INFO - PROCESS | 19436 | |0;dojo.html;3230.0309907027886;3230.9192270193244;3255.1699316674253;3274.950875736863;3280.360329735701;5441.59188060895;5471.480209380113;5533.170024496318;5580.637258578195;5616.831495055145;5467.316585426822;5516.806911758089;5525.226468294432;5527.060399732045;5530.05988981873;4953.529414705597;5051.242313652945;5057.0897238497055;5062.26597143414;5239.816606418776;5100.872478188038;5112.667676601009;5147.588192944574;5169.172932330828;5170.508801663836;4904.386951631046;4960.255961605788;4995.650304478688;4996.075725990703;5055.31753213317;4966.230234313687;4970.701757894538;5032.396112466491;5038.042771873333;5065.392152941634;4973.1297023020825;4990.051890140861;5016.398032236155;5029.723365214912;5048.116579598593;5346.679199248018;5350.866228344284;5409.486098820645;5428.348598168245;5458.727063646841;5881.617694849821;5896.498797602209;5898.498627616657;5944.464998150187;5957.940420595782;5885.176075349455;5901.468867801876;5906.645601263895;6000.33996260411;6048;5596.104623260299;5598.44015598441;5614.859628509238;5615.354234263031;5617.80337688183;6090.363537171995;6096.021318109847;6097.633605971558;6100.426550924247;6102.1839709467895;5653.943460565424;5780.94219057804;5799.739011744482;5826.912596311059;5914.290285165722;5946.851328716817;5950.761969521257;5950.791722289786;5952.494038006731;5956.195913551702;5938.376470470625;5947.226860508106;5949.0481522956115;5950.107483877367;5951.1073338999495;5760.596758226968;5855.238818953509;5891.646501209942;5926.67403292823;6011.549133814981;4454.821807127679;4484.304932735431;4487.371767952489;4491.124230775033;4528.682992190515;3958.1094253792667;3977.463042489227;4007.919841603152;4034.3948407739076;4059.4519739835337;5570.777168913279;5612.579056570774;5618.438156184349;5621.831345059655;5655.4344565543115;5965;5980.8803823924145;5984.222051133412;5989.101634754735;5993.340732519419;5487.6158668893595;5535.308086489189;5566.805161819398;5573.972130139324;5578.24693666358;5041.193409054534;5080.415752188472;5083.517065878736;5084.898302033938;5126.307948426989;6118.20463339763;6139.815805525842;6141.447269745744;6143.447089761943;6146.354632763585;5870.47165755067;5871.794487192928;5916.230889984275;5969.8806023878415;5977.910331344946;6104.9139292562195;6109.890546867989;6129.267100814889;6129.358790882775;6134.008014331881;5792.913106303325;5847.532197424111;5848.678322692293;5851.034579294539;5880.206172166702;5848.122781582797;5882.94117058841;5903.439173278532;5911.7635294587735;5939.2575928009;5727.398623144676;5785.247917770663;5791;5792;5797.2173756542325;5773.04744717117;5777.942220577908;5781.190633311256;5794.797182098607;5803.709814509342;5574.052411090205;5630.60585758993;5653.236813030353;5678.574106942078;5700.116481945305;5819.447152520504;5846.6784326862435;5893.823185304448;5908.3796201399955;5908.7045647718305;5569.498745112959;5685.118806584986;5687.374388817309;5697.886042279214;5698 13:29:26 INFO - PROCESS | 19436 | |1;ext.html;628.990565141523;659.858130501942;668.2482207516541;669.1769123977507;678.8879834827254;44471.555284447146;45845.770771146184;45914.770426147865;45948.310775338396;49577.752111239395;46670;46722.76638616811;47077.76461117698;47110.528894711046;47320.52679473204;8902.73291801247;9030.909690903105;9036.051214622468;9039.141281578273;9042.773930651754;8813.38306318558;8888.111188881125;8906;8909.331800114986;8911.77720556988;8890.644374225023;8938.4190027648;8942.284617230605;8943.060978597252;8943.552822358888;8909.509976951265;8948.597313120925;8948.73153805387;8955.462672239653;8962.551872406353;8884.244839188677;8932.240759535447;8952.552372381355;8956.507392093432;8956.910430895672;42472.575274247174;42863.78568107139;42865.57134428647;43029.784851075856;43045.56954430447;3417.2652879631;3478.286951175003;3491;3547.9290414191573;3586.246888153491;32436.513452298233;32705;33266.66733332684;33366.16584585405;33626.32747345064;4123.175364926997;4186.96537070118;4187.309093999486;4197.328427451593;4267.8079486423185;327243;327552;327768;328021;328422;53584.732076339365;59314.70342648345;59948;60237.39762602405;60313.39686603165;63513.36486635167;64814.35185648083;64985;70286.64856675683;70464.29535704578;16146.596335091717;16309.102999335151;16314.265858036417;16347.427840025779;16379.672406551803;11320.37737924422;12018.879811201776;12137.089718271165;12274.815877761841;12303.261804291771;17721.556961076076;18224.271029158685;18278.725819112726;18365.173567189508;18405.907970460063;6127.234095738033;6191.938080619227;6267.293925950887;6274.309825919146;6329.525285603599;1008.8890222075565;1081.124289325633;1084.5499117865998;1160.2980196980873;1250;33436;33472.49791253133;33566.83216583901;33694.3261134776;33753.662463375054;1093.9507722152523;1102.3606308341143;1163.8894305041008;1217.4886547650008;1236.6908272931767;17512.38706645261;17572.13593970625;17583.384581539583;17701;17866;447977;451867;452320;452659;452906;59664.40335596675;59859;59903.40096599065;59904.70047649821;59943.400565994656;1317.9934100329629;1381.896357773171;1418.8510206428382;1420.5809286260578;1432.8137342145662;33313.333733325686;34058.82970585131;34342.48486272758;34467.13832154216;34701.13247168841;51358.48641513537;51873.740631296605;52017.21974170315;52035.2194717072;52058.739706301225;292763;298872;299206;299603;299839;28336.149915502567;37052.25895482129;41286;41839.7908010458;42810.785946071315;45310.32034519419;45549.31676024928;49302.26046609376;49317.75341123271;49795.751021244665;40642.1871562573;40878;42209;42599.361009585504;42876.142477150905;39798.403023955245;42471.57528424676;42797.35803962881;43469.34795978126;44019.33970990374;42149.789251053546;42611.3608295882;43327.78336108299;43523;43613;36614.8169259152;37452;37580.624193757714;37849;38174.80912595419;28698;28776.712232877402;28838.134855954355;28918.277043074093;28928.855355723088 13:29:26 INFO - PROCESS | 19436 | |2;jquery.html;406.63606072565034;413.925493411186;414.8713898691408;418.372441337993;428.3916838089912;14252.501162459315;17935.910320448394;19417.902910485445;19434.70847937282;19978.20087196514;13042.347882605856;17384;17454;18194.45416637503;19020.2391904324;5545.445455454453;5696.401877802833;5738.512226460756;5740.56945729072;5749.683767392792;5586.273784408021;5654.971725141369;5667.149927510865;5674;5678.914816277759;4080.571539988303;5907.4978626816555;6198.628082315053;6212.534059945499;6324.3991820776955;6220.782272620482;6249.0626406039;6259.061140828867;6288;6323.30443651198;5452.291202143736;5560.471755183251;5581.386047534768;5585.106382978704;5602.579806514487;21663.26693864487;21915.452113697127;22107.115715371365;22219.55560888773;22397.776022239734;2319.4433335999406;2331.9067237310487;2720.8503532305717;3082.33729748103;3143.025662044751;13786.310684465736;14190.716185676332;14290.64273393163;14518.274086295749;14761.55715328542;1953.8729982551088;2022.0799536210989;2056.8354531637433;2074.668053111495;2092.487340601562;81720.59139704323;83791;84030.57984710099;84178.57910710407;84689.57655211746;10752.623658171926;10974.341539507495;10976.396298203676;10993.06747950179;11038.11695064393;15174.393024279127;15364.692706145814;15382.923085384726;15413.691726165638;15433.45982890616;7983.2415920487465;8195.508269503729;8223.794405139799;8329.416940814084;8399.11809260031;7853.136155022943;7878.251566101326;7920.168382319889;8022.9598852005365;8062.637181326737;5897.321807992136;6312.400321969406;6533.934660653427;6763.628000460022;6771.187457505032;1947.2503086311588;1948.298612499499;1995.6806910894188;2039.1435597048978;2044.6217449771543;941.7928055827707;1013.4172850610928;1070.7216123807866;1079.3577821196375;1081.978360432787;18441.354552590594;19022.61954760897;19038.524036899187;19202.40767496398;19234.519137021685;1030.6547306652205;1033.607229252894;1060.0512541275668;1082.626493859617;1095.3263742798122;10631.681049568526;11054.060404865677;11057.557697692002;11059.668209953714;11091.44542772858;487323;492368;493114;495607;499620;62255;72895;79852.6007369971;106315;107651;1085.6254592165849;1096.9286996345372;1116.7989761842784;1123.5168877382803;1127.537709539085;16730.4144354947;17025.31898724037;17162.485125446256;17283.308667653153;17304.826951730323;38627.42058869063;38914.80542597269;42841.35737963995;43529.56470435255;44929.55070449254;55864;57787.711061444425;58356.70821646034;59113;59586;8601.65593376283;8823.647054117764;8875.778105547155;8933.865992009994;9093.863592045993;12357.814632780335;13330.26683532415;13463.663408414868;13740.038197326092;13819.792703109662;11675.941620291844;11730.413479326171;11739.530418783153;12115.333656648969;12449.315287659265;12090.790920907839;12108.152429330215;12311.445984930879;12417.31704756211;12625.431855566705;12257.632271031884;12347.506099756269;12617.053720971147;12651.93674031624;12683.42924568415;7637.198094200251;8001;8859.424137431046;8961.417507861968;9068.455892646462;11757.941210293893;12098.455569499218;12157.939210304246;12194.75610487803;12241.69395765113 13:29:26 INFO - PROCESS | 19436 | |3;mootools.html;1326.8474125475573;1545.7526795712688;1586.9841301586985;1780.1010489702699;1897.260068573256;8469;8844.336674749395;8852.008298132916;9112.726618201465;9123.224525915288;8773.29813614911;8998.68504602339;9060.275177985763;9062.320325975545;9066.546672666356;2133.1893880325533;2338.2634470141934;2378.1676413255395;2406.566817972764;2414.5653782319177;2433.1285912423186;2449.461118553915;2451.191106934716;2460.2250291158316;2464.5933420985516;2320.118355025088;2321.117975169433;2340.3914982104607;2344.6014177589764;2347.882605869708;2061.783512731164;2300.6894069300597;2372.8457650252676;2375.2874137758604;2390.8924098415614;2330.731965823935;2331.405491599648;2341.5316936612744;2342.5783358995373;2364.7517010713973;8910.242629376511;9015.14356136166;9017.594208260578;9033.50315732641;9043.593038313225;5098.821541246076;5283.049051170788;5289.603279754034;5291.788328466857;5298.788048478056;3445.896623101311;3482.8084455354947;3512.5082488451635;3660.6156353582755;3697.131174174067;1162.4768854015642;1168.631880957504;1191.9702007449796;1206.8129439936824;1211.5698926880918;11990.940045299805;12253.326067066308;12274.140810143293;12296.446659900326;12297.3236471994;4584.679072464962;4719.079779442975;4810.518948105231;4826.276058591239;4832.864276894927;10569.312994655476;10572.894271057345;10590.417527035934;10618;10631.096356809758;4903.53416425439;5274.182501712241;5380.488853558905;5390.272313237741;5402.108652072364;4608.516105808909;4745.406824146981;4763.118823017753;4786.090642777931;4790.760461976887;4016.879493615196;4053.1369143861402;4149.875503734893;4180.623743863067;4189.560096189917;1298.4157129291857;1298.8506321772927;1308.6270412932458;1323.8742319479634;1339.71196192819;902;1021.6168936648756;1023.3194925374543;1027.244974943416;1032.6643840751635;5804.448577385142;5933.3473317934995;6006.249218847644;6016.909746353808;6181.474574661114;455.41251785197386;457;461.08704764565675;462.4681616141464;472.11714094642554;4133.937990930139;4258.61672449481;4326.697131200849;4424.491183513873;4503.752293623882;10963.50664220112;11283.943580282046;11327.263727857662;11383.487743051583;11481.311121332747;11313.20807543464;11317.547298108148;11335.376554289593;11348.602798902164;11398.20212585111;7906.327962123284;8090.352771778244;8270.421070525006;8279.95860020696;8374.748757537283;6150.661713605795;6303.306636270098;6328.128120132608;6338.936610634019;6344.111824344688;10137.138343240613;10294.948525257325;10420.947895260475;10500.317479363817;10595.629152979609;10533;10539.631112911318;10544.736381590521;10654.414007229367;10696.465176741287;7294.379977701955;7755.7203061496475;7971.601419929097;7982.880256796268;8153.9184608153155;8766.386352955233;8788.209061184269;8830.116988301119;8873.778155546162;8889.422187557788;7452.515586486861;7635.923640763522;7644.503107298008;7722.111957125003;7732.574708390867;7569.091708994735;7615.276548727862;7773.727919522789;7864.84270314579;7891.289783919475;7193.208747037717;7203.8919416207755;7206.099237595301;7278.381337586153;7280.9271907280245;5283.762230699705;5311.336082989626;5376.435474275145;5445.237666726741;5453.672779633234;5271.762770675406;5364.168553874156;5434.755436005468;5461.098918678374;5467.835964921059 13:29:26 INFO - PROCESS | 19436 | |4;prototype.html;347.8486858216676;349.5420998491976;351.2097779995011;353.16828868015835;356.3300994131033;5321.255024296597;5425.538829199523;5430.348358197017;5449.700266485347;5451.863703407417;5295.894082118365;5309.654872433289;5348.411674715788;5366.275552800371;5389.676619402839;3902.356111241642;4076.8165432555534;4175.415441838145;4221.113566151096;4233.6824738144605;4122.9381559276635;4165.146145040259;4211.115665710189;4218.409422680827;4244.405783190356;4060.4112403701447;4214.199302132585;4221.915561688765;4226.513950895655;4236.851710190144;4120.711550191488;4209.65291106846;4213.894652633678;4224.831006759726;4228.830846766125;3767.585565587783;3770.377887648535;3782.9054273643105;3798.1833905710128;3808.428735689641;5091.592672586185;5100.642954993152;5127.359245041588;5142.331496905415;5204.115300398941;4885.193942999401;4900.730459824708;4915.631327650405;4928.940277840282;4930.753462326869;5323.787048518055;5462.535684466825;5480.80817171401;5591.664500129965;5655.632383895034;3960.683145348365;4064.5325787534516;4064.7764372959477;4152.854650087233;4158.542560318362;5614.775408983635;5733.913991290134;5765.221695071154;5775.537956963432;5777.717801468439;4152.563980782034;4202.138561594866;4235.851745188904;4239.300515414983;4256.1487702459635;4299.462567179103;4308.9569104309185;4314.374415709767;4315.266404711207;4316.136772645421;4815.711057336571;4823.758812059383;4828.348172996671;4843;4854.980454104607;5490.972545137249;5581.134924086773;5605.654642885678;5631.18347839561;5659.688717120598;1459.8248410029817;1466.4354223623768;1472.63184203949;1473.786300986351;1480.25247250138;958.5686441101532;960.9327347085776;975.7609385700549;993.777653486216;994.9104580587782;4774.066503066264;4794.7842347094465;4800.5199480051715;4807.95192048082;4815.036992601494;5055;5107.8252002039735;5109.20807274873;5133.743312834418;5143.614228932845;4492.146492166478;4778.259369797687;4812.484067518791;4845.466998630148;4852.369192005017;2679.571268597015;2750.2574304937957;2758.544840101401;2769.7507224349906;2773.724086919999;5306.787728490817;5319.6808191508635;5327.573794096541;5332.786688532416;5357.276767636319;5190.480951904855;5190.662606930538;5475;5906.350301466835;5912.497437717842;5725.425507985337;5865.530757539302;5940.61386009908;5954.46409823118;5962.880742385128;5746.13807928814;5749.8275051748515;5780.2081354778475;5807.912881306868;5831.591788574929;5706.629069110494;5712.485876271156;5731.942680573141;5733.283339582552;5748.252727145445;5611.240290901766;5921.3782552831335;5925.733341999534;5930.199423077829;5952.404759524013;4140.544540100526;4150.750954942713;4182.142660754599;4228.344606585984;4237.131388065501;5675.801346952837;5865.765369385347;5899.823005309848;5910.7340169693325;5916.31962324321;5574.609777315549;5590.2453168821685;5615.045442274742;5676.886462270649;5678.2050512929045;5634.211210430461;5648.5763567731765;5681.721612637289;5685.829425117253;5697.7720891165545;5305.257263982969;5490.890182196414;5526.613137080366;5534.612577119724;5606.831795046155;5636.689982051026;5648.435156484319;5657.094864821609;5668.886622267614;5676.091825307931;5465.508104270635;5505.091659876076;5505.2933590587045;5512.889742205213;5536.833894983157 13:29:26 INFO - PROCESS | 19436 | |5;yui.html;816.2449733996052;834.2158371131136;835.7785186925462;860.2257967828954;902.575789378992;14125.576232713021;14679.926600366984;14710.852891471082;14737.705245895075;14742.26288685564;13491.932540337284;13554.796678049812;13568.457261709544;13577.117487363315;13581.320933953311;697.3549466743242;818.7011740714626;829.6681327469031;843.4348986179275;850.2857599616322;837.8785076163953;842.8904242448504;844.2486187293283;844.4637655089032;845.0915266088948;893.352319568311;896.3635818568791;896.8878890138733;898.1333013641835;899.4063917814244;739.1425945902754;865.2558799432483;884.6284560484612;885.1679421343916;895.0691281067682;647.9416852483251;649.0556240669814;649.2825427902195;650.1450592470885;650.4633677216316;13240.404181811842;13265;13292.667683307898;13295.468181272738;13296.26870522121;12656.746865062647;12898.548550800771;13241.867581324255;13262.535811246657;13411.396487158101;11483.253588516804;11508.367039812807;11515.25150865191;11760.823587646191;11809.586664466788;4220.180736433533;4314.82740690372;4380.802863871133;4456.086502267028;4470.41884555009;50924.745376273255;51255.23117153208;51677.48322516764;52198.21702674463;52342.47657523414;9849.409035457895;9897.406155630686;10041.548130334153;10238.641647542301;10724.356538607552;18659;18767.90616046911;18833.340833070775;18932.621347573247;18936.147873345733;7495.700171993169;7543.660535275926;7649.655765490566;7654.158042615308;7687.884681729778;4246.44796176495;4264.744115353089;4598.701084429501;4738.691985020962;4775.880602984884;3380.2225488137865;3612.927741445209;3623.8912832614537;3628.0385697790107;3635.90922723182;562.1483452569361;696.2515296056658;696.435886931587;697.849962258117;703.8838591632426;611.8500967263049;649.7141257846532;664.020569659748;677.9830504237335;714.589111261027;9490.430574165572;9830.459324737065;9858.95070524657;9917.504124793732;9991;714.292850078429;728.1189760389882;754.0687251244708;754.9282818132268;774.9573773442402;4433.534478879736;4537.8411755588395;4584.587387135174;4601.792919318638;4609.147307748078;68995;70705.2929470709;71040;71077.28922710707;72353.63823180851;61944.380556193864;63144.68427657832;63800.68099659565;63820;65463.67268163724;56912.71543642255;57089.71455142781;57531.42468575261;57802.42197578055;58832;8786.780330491789;8843.823123537364;8911.777205569913;8943.508107054175;8992.28061755045;34773.47839782355;35429;36185.81907090448;36654.450183246736;37085.62914370822;44929;48815.02369952652;49363.50636493589;50015.749921250164;50352.24471633002;11142.108631309638;11148.498317575566;11200.43997800123;11577.594784182513;11704.473298701409;11629.18595698293;11639.359835209145;11985.921267086003;12721.491140354283;12814.167079139826;11527.711807204887;11987.580434684744;12358.691032724253;12371.814422783846;12594.370281486072;11459;11661.6501504955;11951.940240298743;11954.10344224204;12182.878171218174;11479.024282936043;11949;12034.75930481403;12301.93849030785;12319.076069294659;9177.77055573616;9637.22902167839;9746.366486178376;9925.65260215889;9999.35004224723;10058.893521712753;10120.746981325527;10591.841122383325;10722.678319650424;10746 13:29:26 INFO - PROCESS | 19436 | __end_tp_report 13:29:26 INFO - PROCESS | 19436 | __start_cc_report 13:29:26 INFO - PROCESS | 19436 | _x_x_mozilla_cycle_collect,891 13:29:26 INFO - PROCESS | 19436 | __end_cc_report 13:29:26 INFO - PROCESS | 19436 | __startTimestamp1462998566687__endTimestamp 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | ------- Summary: start ------- 13:29:26 INFO - PROCESS | 19436 | Number of tests: 6 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#0] dojo.html Cycles:165 Average:5499.18 Median:5687.37 stddev:625.12 (11.0%) stddev-sans-first:601.15 13:29:26 INFO - PROCESS | 19436 | Values: 3230.0 3230.9 3255.2 3275.0 3280.4 5441.6 5471.5 5533.2 5580.6 5616.8 5467.3 5516.8 5525.2 5527.1 5530.1 4953.5 5051.2 5057.1 5062.3 5239.8 5100.9 5112.7 5147.6 5169.2 5170.5 4904.4 4960.3 4995.7 4996.1 5055.3 4966.2 4970.7 5032.4 5038.0 5065.4 4973.1 4990.1 5016.4 5029.7 5048.1 5346.7 5350.9 5409.5 5428.3 5458.7 5881.6 5896.5 5898.5 5944.5 5957.9 5885.2 5901.5 5906.6 6000.3 6048.0 5596.1 5598.4 5614.9 5615.4 5617.8 6090.4 6096.0 6097.6 6100.4 6102.2 5653.9 5780.9 5799.7 5826.9 5914.3 5946.9 5950.8 5950.8 5952.5 5956.2 5938.4 5947.2 5949.0 5950.1 5951.1 5760.6 5855.2 5891.6 5926.7 6011.5 4454.8 4484.3 4487.4 4491.1 4528.7 3958.1 3977.5 4007.9 4034.4 4059.5 5570.8 5612.6 5618.4 5621.8 5655.4 5965.0 5980.9 5984.2 5989.1 5993.3 5487.6 5535.3 5566.8 5574.0 5578.2 5041.2 5080.4 5083.5 5084.9 5126.3 6118.2 6139.8 6141.4 6143.4 6146.4 5870.5 5871.8 5916.2 5969.9 5977.9 6104.9 6109.9 6129.3 6129.4 6134.0 5792.9 5847.5 5848.7 5851.0 5880.2 5848.1 5882.9 5903.4 5911.8 5939.3 5727.4 5785.2 5791.0 5792.0 5797.2 5773.0 5777.9 5781.2 5794.8 5803.7 5574.1 5630.6 5653.2 5678.6 5700.1 5819.4 5846.7 5893.8 5908.4 5908.7 5569.5 5685.1 5687.4 5697.9 5698.0 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#1] ext.html Cycles:180 Average:54407.43 Median:42605.36 stddev:96064.84 (225.5%) stddev-sans-first:96249.46 13:29:26 INFO - PROCESS | 19436 | Values: 629.0 659.9 668.2 669.2 678.9 44471.6 45845.8 45914.8 45948.3 49577.8 46670.0 46722.8 47077.8 47110.5 47320.5 8902.7 9030.9 9036.1 9039.1 9042.8 8813.4 8888.1 8906.0 8909.3 8911.8 8890.6 8938.4 8942.3 8943.1 8943.6 8909.5 8948.6 8948.7 8955.5 8962.6 8884.2 8932.2 8952.6 8956.5 8956.9 42472.6 42863.8 42865.6 43029.8 43045.6 3417.3 3478.3 3491.0 3547.9 3586.2 32436.5 32705.0 33266.7 33366.2 33626.3 4123.2 4187.0 4187.3 4197.3 4267.8 327243.0 327552.0 327768.0 328021.0 328422.0 53584.7 59314.7 59948.0 60237.4 60313.4 63513.4 64814.4 64985.0 70286.6 70464.3 16146.6 16309.1 16314.3 16347.4 16379.7 11320.4 12018.9 12137.1 12274.8 12303.3 17721.6 18224.3 18278.7 18365.2 18405.9 6127.2 6191.9 6267.3 6274.3 6329.5 1008.9 1081.1 1084.5 1160.3 1250.0 33436.0 33472.5 33566.8 33694.3 33753.7 1094.0 1102.4 1163.9 1217.5 1236.7 17512.4 17572.1 17583.4 17701.0 17866.0 447977.0 451867.0 452320.0 452659.0 452906.0 59664.4 59859.0 59903.4 59904.7 59943.4 1318.0 1381.9 1418.9 1420.6 1432.8 33313.3 34058.8 34342.5 34467.1 34701.1 51358.5 51873.7 52017.2 52035.2 52058.7 292763.0 298872.0 299206.0 299603.0 299839.0 28336.1 37052.3 41286.0 41839.8 42810.8 45310.3 45549.3 49302.3 49317.8 49795.8 40642.2 40878.0 42209.0 42599.4 42876.1 39798.4 42471.6 42797.4 43469.3 44019.3 42149.8 42611.4 43327.8 43523.0 43613.0 36614.8 37452.0 37580.6 37849.0 38174.8 28698.0 28776.7 28838.1 28918.3 28928.9 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#2] jquery.html Cycles:180 Average:29151.27 Median:11877.88 stddev:81301.68 (684.5%) stddev-sans-first:81501.11 13:29:26 INFO - PROCESS | 19436 | Values: 406.6 413.9 414.9 418.4 428.4 14252.5 17935.9 19417.9 19434.7 19978.2 13042.3 17384.0 17454.0 18194.5 19020.2 5545.4 5696.4 5738.5 5740.6 5749.7 5586.3 5655.0 5667.1 5674.0 5678.9 4080.6 5907.5 6198.6 6212.5 6324.4 6220.8 6249.1 6259.1 6288.0 6323.3 5452.3 5560.5 5581.4 5585.1 5602.6 21663.3 21915.5 22107.1 22219.6 22397.8 2319.4 2331.9 2720.9 3082.3 3143.0 13786.3 14190.7 14290.6 14518.3 14761.6 1953.9 2022.1 2056.8 2074.7 2092.5 81720.6 83791.0 84030.6 84178.6 84689.6 10752.6 10974.3 10976.4 10993.1 11038.1 15174.4 15364.7 15382.9 15413.7 15433.5 7983.2 8195.5 8223.8 8329.4 8399.1 7853.1 7878.3 7920.2 8023.0 8062.6 5897.3 6312.4 6533.9 6763.6 6771.2 1947.3 1948.3 1995.7 2039.1 2044.6 941.8 1013.4 1070.7 1079.4 1082.0 18441.4 19022.6 19038.5 19202.4 19234.5 1030.7 1033.6 1060.1 1082.6 1095.3 10631.7 11054.1 11057.6 11059.7 11091.4 487323.0 492368.0 493114.0 495607.0 499620.0 62255.0 72895.0 79852.6 106315.0 107651.0 1085.6 1096.9 1116.8 1123.5 1127.5 16730.4 17025.3 17162.5 17283.3 17304.8 38627.4 38914.8 42841.4 43529.6 44929.6 55864.0 57787.7 58356.7 59113.0 59586.0 8601.7 8823.6 8875.8 8933.9 9093.9 12357.8 13330.3 13463.7 13740.0 13819.8 11675.9 11730.4 11739.5 12115.3 12449.3 12090.8 12108.2 12311.4 12417.3 12625.4 12257.6 12347.5 12617.1 12651.9 12683.4 7637.2 8001.0 8859.4 8961.4 9068.5 11757.9 12098.5 12157.9 12194.8 12241.7 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#3] mootools.html Cycles:180 Average:5922.29 Median:2520.84 stddev:3385.84 (134.3%) stddev-sans-first:3377.73 13:29:26 INFO - PROCESS | 19436 | Values: 1326.8 1545.8 1587.0 1780.1 1897.3 8469.0 8844.3 8852.0 9112.7 9123.2 8773.3 8998.7 9060.3 9062.3 9066.5 2133.2 2338.3 2378.2 2406.6 2414.6 2433.1 2449.5 2451.2 2460.2 2464.6 2320.1 2321.1 2340.4 2344.6 2347.9 2061.8 2300.7 2372.8 2375.3 2390.9 2330.7 2331.4 2341.5 2342.6 2364.8 8910.2 9015.1 9017.6 9033.5 9043.6 5098.8 5283.0 5289.6 5291.8 5298.8 3445.9 3482.8 3512.5 3660.6 3697.1 1162.5 1168.6 1192.0 1206.8 1211.6 11990.9 12253.3 12274.1 12296.4 12297.3 4584.7 4719.1 4810.5 4826.3 4832.9 10569.3 10572.9 10590.4 10618.0 10631.1 4903.5 5274.2 5380.5 5390.3 5402.1 4608.5 4745.4 4763.1 4786.1 4790.8 4016.9 4053.1 4149.9 4180.6 4189.6 1298.4 1298.9 1308.6 1323.9 1339.7 902.0 1021.6 1023.3 1027.2 1032.7 5804.4 5933.3 6006.2 6016.9 6181.5 455.4 457.0 461.1 462.5 472.1 4133.9 4258.6 4326.7 4424.5 4503.8 10963.5 11283.9 11327.3 11383.5 11481.3 11313.2 11317.5 11335.4 11348.6 11398.2 7906.3 8090.4 8270.4 8280.0 8374.7 6150.7 6303.3 6328.1 6338.9 6344.1 10137.1 10294.9 10420.9 10500.3 10595.6 10533.0 10539.6 10544.7 10654.4 10696.5 7294.4 7755.7 7971.6 7982.9 8153.9 8766.4 8788.2 8830.1 8873.8 8889.4 7452.5 7635.9 7644.5 7722.1 7732.6 7569.1 7615.3 7773.7 7864.8 7891.3 7193.2 7203.9 7206.1 7278.4 7280.9 5283.8 5311.3 5376.4 5445.2 5453.7 5271.8 5364.2 5434.8 5461.1 5467.8 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#4] prototype.html Cycles:180 Average:4663.91 Median:5197.39 stddev:1352.20 (26.0%) stddev-sans-first:1316.61 13:29:26 INFO - PROCESS | 19436 | Values: 347.8 349.5 351.2 353.2 356.3 5321.3 5425.5 5430.3 5449.7 5451.9 5295.9 5309.7 5348.4 5366.3 5389.7 3902.4 4076.8 4175.4 4221.1 4233.7 4122.9 4165.1 4211.1 4218.4 4244.4 4060.4 4214.2 4221.9 4226.5 4236.9 4120.7 4209.7 4213.9 4224.8 4228.8 3767.6 3770.4 3782.9 3798.2 3808.4 5091.6 5100.6 5127.4 5142.3 5204.1 4885.2 4900.7 4915.6 4928.9 4930.8 5323.8 5462.5 5480.8 5591.7 5655.6 3960.7 4064.5 4064.8 4152.9 4158.5 5614.8 5733.9 5765.2 5775.5 5777.7 4152.6 4202.1 4235.9 4239.3 4256.1 4299.5 4309.0 4314.4 4315.3 4316.1 4815.7 4823.8 4828.3 4843.0 4855.0 5491.0 5581.1 5605.7 5631.2 5659.7 1459.8 1466.4 1472.6 1473.8 1480.3 958.6 960.9 975.8 993.8 994.9 4774.1 4794.8 4800.5 4808.0 4815.0 5055.0 5107.8 5109.2 5133.7 5143.6 4492.1 4778.3 4812.5 4845.5 4852.4 2679.6 2750.3 2758.5 2769.8 2773.7 5306.8 5319.7 5327.6 5332.8 5357.3 5190.5 5190.7 5475.0 5906.4 5912.5 5725.4 5865.5 5940.6 5954.5 5962.9 5746.1 5749.8 5780.2 5807.9 5831.6 5706.6 5712.5 5731.9 5733.3 5748.3 5611.2 5921.4 5925.7 5930.2 5952.4 4140.5 4150.8 4182.1 4228.3 4237.1 5675.8 5865.8 5899.8 5910.7 5916.3 5574.6 5590.2 5615.0 5676.9 5678.2 5634.2 5648.6 5681.7 5685.8 5697.8 5305.3 5490.9 5526.6 5534.6 5606.8 5636.7 5648.4 5657.1 5668.9 5676.1 5465.5 5505.1 5505.3 5512.9 5536.8 13:29:26 INFO - PROCESS | 19436 | 13:29:26 INFO - PROCESS | 19436 | [#5] yui.html Cycles:180 Average:15378.57 Median:49689.63 stddev:18897.56 (38.0%) stddev-sans-first:18918.93 13:29:26 INFO - PROCESS | 19436 | Values: 816.2 834.2 835.8 860.2 902.6 14125.6 14679.9 14710.9 14737.7 14742.3 13491.9 13554.8 13568.5 13577.1 13581.3 697.4 818.7 829.7 843.4 850.3 837.9 842.9 844.2 844.5 845.1 893.4 896.4 896.9 898.1 899.4 739.1 865.3 884.6 885.2 895.1 647.9 649.1 649.3 650.1 650.5 13240.4 13265.0 13292.7 13295.5 13296.3 12656.7 12898.5 13241.9 13262.5 13411.4 11483.3 11508.4 11515.3 11760.8 11809.6 4220.2 4314.8 4380.8 4456.1 4470.4 50924.7 51255.2 51677.5 52198.2 52342.5 9849.4 9897.4 10041.5 10238.6 10724.4 18659.0 18767.9 18833.3 18932.6 18936.1 7495.7 7543.7 7649.7 7654.2 7687.9 4246.4 4264.7 4598.7 4738.7 4775.9 3380.2 3612.9 3623.9 3628.0 3635.9 562.1 696.3 696.4 697.8 703.9 611.9 649.7 664.0 678.0 714.6 9490.4 9830.5 9859.0 9917.5 9991.0 714.3 728.1 754.1 754.9 775.0 4433.5 4537.8 4584.6 4601.8 4609.1 68995.0 70705.3 71040.0 71077.3 72353.6 61944.4 63144.7 63800.7 63820.0 65463.7 56912.7 57089.7 57531.4 57802.4 58832.0 8786.8 8843.8 8911.8 8943.5 8992.3 34773.5 35429.0 36185.8 36654.5 37085.6 44929.0 48815.0 49363.5 50015.7 50352.2 11142.1 11148.5 11200.4 11577.6 11704.5 11629.2 11639.4 11985.9 12721.5 12814.2 11527.7 11987.6 12358.7 12371.8 12594.4 11459.0 11661.7 11951.9 11954.1 12182.9 11479.0 11949.0 12034.8 12301.9 12319.1 9177.8 9637.2 9746.4 9925.7 9999.4 10058.9 10120.7 10591.8 10722.7 10746.0 13:29:26 INFO - PROCESS | 19436 | -------- Summary: end -------- 13:29:26 INFO - PROCESS | 19436 | 13:29:27 INFO - TEST-INFO | 19436: exit 0 13:29:27 INFO - TEST-OK | dromaeo_css | took 1113256ms 13:29:27 INFO - TEST-START | kraken 13:29:27 INFO - operating with platform_type : linux_ 13:29:27 INFO - Initialising browser for kraken test... 13:29:27 INFO - TEST-INFO | started process 19617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPlVuM/profile http://localhost:33293/getInfo.html) 13:29:30 INFO - PROCESS | 19617 | __metrics Screen width/height:1600/1200 13:29:30 INFO - PROCESS | 19617 | colorDepth:24 13:29:30 INFO - PROCESS | 19617 | Browser inner width/height: 1024/697 13:29:30 INFO - PROCESS | 19617 | __metrics 13:29:31 ERROR - PROCESS | 19617 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:29:32 INFO - TEST-INFO | 19617: exit 0 13:29:32 INFO - Browser initialized. 13:29:32 INFO - Running cycle 1/1 for kraken test... 13:29:32 INFO - TEST-INFO | started process 19694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPlVuM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:44 INFO - PROCESS | 19694 | RSS: Main: 151728128 13:29:44 INFO - PROCESS | 19694 | 13:29:46 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33293/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:47 INFO - PROCESS | 19694 | RSS: Main: 208048128 13:29:47 INFO - PROCESS | 19694 | 13:29:50 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33293/tests/kraken/driver.html?testName=audio-dft) 13:29:51 INFO - PROCESS | 19694 | RSS: Main: 197570560 13:29:51 INFO - PROCESS | 19694 | 13:29:54 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33293/tests/kraken/driver.html?testName=audio-fft) 13:29:54 INFO - PROCESS | 19694 | RSS: Main: 264978432 13:29:54 INFO - PROCESS | 19694 | 13:29:57 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33293/tests/kraken/driver.html?testName=audio-oscillator) 13:29:57 INFO - PROCESS | 19694 | RSS: Main: 174325760 13:29:57 INFO - PROCESS | 19694 | 13:30:00 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:30:00 INFO - PROCESS | 19694 | RSS: Main: 177983488 13:30:00 INFO - PROCESS | 19694 | 13:30:03 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33293/tests/kraken/driver.html?testName=imaging-darkroom) 13:30:04 INFO - PROCESS | 19694 | RSS: Main: 213725184 13:30:04 INFO - PROCESS | 19694 | 13:30:07 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33293/tests/kraken/driver.html?testName=imaging-desaturate) 13:30:08 INFO - PROCESS | 19694 | RSS: Main: 214609920 13:30:08 INFO - PROCESS | 19694 | 13:30:11 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33293/tests/kraken/driver.html?testName=json-parse-financial) 13:30:12 INFO - PROCESS | 19694 | RSS: Main: 214798336 13:30:12 INFO - PROCESS | 19694 | 13:30:13 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:30:14 INFO - PROCESS | 19694 | RSS: Main: 202199040 13:30:14 INFO - PROCESS | 19694 | 13:30:16 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:30:16 INFO - PROCESS | 19694 | RSS: Main: 207884288 13:30:16 INFO - PROCESS | 19694 | 13:30:18 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:30:19 INFO - PROCESS | 19694 | RSS: Main: 216780800 13:30:19 INFO - PROCESS | 19694 | 13:30:22 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:30:22 INFO - PROCESS | 19694 | RSS: Main: 219889664 13:30:22 INFO - PROCESS | 19694 | 13:30:25 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:30:26 INFO - PROCESS | 19694 | RSS: Main: 219144192 13:30:26 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:33293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33293/tests/kraken/driver.html?testName=ai-astar) 13:30:28 INFO - PROCESS | 19694 | RSS: Main: 265084928 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | __start_tp_report 13:30:28 INFO - PROCESS | 19694 | _x_x_mozilla_page_load 13:30:28 INFO - PROCESS | 19694 | _x_x_mozilla_page_load_details 13:30:28 INFO - PROCESS | 19694 | |i|pagename|runs| 13:30:28 INFO - PROCESS | 19694 | |0;ai-astar;110;107;110;112;110;113;111;110;110;111 13:30:28 INFO - PROCESS | 19694 | |1;audio-beat-detection;153;124;153;218;126;156;147;126;179;137 13:30:28 INFO - PROCESS | 19694 | |2;audio-dft;161;161;159;161;160;161;162;160;161;162 13:30:28 INFO - PROCESS | 19694 | |3;audio-fft;75;77;77;158;75;75;75;73;128;75 13:30:28 INFO - PROCESS | 19694 | |4;audio-oscillator;93;91;147;92;93;92;135;92;92;141 13:30:28 INFO - PROCESS | 19694 | |5;imaging-gaussian-blur;116;117;116;116;116;116;119;116;116;116 13:30:28 INFO - PROCESS | 19694 | |6;imaging-darkroom;145;146;146;146;146;145;145;146;146;145 13:30:28 INFO - PROCESS | 19694 | |7;imaging-desaturate;95;95;95;97;95;95;95;95;96;94 13:30:28 INFO - PROCESS | 19694 | |8;json-parse-financial;59;60;58;59;60;59;63;110;56;55 13:30:28 INFO - PROCESS | 19694 | |9;json-stringify-tinderbox;60;59;58;57;59;58;58;58;59;58 13:30:28 INFO - PROCESS | 19694 | |10;stanford-crypto-aes;78;83;79;83;78;79;79;85;80;78 13:30:28 INFO - PROCESS | 19694 | |11;stanford-crypto-ccm;124;125;138;122;135;131;129;137;235;132 13:30:28 INFO - PROCESS | 19694 | |12;stanford-crypto-pbkdf2;168;165;162;162;166;163;164;166;169;168 13:30:28 INFO - PROCESS | 19694 | |13;stanford-crypto-sha256-iterative;67;65;64;64;67;64;65;64;63;62 13:30:28 INFO - PROCESS | 19694 | __end_tp_report 13:30:28 INFO - PROCESS | 19694 | __start_cc_report 13:30:28 INFO - PROCESS | 19694 | _x_x_mozilla_cycle_collect,1828 13:30:28 INFO - PROCESS | 19694 | __end_cc_report 13:30:28 INFO - PROCESS | 19694 | __startTimestamp1462998628293__endTimestamp 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | ------- Summary: start ------- 13:30:28 INFO - PROCESS | 19694 | Number of tests: 14 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.58 (1.4%) stddev-sans-first:1.67 13:30:28 INFO - PROCESS | 19694 | Values: 110.0 107.0 110.0 112.0 110.0 113.0 111.0 110.0 110.0 111.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.00 stddev:28.85 (18.9%) stddev-sans-first:30.59 13:30:28 INFO - PROCESS | 19694 | Values: 153.0 124.0 153.0 218.0 126.0 156.0 147.0 126.0 179.0 137.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 13:30:28 INFO - PROCESS | 19694 | Values: 161.0 161.0 159.0 161.0 160.0 161.0 162.0 160.0 161.0 162.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#3] audio-fft Cycles:10 Average:88.80 Median:75.00 stddev:29.45 (39.3%) stddev-sans-first:30.81 13:30:28 INFO - PROCESS | 19694 | Values: 75.0 77.0 77.0 158.0 75.0 75.0 75.0 73.0 128.0 75.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.00 stddev:23.78 (25.8%) stddev-sans-first:24.69 13:30:28 INFO - PROCESS | 19694 | Values: 93.0 91.0 147.0 92.0 93.0 92.0 135.0 92.0 92.0 141.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 13:30:28 INFO - PROCESS | 19694 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 119.0 116.0 116.0 116.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:30:28 INFO - PROCESS | 19694 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 13:30:28 INFO - PROCESS | 19694 | Values: 95.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 94.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:59.00 stddev:16.35 (27.7%) stddev-sans-first:17.24 13:30:28 INFO - PROCESS | 19694 | Values: 59.0 60.0 58.0 59.0 60.0 59.0 63.0 110.0 56.0 55.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 13:30:28 INFO - PROCESS | 19694 | Values: 60.0 59.0 58.0 57.0 59.0 58.0 58.0 58.0 59.0 58.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.53 (3.2%) stddev-sans-first:2.55 13:30:28 INFO - PROCESS | 19694 | Values: 78.0 83.0 79.0 83.0 78.0 79.0 79.0 85.0 80.0 78.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:133.50 stddev:33.55 (25.1%) stddev-sans-first:35.02 13:30:28 INFO - PROCESS | 19694 | Values: 124.0 125.0 138.0 122.0 135.0 131.0 129.0 137.0 235.0 132.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.54 (1.5%) stddev-sans-first:2.50 13:30:28 INFO - PROCESS | 19694 | Values: 168.0 165.0 162.0 162.0 166.0 163.0 164.0 166.0 169.0 168.0 13:30:28 INFO - PROCESS | 19694 | 13:30:28 INFO - PROCESS | 19694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.58 (2.5%) stddev-sans-first:1.39 13:30:28 INFO - PROCESS | 19694 | Values: 67.0 65.0 64.0 64.0 67.0 64.0 65.0 64.0 63.0 62.0 13:30:28 INFO - PROCESS | 19694 | -------- Summary: end -------- 13:30:28 INFO - PROCESS | 19694 | 13:30:29 INFO - TEST-INFO | 19694: exit 0 13:30:29 INFO - TEST-OK | kraken | took 61908ms 13:30:29 INFO - SUITE-END | took 1175s 13:30:29 INFO - Completed test suite (00:19:35) 13:30:29 INFO - javascript benchmark 13:30:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.0309907027886, 3230.9192270193244, 3255.1699316674253, 3274.950875736863, 3280.360329735701, 5441.59188060895, 5471.480209380113, 5533.170024496318, 5580.637258578195, 5616.831495055145, 5467.316585426822, 5516.806911758089, 5525.226468294432, 5527.060399732045, 5530.05988981873, 4953.529414705597, 5051.242313652945, 5057.0897238497055, 5062.26597143414, 5239.816606418776, 5100.872478188038, 5112.667676601009, 5147.588192944574, 5169.172932330828, 5170.508801663836, 4904.386951631046, 4960.255961605788, 4995.650304478688, 4996.075725990703, 5055.31753213317, 4966.230234313687, 4970.701757894538, 5032.396112466491, 5038.042771873333, 5065.392152941634, 4973.1297023020825, 4990.051890140861, 5016.398032236155, 5029.723365214912, 5048.116579598593, 5346.679199248018, 5350.866228344284, 5409.486098820645, 5428.348598168245, 5458.727063646841, 5881.617694849821, 5896.498797602209, 5898.498627616657, 5944.464998150187, 5957.940420595782, 5885.176075349455, 5901.468867801876, 5906.645601263895, 6000.33996260411, 6048.0, 5596.104623260299, 5598.44015598441, 5614.859628509238, 5615.354234263031, 5617.80337688183, 6090.363537171995, 6096.021318109847, 6097.633605971558, 6100.426550924247, 6102.1839709467895, 5653.943460565424, 5780.94219057804, 5799.739011744482, 5826.912596311059, 5914.290285165722, 5946.851328716817, 5950.761969521257, 5950.791722289786, 5952.494038006731, 5956.195913551702, 5938.376470470625, 5947.226860508106, 5949.0481522956115, 5950.107483877367, 5951.1073338999495, 5760.596758226968, 5855.238818953509, 5891.646501209942, 5926.67403292823, 6011.549133814981, 4454.821807127679, 4484.304932735431, 4487.371767952489, 4491.124230775033, 4528.682992190515, 3958.1094253792667, 3977.463042489227, 4007.919841603152, 4034.3948407739076, 4059.4519739835337, 5570.777168913279, 5612.579056570774, 5618.438156184349, 5621.831345059655, 5655.4344565543115, 5965.0, 5980.8803823924145, 5984.222051133412, 5989.101634754735, 5993.340732519419, 5487.6158668893595, 5535.308086489189, 5566.805161819398, 5573.972130139324, 5578.24693666358, 5041.193409054534, 5080.415752188472, 5083.517065878736, 5084.898302033938, 5126.307948426989, 6118.20463339763, 6139.815805525842, 6141.447269745744, 6143.447089761943, 6146.354632763585, 5870.47165755067, 5871.794487192928, 5916.230889984275, 5969.8806023878415, 5977.910331344946, 6104.9139292562195, 6109.890546867989, 6129.267100814889, 6129.358790882775, 6134.008014331881, 5792.913106303325, 5847.532197424111, 5848.678322692293, 5851.034579294539, 5880.206172166702, 5848.122781582797, 5882.94117058841, 5903.439173278532, 5911.7635294587735, 5939.2575928009, 5727.398623144676, 5785.247917770663, 5791.0, 5792.0, 5797.2173756542325, 5773.04744717117, 5777.942220577908, 5781.190633311256, 5794.797182098607, 5803.709814509342, 5574.052411090205, 5630.60585758993, 5653.236813030353, 5678.574106942078, 5700.116481945305, 5819.447152520504, 5846.6784326862435, 5893.823185304448, 5908.3796201399955, 5908.7045647718305, 5569.498745112959, 5685.118806584986, 5687.374388817309, 5697.886042279214, 5698.0], "value": 5457.158259313866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.990565141523, 659.858130501942, 668.2482207516541, 669.1769123977507, 678.8879834827254, 44471.555284447146, 45845.770771146184, 45914.770426147865, 45948.310775338396, 49577.752111239395, 46670.0, 46722.76638616811, 47077.76461117698, 47110.528894711046, 47320.52679473204, 8902.73291801247, 9030.909690903105, 9036.051214622468, 9039.141281578273, 9042.773930651754, 8813.38306318558, 8888.111188881125, 8906.0, 8909.331800114986, 8911.77720556988, 8890.644374225023, 8938.4190027648, 8942.284617230605, 8943.060978597252, 8943.552822358888, 8909.509976951265, 8948.597313120925, 8948.73153805387, 8955.462672239653, 8962.551872406353, 8884.244839188677, 8932.240759535447, 8952.552372381355, 8956.507392093432, 8956.910430895672, 42472.575274247174, 42863.78568107139, 42865.57134428647, 43029.784851075856, 43045.56954430447, 3417.2652879631, 3478.286951175003, 3491.0, 3547.9290414191573, 3586.246888153491, 32436.513452298233, 32705.0, 33266.66733332684, 33366.16584585405, 33626.32747345064, 4123.175364926997, 4186.96537070118, 4187.309093999486, 4197.328427451593, 4267.8079486423185, 327243.0, 327552.0, 327768.0, 328021.0, 328422.0, 53584.732076339365, 59314.70342648345, 59948.0, 60237.39762602405, 60313.39686603165, 63513.36486635167, 64814.35185648083, 64985.0, 70286.64856675683, 70464.29535704578, 16146.596335091717, 16309.102999335151, 16314.265858036417, 16347.427840025779, 16379.672406551803, 11320.37737924422, 12018.879811201776, 12137.089718271165, 12274.815877761841, 12303.261804291771, 17721.556961076076, 18224.271029158685, 18278.725819112726, 18365.173567189508, 18405.907970460063, 6127.234095738033, 6191.938080619227, 6267.293925950887, 6274.309825919146, 6329.525285603599, 1008.8890222075565, 1081.124289325633, 1084.5499117865998, 1160.2980196980873, 1250.0, 33436.0, 33472.49791253133, 33566.83216583901, 33694.3261134776, 33753.662463375054, 1093.9507722152523, 1102.3606308341143, 1163.8894305041008, 1217.4886547650008, 1236.6908272931767, 17512.38706645261, 17572.13593970625, 17583.384581539583, 17701.0, 17866.0, 447977.0, 451867.0, 452320.0, 452659.0, 452906.0, 59664.40335596675, 59859.0, 59903.40096599065, 59904.70047649821, 59943.400565994656, 1317.9934100329629, 1381.896357773171, 1418.8510206428382, 1420.5809286260578, 1432.8137342145662, 33313.333733325686, 34058.82970585131, 34342.48486272758, 34467.13832154216, 34701.13247168841, 51358.48641513537, 51873.740631296605, 52017.21974170315, 52035.2194717072, 52058.739706301225, 292763.0, 298872.0, 299206.0, 299603.0, 299839.0, 28336.149915502567, 37052.25895482129, 41286.0, 41839.7908010458, 42810.785946071315, 45310.32034519419, 45549.31676024928, 49302.26046609376, 49317.75341123271, 49795.751021244665, 40642.1871562573, 40878.0, 42209.0, 42599.361009585504, 42876.142477150905, 39798.403023955245, 42471.57528424676, 42797.35803962881, 43469.34795978126, 44019.33970990374, 42149.789251053546, 42611.3608295882, 43327.78336108299, 43523.0, 43613.0, 36614.8169259152, 37452.0, 37580.624193757714, 37849.0, 38174.80912595419, 28698.0, 28776.712232877402, 28838.134855954355, 28918.277043074093, 28928.855355723088], "value": 20284.75604760533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.63606072565034, 413.925493411186, 414.8713898691408, 418.372441337993, 428.3916838089912, 14252.501162459315, 17935.910320448394, 19417.902910485445, 19434.70847937282, 19978.20087196514, 13042.347882605856, 17384.0, 17454.0, 18194.45416637503, 19020.2391904324, 5545.445455454453, 5696.401877802833, 5738.512226460756, 5740.56945729072, 5749.683767392792, 5586.273784408021, 5654.971725141369, 5667.149927510865, 5674.0, 5678.914816277759, 4080.571539988303, 5907.4978626816555, 6198.628082315053, 6212.534059945499, 6324.3991820776955, 6220.782272620482, 6249.0626406039, 6259.061140828867, 6288.0, 6323.30443651198, 5452.291202143736, 5560.471755183251, 5581.386047534768, 5585.106382978704, 5602.579806514487, 21663.26693864487, 21915.452113697127, 22107.115715371365, 22219.55560888773, 22397.776022239734, 2319.4433335999406, 2331.9067237310487, 2720.8503532305717, 3082.33729748103, 3143.025662044751, 13786.310684465736, 14190.716185676332, 14290.64273393163, 14518.274086295749, 14761.55715328542, 1953.8729982551088, 2022.0799536210989, 2056.8354531637433, 2074.668053111495, 2092.487340601562, 81720.59139704323, 83791.0, 84030.57984710099, 84178.57910710407, 84689.57655211746, 10752.623658171926, 10974.341539507495, 10976.396298203676, 10993.06747950179, 11038.11695064393, 15174.393024279127, 15364.692706145814, 15382.923085384726, 15413.691726165638, 15433.45982890616, 7983.2415920487465, 8195.508269503729, 8223.794405139799, 8329.416940814084, 8399.11809260031, 7853.136155022943, 7878.251566101326, 7920.168382319889, 8022.9598852005365, 8062.637181326737, 5897.321807992136, 6312.400321969406, 6533.934660653427, 6763.628000460022, 6771.187457505032, 1947.2503086311588, 1948.298612499499, 1995.6806910894188, 2039.1435597048978, 2044.6217449771543, 941.7928055827707, 1013.4172850610928, 1070.7216123807866, 1079.3577821196375, 1081.978360432787, 18441.354552590594, 19022.61954760897, 19038.524036899187, 19202.40767496398, 19234.519137021685, 1030.6547306652205, 1033.607229252894, 1060.0512541275668, 1082.626493859617, 1095.3263742798122, 10631.681049568526, 11054.060404865677, 11057.557697692002, 11059.668209953714, 11091.44542772858, 487323.0, 492368.0, 493114.0, 495607.0, 499620.0, 62255.0, 72895.0, 79852.6007369971, 106315.0, 107651.0, 1085.6254592165849, 1096.9286996345372, 1116.7989761842784, 1123.5168877382803, 1127.537709539085, 16730.4144354947, 17025.31898724037, 17162.485125446256, 17283.308667653153, 17304.826951730323, 38627.42058869063, 38914.80542597269, 42841.35737963995, 43529.56470435255, 44929.55070449254, 55864.0, 57787.711061444425, 58356.70821646034, 59113.0, 59586.0, 8601.65593376283, 8823.647054117764, 8875.778105547155, 8933.865992009994, 9093.863592045993, 12357.814632780335, 13330.26683532415, 13463.663408414868, 13740.038197326092, 13819.792703109662, 11675.941620291844, 11730.413479326171, 11739.530418783153, 12115.333656648969, 12449.315287659265, 12090.790920907839, 12108.152429330215, 12311.445984930879, 12417.31704756211, 12625.431855566705, 12257.632271031884, 12347.506099756269, 12617.053720971147, 12651.93674031624, 12683.42924568415, 7637.198094200251, 8001.0, 8859.424137431046, 8961.417507861968, 9068.455892646462, 11757.941210293893, 12098.455569499218, 12157.939210304246, 12194.75610487803, 12241.69395765113], "value": 9525.173305471895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.8474125475573, 1545.7526795712688, 1586.9841301586985, 1780.1010489702699, 1897.260068573256, 8469.0, 8844.336674749395, 8852.008298132916, 9112.726618201465, 9123.224525915288, 8773.29813614911, 8998.68504602339, 9060.275177985763, 9062.320325975545, 9066.546672666356, 2133.1893880325533, 2338.2634470141934, 2378.1676413255395, 2406.566817972764, 2414.5653782319177, 2433.1285912423186, 2449.461118553915, 2451.191106934716, 2460.2250291158316, 2464.5933420985516, 2320.118355025088, 2321.117975169433, 2340.3914982104607, 2344.6014177589764, 2347.882605869708, 2061.783512731164, 2300.6894069300597, 2372.8457650252676, 2375.2874137758604, 2390.8924098415614, 2330.731965823935, 2331.405491599648, 2341.5316936612744, 2342.5783358995373, 2364.7517010713973, 8910.242629376511, 9015.14356136166, 9017.594208260578, 9033.50315732641, 9043.593038313225, 5098.821541246076, 5283.049051170788, 5289.603279754034, 5291.788328466857, 5298.788048478056, 3445.896623101311, 3482.8084455354947, 3512.5082488451635, 3660.6156353582755, 3697.131174174067, 1162.4768854015642, 1168.631880957504, 1191.9702007449796, 1206.8129439936824, 1211.5698926880918, 11990.940045299805, 12253.326067066308, 12274.140810143293, 12296.446659900326, 12297.3236471994, 4584.679072464962, 4719.079779442975, 4810.518948105231, 4826.276058591239, 4832.864276894927, 10569.312994655476, 10572.894271057345, 10590.417527035934, 10618.0, 10631.096356809758, 4903.53416425439, 5274.182501712241, 5380.488853558905, 5390.272313237741, 5402.108652072364, 4608.516105808909, 4745.406824146981, 4763.118823017753, 4786.090642777931, 4790.760461976887, 4016.879493615196, 4053.1369143861402, 4149.875503734893, 4180.623743863067, 4189.560096189917, 1298.4157129291857, 1298.8506321772927, 1308.6270412932458, 1323.8742319479634, 1339.71196192819, 902.0, 1021.6168936648756, 1023.3194925374543, 1027.244974943416, 1032.6643840751635, 5804.448577385142, 5933.3473317934995, 6006.249218847644, 6016.909746353808, 6181.474574661114, 455.41251785197386, 457.0, 461.08704764565675, 462.4681616141464, 472.11714094642554, 4133.937990930139, 4258.61672449481, 4326.697131200849, 4424.491183513873, 4503.752293623882, 10963.50664220112, 11283.943580282046, 11327.263727857662, 11383.487743051583, 11481.311121332747, 11313.20807543464, 11317.547298108148, 11335.376554289593, 11348.602798902164, 11398.20212585111, 7906.327962123284, 8090.352771778244, 8270.421070525006, 8279.95860020696, 8374.748757537283, 6150.661713605795, 6303.306636270098, 6328.128120132608, 6338.936610634019, 6344.111824344688, 10137.138343240613, 10294.948525257325, 10420.947895260475, 10500.317479363817, 10595.629152979609, 10533.0, 10539.631112911318, 10544.736381590521, 10654.414007229367, 10696.465176741287, 7294.379977701955, 7755.7203061496475, 7971.601419929097, 7982.880256796268, 8153.9184608153155, 8766.386352955233, 8788.209061184269, 8830.116988301119, 8873.778155546162, 8889.422187557788, 7452.515586486861, 7635.923640763522, 7644.503107298008, 7722.111957125003, 7732.574708390867, 7569.091708994735, 7615.276548727862, 7773.727919522789, 7864.84270314579, 7891.289783919475, 7193.208747037717, 7203.8919416207755, 7206.099237595301, 7278.381337586153, 7280.9271907280245, 5283.762230699705, 5311.336082989626, 5376.435474275145, 5445.237666726741, 5453.672779633234, 5271.762770675406, 5364.168553874156, 5434.755436005468, 5461.098918678374, 5467.835964921059], "value": 4661.534310396154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8486858216676, 349.5420998491976, 351.2097779995011, 353.16828868015835, 356.3300994131033, 5321.255024296597, 5425.538829199523, 5430.348358197017, 5449.700266485347, 5451.863703407417, 5295.894082118365, 5309.654872433289, 5348.411674715788, 5366.275552800371, 5389.676619402839, 3902.356111241642, 4076.8165432555534, 4175.415441838145, 4221.113566151096, 4233.6824738144605, 4122.9381559276635, 4165.146145040259, 4211.115665710189, 4218.409422680827, 4244.405783190356, 4060.4112403701447, 4214.199302132585, 4221.915561688765, 4226.513950895655, 4236.851710190144, 4120.711550191488, 4209.65291106846, 4213.894652633678, 4224.831006759726, 4228.830846766125, 3767.585565587783, 3770.377887648535, 3782.9054273643105, 3798.1833905710128, 3808.428735689641, 5091.592672586185, 5100.642954993152, 5127.359245041588, 5142.331496905415, 5204.115300398941, 4885.193942999401, 4900.730459824708, 4915.631327650405, 4928.940277840282, 4930.753462326869, 5323.787048518055, 5462.535684466825, 5480.80817171401, 5591.664500129965, 5655.632383895034, 3960.683145348365, 4064.5325787534516, 4064.7764372959477, 4152.854650087233, 4158.542560318362, 5614.775408983635, 5733.913991290134, 5765.221695071154, 5775.537956963432, 5777.717801468439, 4152.563980782034, 4202.138561594866, 4235.851745188904, 4239.300515414983, 4256.1487702459635, 4299.462567179103, 4308.9569104309185, 4314.374415709767, 4315.266404711207, 4316.136772645421, 4815.711057336571, 4823.758812059383, 4828.348172996671, 4843.0, 4854.980454104607, 5490.972545137249, 5581.134924086773, 5605.654642885678, 5631.18347839561, 5659.688717120598, 1459.8248410029817, 1466.4354223623768, 1472.63184203949, 1473.786300986351, 1480.25247250138, 958.5686441101532, 960.9327347085776, 975.7609385700549, 993.777653486216, 994.9104580587782, 4774.066503066264, 4794.7842347094465, 4800.5199480051715, 4807.95192048082, 4815.036992601494, 5055.0, 5107.8252002039735, 5109.20807274873, 5133.743312834418, 5143.614228932845, 4492.146492166478, 4778.259369797687, 4812.484067518791, 4845.466998630148, 4852.369192005017, 2679.571268597015, 2750.2574304937957, 2758.544840101401, 2769.7507224349906, 2773.724086919999, 5306.787728490817, 5319.6808191508635, 5327.573794096541, 5332.786688532416, 5357.276767636319, 5190.480951904855, 5190.662606930538, 5475.0, 5906.350301466835, 5912.497437717842, 5725.425507985337, 5865.530757539302, 5940.61386009908, 5954.46409823118, 5962.880742385128, 5746.13807928814, 5749.8275051748515, 5780.2081354778475, 5807.912881306868, 5831.591788574929, 5706.629069110494, 5712.485876271156, 5731.942680573141, 5733.283339582552, 5748.252727145445, 5611.240290901766, 5921.3782552831335, 5925.733341999534, 5930.199423077829, 5952.404759524013, 4140.544540100526, 4150.750954942713, 4182.142660754599, 4228.344606585984, 4237.131388065501, 5675.801346952837, 5865.765369385347, 5899.823005309848, 5910.7340169693325, 5916.31962324321, 5574.609777315549, 5590.2453168821685, 5615.045442274742, 5676.886462270649, 5678.2050512929045, 5634.211210430461, 5648.5763567731765, 5681.721612637289, 5685.829425117253, 5697.7720891165545, 5305.257263982969, 5490.890182196414, 5526.613137080366, 5534.612577119724, 5606.831795046155, 5636.689982051026, 5648.435156484319, 5657.094864821609, 5668.886622267614, 5676.091825307931, 5465.508104270635, 5505.091659876076, 5505.2933590587045, 5512.889742205213, 5536.833894983157], "value": 4241.44858601623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.2449733996052, 834.2158371131136, 835.7785186925462, 860.2257967828954, 902.575789378992, 14125.576232713021, 14679.926600366984, 14710.852891471082, 14737.705245895075, 14742.26288685564, 13491.932540337284, 13554.796678049812, 13568.457261709544, 13577.117487363315, 13581.320933953311, 697.3549466743242, 818.7011740714626, 829.6681327469031, 843.4348986179275, 850.2857599616322, 837.8785076163953, 842.8904242448504, 844.2486187293283, 844.4637655089032, 845.0915266088948, 893.352319568311, 896.3635818568791, 896.8878890138733, 898.1333013641835, 899.4063917814244, 739.1425945902754, 865.2558799432483, 884.6284560484612, 885.1679421343916, 895.0691281067682, 647.9416852483251, 649.0556240669814, 649.2825427902195, 650.1450592470885, 650.4633677216316, 13240.404181811842, 13265.0, 13292.667683307898, 13295.468181272738, 13296.26870522121, 12656.746865062647, 12898.548550800771, 13241.867581324255, 13262.535811246657, 13411.396487158101, 11483.253588516804, 11508.367039812807, 11515.25150865191, 11760.823587646191, 11809.586664466788, 4220.180736433533, 4314.82740690372, 4380.802863871133, 4456.086502267028, 4470.41884555009, 50924.745376273255, 51255.23117153208, 51677.48322516764, 52198.21702674463, 52342.47657523414, 9849.409035457895, 9897.406155630686, 10041.548130334153, 10238.641647542301, 10724.356538607552, 18659.0, 18767.90616046911, 18833.340833070775, 18932.621347573247, 18936.147873345733, 7495.700171993169, 7543.660535275926, 7649.655765490566, 7654.158042615308, 7687.884681729778, 4246.44796176495, 4264.744115353089, 4598.701084429501, 4738.691985020962, 4775.880602984884, 3380.2225488137865, 3612.927741445209, 3623.8912832614537, 3628.0385697790107, 3635.90922723182, 562.1483452569361, 696.2515296056658, 696.435886931587, 697.849962258117, 703.8838591632426, 611.8500967263049, 649.7141257846532, 664.020569659748, 677.9830504237335, 714.589111261027, 9490.430574165572, 9830.459324737065, 9858.95070524657, 9917.504124793732, 9991.0, 714.292850078429, 728.1189760389882, 754.0687251244708, 754.9282818132268, 774.9573773442402, 4433.534478879736, 4537.8411755588395, 4584.587387135174, 4601.792919318638, 4609.147307748078, 68995.0, 70705.2929470709, 71040.0, 71077.28922710707, 72353.63823180851, 61944.380556193864, 63144.68427657832, 63800.68099659565, 63820.0, 65463.67268163724, 56912.71543642255, 57089.71455142781, 57531.42468575261, 57802.42197578055, 58832.0, 8786.780330491789, 8843.823123537364, 8911.777205569913, 8943.508107054175, 8992.28061755045, 34773.47839782355, 35429.0, 36185.81907090448, 36654.450183246736, 37085.62914370822, 44929.0, 48815.02369952652, 49363.50636493589, 50015.749921250164, 50352.24471633002, 11142.108631309638, 11148.498317575566, 11200.43997800123, 11577.594784182513, 11704.473298701409, 11629.18595698293, 11639.359835209145, 11985.921267086003, 12721.491140354283, 12814.167079139826, 11527.711807204887, 11987.580434684744, 12358.691032724253, 12371.814422783846, 12594.370281486072, 11459.0, 11661.6501504955, 11951.940240298743, 11954.10344224204, 12182.878171218174, 11479.024282936043, 11949.0, 12034.75930481403, 12301.93849030785, 12319.076069294659, 9177.77055573616, 9637.22902167839, 9746.366486178376, 9925.65260215889, 9999.35004224723, 10058.893521712753, 10120.746981325527, 10591.841122383325, 10722.678319650424, 10746.0], "value": 6792.582344194006, "unit": "score"}], "name": "dromaeo_css", "value": 7219.748390879615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 112.0, 110.0, 113.0, 111.0, 110.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 153.0, 218.0, 126.0, 156.0, 147.0, 126.0, 179.0, 137.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 158.0, 75.0, 75.0, 75.0, 73.0, 128.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 147.0, 92.0, 93.0, 92.0, 135.0, 92.0, 92.0, 141.0], "value": 106.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 119.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 63.0, 110.0, 56.0, 55.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 57.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 79.0, 83.0, 78.0, 79.0, 79.0, 85.0, 80.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 138.0, 122.0, 135.0, 131.0, 129.0, 137.0, 235.0, 132.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 162.0, 162.0, 166.0, 163.0, 164.0, 166.0, 169.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 67.0, 64.0, 65.0, 64.0, 63.0, 62.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1549.0000000000002, "alertThreshold": 2.0}]} 13:30:29 INFO - Return code: 0 13:30:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:30:29 ERROR - # TBPL SUCCESS # 13:30:29 INFO - Running post-action listener: _resource_record_post_action 13:30:29 INFO - ##### 13:30:29 INFO - ##### Finished run-tests step (success) 13:30:29 INFO - ##### 13:30:29 INFO - Running post-run listener: _resource_record_post_run 13:30:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 537710592; Read time: 0; Write time: 729712 13:30:30 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251211776; Read time: 0; Write time: 408328 13:30:30 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 286498816; Read time: 0; Write time: 321384 13:30:30 INFO - Running post-run listener: _upload_blobber_files 13:30:30 INFO - Blob upload gear active. 13:30:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:30:30 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 13:30:30 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'] 13:30:30 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 13:30:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:31 INFO - (blobuploader) - INFO - Done attempting. 13:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:32 INFO - (blobuploader) - INFO - Done attempting. 13:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:32 INFO - Return code: 0 13:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901907287af7f5800fc20d150904cca85ae29936a90f48fadf2322236ec4cc7da41684b3dfd3d25f50a3915cd0d82691087ae8b52a3727542b0b4ad64b5761c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3063587f49ddf4e755ec2f16405a5ab0a6f9dc8ff9bee2237570f9e717ffc32847c9d57eeea0a3cafd5a9bde8bc40ae1fe452fc2acedc2007b409261bb3c37db"} 13:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:32 INFO - Contents: 13:30:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901907287af7f5800fc20d150904cca85ae29936a90f48fadf2322236ec4cc7da41684b3dfd3d25f50a3915cd0d82691087ae8b52a3727542b0b4ad64b5761c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3063587f49ddf4e755ec2f16405a5ab0a6f9dc8ff9bee2237570f9e717ffc32847c9d57eeea0a3cafd5a9bde8bc40ae1fe452fc2acedc2007b409261bb3c37db"} 13:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:32 INFO - Copying logs to upload dir... 13:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.269442 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-11 13:30:33.182877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 13:30:33.192943) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 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/901907287af7f5800fc20d150904cca85ae29936a90f48fadf2322236ec4cc7da41684b3dfd3d25f50a3915cd0d82691087ae8b52a3727542b0b4ad64b5761c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3063587f49ddf4e755ec2f16405a5ab0a6f9dc8ff9bee2237570f9e717ffc32847c9d57eeea0a3cafd5a9bde8bc40ae1fe452fc2acedc2007b409261bb3c37db"} build_url:https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/Ja2kUphES8aukwqBa1x3DQ/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/901907287af7f5800fc20d150904cca85ae29936a90f48fadf2322236ec4cc7da41684b3dfd3d25f50a3915cd0d82691087ae8b52a3727542b0b4ad64b5761c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3063587f49ddf4e755ec2f16405a5ab0a6f9dc8ff9bee2237570f9e717ffc32847c9d57eeea0a3cafd5a9bde8bc40ae1fe452fc2acedc2007b409261bb3c37db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 13:30:33.217035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:30:33.217367) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462997397.697503-1750978643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:30:33.269227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 13:30:33.271652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 13:30:33.272033) ========= ========= Total master_lag: 0.56 =========