builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1462984092.84 results: success (0) buildid: 20160511081810 builduid: f731616e298249f78851349ee13ba990 revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.839555) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.840268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.840760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.859246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.859847) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 09:28:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-11 09:28:13 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089530 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.965871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:12.966413) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014490 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.016605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.016967) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a67f6710c37cce1c11882eceefceaaef0b5a9076 --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 a67f6710c37cce1c11882eceefceaaef0b5a9076 --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=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 09:28:13,358 truncating revision to first 12 chars 2016-05-11 09:28:13,358 Setting DEBUG logging. 2016-05-11 09:28:13,358 attempt 1/10 2016-05-11 09:28:13,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a67f6710c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 09:28:13,751 unpacking tar archive at: fx-team-a67f6710c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.715568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.715915) ========= script_repo_revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.716331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.716595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 09:28:13.726466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-11 09:28:13.726825) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:14 INFO - MultiFileLogger online at 20160511 09:28:14 in /builds/slave/test 09:28:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:28:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:14 INFO - {'append_to_log': False, 09:28:14 INFO - 'base_work_dir': '/builds/slave/test', 09:28:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:28:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:28:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:14 INFO - 'config_files': ('talos/linux_config.py',), 09:28:14 INFO - 'default_actions': ('clobber', 09:28:14 INFO - 'read-buildbot-config', 09:28:14 INFO - 'download-and-extract', 09:28:14 INFO - 'populate-webroot', 09:28:14 INFO - 'create-virtualenv', 09:28:14 INFO - 'install', 09:28:14 INFO - 'run-tests'), 09:28:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:14 INFO - 'download_minidump_stackwalk': True, 09:28:14 INFO - 'download_symbols': 'ondemand', 09:28:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:14 INFO - 'installer_path': 'installer.exe', 09:28:14 INFO - 'log_level': 'info', 09:28:14 INFO - 'log_name': 'talos', 09:28:14 INFO - 'log_to_console': True, 09:28:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:14 INFO - 'opt_config_files': (), 09:28:14 INFO - 'pip_index': False, 09:28:14 INFO - 'sps_profile': False, 09:28:14 INFO - 'sps_profile_interval': 0, 09:28:14 INFO - 'suite': 'dromaeojs', 09:28:14 INFO - 'system_bits': '32', 09:28:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:14 INFO - 'title': 'talos-linux64-ix-049', 09:28:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:14 INFO - 'use_talos_json': True, 09:28:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:14 INFO - 'work_dir': 'build'} 09:28:14 INFO - ##### 09:28:14 INFO - ##### Running clobber step. 09:28:14 INFO - ##### 09:28:14 INFO - Running pre-action listener: _resource_record_pre_action 09:28:14 INFO - Running main action method: clobber 09:28:14 INFO - rmtree: /builds/slave/test/build 09:28:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:14 INFO - Running post-action listener: _resource_record_post_action 09:28:14 INFO - ##### 09:28:14 INFO - ##### Finished clobber step (success) 09:28:14 INFO - ##### 09:28:14 INFO - ##### 09:28:14 INFO - ##### Running read-buildbot-config step. 09:28:14 INFO - ##### 09:28:14 INFO - Running pre-action listener: _resource_record_pre_action 09:28:14 INFO - Running main action method: read_buildbot_config 09:28:14 INFO - Using buildbot properties: 09:28:14 INFO - { 09:28:14 INFO - "project": "", 09:28:14 INFO - "product": "firefox", 09:28:14 INFO - "script_repo_revision": "production", 09:28:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:28:14 INFO - "repository": "", 09:28:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:28:14 INFO - "buildid": "20160511081810", 09:28:14 INFO - "pgo_build": "False", 09:28:14 INFO - "basedir": "/builds/slave/test", 09:28:14 INFO - "buildnumber": 2964, 09:28:14 INFO - "slavename": "talos-linux64-ix-049", 09:28:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:28:14 INFO - "platform": "ubuntu64_hw", 09:28:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:28:14 INFO - "branch": "fx-team", 09:28:14 INFO - "repo_path": "integration/fx-team", 09:28:14 INFO - "revision": "a67f6710c37cce1c11882eceefceaaef0b5a9076", 09:28:14 INFO - "stage_platform": "linux64", 09:28:14 INFO - "builduid": "f731616e298249f78851349ee13ba990", 09:28:14 INFO - "slavebuilddir": "test" 09:28:14 INFO - } 09:28:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:28:14 INFO - Running post-action listener: _resource_record_post_action 09:28:14 INFO - ##### 09:28:14 INFO - ##### Finished read-buildbot-config step (success) 09:28:14 INFO - ##### 09:28:14 INFO - ##### 09:28:14 INFO - ##### Running download-and-extract step. 09:28:14 INFO - ##### 09:28:14 INFO - Running pre-action listener: _resource_record_pre_action 09:28:14 INFO - Running main action method: download_and_extract 09:28:14 INFO - mkdir: /builds/slave/test/build/tests 09:28: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')]} 09:28:14 INFO - https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:15 INFO - Downloaded 1361 bytes. 09:28:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:28:15 INFO - Using the following test package requirements: 09:28:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:28:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:28:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:28:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'jsshell-linux-x86_64.zip'], 09:28:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:28:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:28:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:28:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:28:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:28:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:28:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:28:15 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')]} 09:28:15 INFO - https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:16 INFO - Downloaded 22329056 bytes. 09:28:16 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'] 09:28:16 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 09:28:17 INFO - Return code: 0 09:28:17 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 09:28: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')]} 09:28:17 INFO - https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:18 INFO - Downloaded 22329056 bytes. 09:28:18 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'] 09:28:18 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 09:28:20 INFO - Return code: 0 09:28:20 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')]} 09:28:20 INFO - https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:28:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:28:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:28:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:21 INFO - Downloaded 10840152 bytes. 09:28:21 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'] 09:28:21 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 09:28:21 INFO - Return code: 0 09:28:21 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')]} 09:28:21 INFO - https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoNK1jXTTO6aNwEUcljMOA/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 09:28:24 INFO - Downloaded 54681825 bytes. 09:28:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:28:24 INFO - mkdir: /builds/slave/test/properties 09:28:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:28:24 INFO - Writing to file /builds/slave/test/properties/build_url 09:28:24 INFO - Contents: 09:28:24 INFO - build_url:https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:28:25 INFO - Running post-action listener: _resource_record_post_action 09:28:25 INFO - Running post-action listener: set_extra_try_arguments 09:28:25 INFO - ##### 09:28:25 INFO - ##### Finished download-and-extract step (success) 09:28:25 INFO - ##### 09:28:25 INFO - ##### 09:28:25 INFO - ##### Running populate-webroot step. 09:28:25 INFO - ##### 09:28:25 INFO - Running pre-action listener: _resource_record_pre_action 09:28:25 INFO - Running main action method: populate_webroot 09:28:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:28:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:28:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:28:25 INFO - '--tppagecycles', 09:28:25 INFO - '7'], 09:28:25 INFO - 'tests': ['tsvgm']}}, 09:28:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:28:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:28:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:28:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:28:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['damp', 'tps']}, 09:28:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'tests': ['damp', 'tps']}, 09:28:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['dromaeo_dom']}, 09:28:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:28:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'other-e10s': {'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['a11yr', 09:28:25 INFO - 'ts_paint', 09:28:25 INFO - 'tpaint', 09:28:25 INFO - 'sessionrestore', 09:28:25 INFO - 'sessionrestore_no_auto_restore', 09:28:25 INFO - 'tabpaint']}, 09:28:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['tsvgx', 09:28:25 INFO - 'tsvgr_opacity', 09:28:25 INFO - 'tart', 09:28:25 INFO - 'tscrollx', 09:28:25 INFO - 'cart']}, 09:28:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:28:25 INFO - 'tsvgr_opacity', 09:28:25 INFO - 'tart', 09:28:25 INFO - 'tscrollx', 09:28:25 INFO - 'cart']}, 09:28:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'talos_options': ['--disable-e10s'], 09:28:25 INFO - 'tests': ['tp5o']}, 09:28:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'tests': ['tp5o']}, 09:28:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'talos_options': ['--disable-e10s', 09:28:25 INFO - '--xperf_path', 09:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:25 INFO - 'tests': ['tp5n']}, 09:28:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:28:25 INFO - 'talos_options': ['--xperf_path', 09:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:25 INFO - 'tests': ['tp5n']}}, 09:28:25 INFO - 'talos.zip': {'path': '', 09:28:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:28:25 INFO - Running post-action listener: _resource_record_post_action 09:28:25 INFO - ##### 09:28:25 INFO - ##### Finished populate-webroot step (success) 09:28:25 INFO - ##### 09:28:25 INFO - ##### 09:28:25 INFO - ##### Running create-virtualenv step. 09:28:25 INFO - ##### 09:28:25 INFO - Running pre-action listener: _resource_record_pre_action 09:28:25 INFO - Running main action method: create_virtualenv 09:28:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:28:25 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 09:28:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:28:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:28:26 INFO - Using real prefix '/usr' 09:28:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:28:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:28:28 INFO - Installing pip.................done. 09:28:28 INFO - Return code: 0 09:28:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:28:28 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')]} 09:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:28 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')]} 09:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:28 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:28 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 09:28:28 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 09:28:28 INFO - Using env: {'DISPLAY': ':0', 09:28:28 INFO - 'HOME': '/home/cltbld', 09:28:28 INFO - 'LANG': 'en_US.UTF-8', 09:28:28 INFO - 'LANGUAGE': 'en_US:en', 09:28:28 INFO - 'LOGNAME': 'cltbld', 09:28:28 INFO - 'MAIL': '/var/mail/cltbld', 09:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:28 INFO - 'MOZ_NO_REMOTE': '1', 09:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:28 INFO - 'NO_EM_RESTART': '1', 09:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:28 INFO - 'PWD': '/builds/slave/test', 09:28:28 INFO - 'SHELL': '/bin/bash', 09:28:28 INFO - 'SHLVL': '1', 09:28:28 INFO - 'TERM': 'linux', 09:28:28 INFO - 'TMOUT': '86400', 09:28:28 INFO - 'USER': 'cltbld', 09:28:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:28 INFO - '_': '/tools/buildbot/bin/python'} 09:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:28 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 09:28:28 INFO - Cleaning up... 09:28:28 INFO - Return code: 0 09:28:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:28:28 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')]} 09:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:28 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')]} 09:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:28 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:28 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 09:28:28 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 09:28:28 INFO - Using env: {'DISPLAY': ':0', 09:28:28 INFO - 'HOME': '/home/cltbld', 09:28:28 INFO - 'LANG': 'en_US.UTF-8', 09:28:28 INFO - 'LANGUAGE': 'en_US:en', 09:28:28 INFO - 'LOGNAME': 'cltbld', 09:28:28 INFO - 'MAIL': '/var/mail/cltbld', 09:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:28 INFO - 'MOZ_NO_REMOTE': '1', 09:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:28 INFO - 'NO_EM_RESTART': '1', 09:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:28 INFO - 'PWD': '/builds/slave/test', 09:28:28 INFO - 'SHELL': '/bin/bash', 09:28:28 INFO - 'SHLVL': '1', 09:28:28 INFO - 'TERM': 'linux', 09:28:28 INFO - 'TMOUT': '86400', 09:28:28 INFO - 'USER': 'cltbld', 09:28:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:28 INFO - '_': '/tools/buildbot/bin/python'} 09:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:28 INFO - Downloading/unpacking psutil>=0.7.1 09:28:28 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 09:28:28 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 09:28:28 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 09:28:28 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 09:28:28 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 09:28:28 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 09:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:28:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:30 INFO - Installing collected packages: psutil 09:28:30 INFO - Running setup.py install for psutil 09:28:31 INFO - building 'psutil._psutil_linux' extension 09:28:31 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 09:28:31 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 09:28:31 INFO - building 'psutil._psutil_posix' extension 09:28:31 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 09:28:31 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 09:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:31 INFO - Successfully installed psutil 09:28:31 INFO - Cleaning up... 09:28:31 INFO - Return code: 0 09:28:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:28:31 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')]} 09:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:31 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')]} 09:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:31 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:31 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 09:28:31 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 09:28:31 INFO - Using env: {'DISPLAY': ':0', 09:28:31 INFO - 'HOME': '/home/cltbld', 09:28:31 INFO - 'LANG': 'en_US.UTF-8', 09:28:31 INFO - 'LANGUAGE': 'en_US:en', 09:28:31 INFO - 'LOGNAME': 'cltbld', 09:28:31 INFO - 'MAIL': '/var/mail/cltbld', 09:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:31 INFO - 'MOZ_NO_REMOTE': '1', 09:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:31 INFO - 'NO_EM_RESTART': '1', 09:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:31 INFO - 'PWD': '/builds/slave/test', 09:28:31 INFO - 'SHELL': '/bin/bash', 09:28:31 INFO - 'SHLVL': '1', 09:28:31 INFO - 'TERM': 'linux', 09:28:31 INFO - 'TMOUT': '86400', 09:28:31 INFO - 'USER': 'cltbld', 09:28:31 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:31 INFO - '_': '/tools/buildbot/bin/python'} 09:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:28:31 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 09:28:31 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 09:28:31 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 09:28:31 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 09:28:31 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 09:28:31 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 09:28:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:28:33 INFO - Installing collected packages: mozsystemmonitor 09:28:33 INFO - Running setup.py install for mozsystemmonitor 09:28:33 INFO - Successfully installed mozsystemmonitor 09:28:33 INFO - Cleaning up... 09:28:33 INFO - Return code: 0 09:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:28: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')]} 09:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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')]} 09:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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', '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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:28: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 blobuploader==1.2.4 09:28:33 INFO - Using env: {'DISPLAY': ':0', 09:28:33 INFO - 'HOME': '/home/cltbld', 09:28:33 INFO - 'LANG': 'en_US.UTF-8', 09:28:33 INFO - 'LANGUAGE': 'en_US:en', 09:28:33 INFO - 'LOGNAME': 'cltbld', 09:28:33 INFO - 'MAIL': '/var/mail/cltbld', 09:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:33 INFO - 'MOZ_NO_REMOTE': '1', 09:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:33 INFO - 'NO_EM_RESTART': '1', 09:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:33 INFO - 'PWD': '/builds/slave/test', 09:28:33 INFO - 'SHELL': '/bin/bash', 09:28:33 INFO - 'SHLVL': '1', 09:28:33 INFO - 'TERM': 'linux', 09:28:33 INFO - 'TMOUT': '86400', 09:28:33 INFO - 'USER': 'cltbld', 09:28:33 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:33 INFO - '_': '/tools/buildbot/bin/python'} 09:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:28:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:28:36 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 09:28:36 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 09:28:36 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 09:28:36 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 09:28:36 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 09:28:36 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 09:28:36 INFO - Downloading docopt-0.6.1.tar.gz 09:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:28:36 INFO - Running setup.py install for blobuploader 09:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:28:36 INFO - Running setup.py install for requests 09:28:37 INFO - Running setup.py install for docopt 09:28:37 INFO - Successfully installed blobuploader requests docopt 09:28:37 INFO - Cleaning up... 09:28:37 INFO - Return code: 0 09:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:37 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')]} 09:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:37 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')]} 09:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:37 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:37 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 09:28:37 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 09:28:37 INFO - Using env: {'DISPLAY': ':0', 09:28:37 INFO - 'HOME': '/home/cltbld', 09:28:37 INFO - 'LANG': 'en_US.UTF-8', 09:28:37 INFO - 'LANGUAGE': 'en_US:en', 09:28:37 INFO - 'LOGNAME': 'cltbld', 09:28:37 INFO - 'MAIL': '/var/mail/cltbld', 09:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:37 INFO - 'MOZ_NO_REMOTE': '1', 09:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:37 INFO - 'NO_EM_RESTART': '1', 09:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:37 INFO - 'PWD': '/builds/slave/test', 09:28:37 INFO - 'SHELL': '/bin/bash', 09:28:37 INFO - 'SHLVL': '1', 09:28:37 INFO - 'TERM': 'linux', 09:28:37 INFO - 'TMOUT': '86400', 09:28:37 INFO - 'USER': 'cltbld', 09:28:37 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:37 INFO - '_': '/tools/buildbot/bin/python'} 09:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:37 INFO - Running setup.py (path:/tmp/pip-flpO4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:37 INFO - Running setup.py (path:/tmp/pip-cm3dhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:37 INFO - Running setup.py (path:/tmp/pip-OdM5Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:37 INFO - Running setup.py (path:/tmp/pip-aDvJNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:37 INFO - Running setup.py (path:/tmp/pip-sImV_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:37 INFO - Running setup.py (path:/tmp/pip-mV1B7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:37 INFO - Running setup.py (path:/tmp/pip-hAWCeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:37 INFO - Running setup.py (path:/tmp/pip-dJCkj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:37 INFO - Running setup.py (path:/tmp/pip-Nh4nDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:38 INFO - Running setup.py (path:/tmp/pip-CngP6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:38 INFO - Running setup.py (path:/tmp/pip-MWKE2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:38 INFO - Running setup.py (path:/tmp/pip-rPv5GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:38 INFO - Running setup.py (path:/tmp/pip-WDTNWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:38 INFO - Running setup.py (path:/tmp/pip-WtqB8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:38 INFO - Running setup.py (path:/tmp/pip-OjafBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:38 INFO - Running setup.py (path:/tmp/pip-AEhj24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:38 INFO - Running setup.py (path:/tmp/pip-L66m4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:28:38 INFO - Running setup.py install for manifestparser 09:28:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:28:38 INFO - Running setup.py install for mozcrash 09:28:38 INFO - Running setup.py install for mozdebug 09:28:38 INFO - Running setup.py install for mozdevice 09:28:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozfile 09:28:39 INFO - Running setup.py install for mozhttpd 09:28:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozinfo 09:28:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozInstall 09:28:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozleak 09:28:39 INFO - Running setup.py install for mozlog 09:28:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for moznetwork 09:28:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozprocess 09:28:39 INFO - Running setup.py install for mozprofile 09:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:28:39 INFO - Running setup.py install for mozrunner 09:28:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:28:40 INFO - Running setup.py install for mozscreenshot 09:28:40 INFO - Running setup.py install for moztest 09:28:40 INFO - Running setup.py install for mozversion 09:28:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:28:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:28:40 INFO - Cleaning up... 09:28:40 INFO - Return code: 0 09:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:40 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 09:28:40 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 09:28:40 INFO - Using env: {'DISPLAY': ':0', 09:28:40 INFO - 'HOME': '/home/cltbld', 09:28:40 INFO - 'LANG': 'en_US.UTF-8', 09:28:40 INFO - 'LANGUAGE': 'en_US:en', 09:28:40 INFO - 'LOGNAME': 'cltbld', 09:28:40 INFO - 'MAIL': '/var/mail/cltbld', 09:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:40 INFO - 'MOZ_NO_REMOTE': '1', 09:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:40 INFO - 'NO_EM_RESTART': '1', 09:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:40 INFO - 'PWD': '/builds/slave/test', 09:28:40 INFO - 'SHELL': '/bin/bash', 09:28:40 INFO - 'SHLVL': '1', 09:28:40 INFO - 'TERM': 'linux', 09:28:40 INFO - 'TMOUT': '86400', 09:28:40 INFO - 'USER': 'cltbld', 09:28:40 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:40 INFO - '_': '/tools/buildbot/bin/python'} 09:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:40 INFO - Running setup.py (path:/tmp/pip-4haqnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:40 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)) 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:40 INFO - Running setup.py (path:/tmp/pip-QOAeU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:40 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)) 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:40 INFO - Running setup.py (path:/tmp/pip-lNl9pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:40 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)) 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:40 INFO - Running setup.py (path:/tmp/pip-5Z9T54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:40 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)) 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:40 INFO - Running setup.py (path:/tmp/pip-YnwCa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:40 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)) 09:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:40 INFO - Running setup.py (path:/tmp/pip-XBi4r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:41 INFO - Running setup.py (path:/tmp/pip-UYd7Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:41 INFO - Running setup.py (path:/tmp/pip-0ALcQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:41 INFO - Running setup.py (path:/tmp/pip-OQzqzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:41 INFO - Running setup.py (path:/tmp/pip-H49JRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:41 INFO - Running setup.py (path:/tmp/pip-PoVfr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:41 INFO - Running setup.py (path:/tmp/pip-uBpYSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:41 INFO - Running setup.py (path:/tmp/pip-VktgCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:41 INFO - Running setup.py (path:/tmp/pip-9ImaeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:41 INFO - Running setup.py (path:/tmp/pip-TQ1oRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:41 INFO - Running setup.py (path:/tmp/pip-NWkL8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:41 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)) 09:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:41 INFO - Running setup.py (path:/tmp/pip-L4bGOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:41 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)) 09:28:41 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)) 09:28:41 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)) 09:28:41 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)) 09:28:41 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)) 09:28:41 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)) 09:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:43 INFO - Downloading blessings-1.6.tar.gz 09:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:28:43 INFO - Installing collected packages: blessings 09:28:43 INFO - Running setup.py install for blessings 09:28:43 INFO - Successfully installed blessings 09:28:43 INFO - Cleaning up... 09:28:43 INFO - Return code: 0 09:28:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:28:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:44 INFO - Reading from file tmpfile_stdout 09:28:44 INFO - Current package versions: 09:28:44 INFO - argparse == 1.2.1 09:28:44 INFO - blessings == 1.6 09:28:44 INFO - blobuploader == 1.2.4 09:28:44 INFO - docopt == 0.6.1 09:28:44 INFO - manifestparser == 1.1 09:28:44 INFO - mozInstall == 1.12 09:28:44 INFO - mozcrash == 0.17 09:28:44 INFO - mozdebug == 0.1 09:28:44 INFO - mozdevice == 0.48 09:28:44 INFO - mozfile == 1.2 09:28:44 INFO - mozhttpd == 0.7 09:28:44 INFO - mozinfo == 0.9 09:28:44 INFO - mozleak == 0.1 09:28:44 INFO - mozlog == 3.1 09:28:44 INFO - moznetwork == 0.27 09:28:44 INFO - mozprocess == 0.22 09:28:44 INFO - mozprofile == 0.28 09:28:44 INFO - mozrunner == 6.11 09:28:44 INFO - mozscreenshot == 0.1 09:28:44 INFO - mozsystemmonitor == 0.0 09:28:44 INFO - moztest == 0.7 09:28:44 INFO - mozversion == 1.4 09:28:44 INFO - psutil == 3.1.1 09:28:44 INFO - requests == 1.2.3 09:28:44 INFO - wsgiref == 0.1.2 09:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:44 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')]} 09:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:44 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')]} 09:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:44 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:44 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 09:28:44 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 09:28:44 INFO - Using env: {'DISPLAY': ':0', 09:28:44 INFO - 'HOME': '/home/cltbld', 09:28:44 INFO - 'LANG': 'en_US.UTF-8', 09:28:44 INFO - 'LANGUAGE': 'en_US:en', 09:28:44 INFO - 'LOGNAME': 'cltbld', 09:28:44 INFO - 'MAIL': '/var/mail/cltbld', 09:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:44 INFO - 'MOZ_NO_REMOTE': '1', 09:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:44 INFO - 'NO_EM_RESTART': '1', 09:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:44 INFO - 'PWD': '/builds/slave/test', 09:28:44 INFO - 'SHELL': '/bin/bash', 09:28:44 INFO - 'SHLVL': '1', 09:28:44 INFO - 'TERM': 'linux', 09:28:44 INFO - 'TMOUT': '86400', 09:28:44 INFO - 'USER': 'cltbld', 09:28:44 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:44 INFO - '_': '/tools/buildbot/bin/python'} 09:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 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)) 09:28:44 INFO - Cleaning up... 09:28:44 INFO - Return code: 0 09:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:28:44 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')]} 09:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:44 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')]} 09:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:44 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:44 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 09:28:44 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 09:28:44 INFO - Using env: {'DISPLAY': ':0', 09:28:44 INFO - 'HOME': '/home/cltbld', 09:28:44 INFO - 'LANG': 'en_US.UTF-8', 09:28:44 INFO - 'LANGUAGE': 'en_US:en', 09:28:44 INFO - 'LOGNAME': 'cltbld', 09:28:44 INFO - 'MAIL': '/var/mail/cltbld', 09:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:44 INFO - 'MOZ_NO_REMOTE': '1', 09:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:44 INFO - 'NO_EM_RESTART': '1', 09:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:44 INFO - 'PWD': '/builds/slave/test', 09:28:44 INFO - 'SHELL': '/bin/bash', 09:28:44 INFO - 'SHLVL': '1', 09:28:44 INFO - 'TERM': 'linux', 09:28:44 INFO - 'TMOUT': '86400', 09:28:44 INFO - 'USER': 'cltbld', 09:28:44 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:44 INFO - '_': '/tools/buildbot/bin/python'} 09:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:44 INFO - Downloading/unpacking jsonschema 09:28:44 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 09:28:44 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 09:28:44 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 09:28:44 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 09:28:44 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 09:28:44 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 09:28:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:28:46 INFO - Downloading/unpacking functools32 (from jsonschema) 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:28:46 INFO - warning: no files found matching '*.txt' 09:28:46 INFO - no previously-included directories found matching 'build' 09:28:46 INFO - no previously-included directories found matching 'dist' 09:28:46 INFO - no previously-included directories found matching '.git*' 09:28:46 INFO - Installing collected packages: jsonschema, functools32 09:28:46 INFO - Running setup.py install for functools32 09:28:46 INFO - warning: no files found matching '*.txt' 09:28:46 INFO - no previously-included directories found matching 'build' 09:28:46 INFO - no previously-included directories found matching 'dist' 09:28:46 INFO - no previously-included directories found matching '.git*' 09:28:46 INFO - Successfully installed jsonschema functools32 09:28:46 INFO - Cleaning up... 09:28:46 INFO - Return code: 0 09:28:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:28:46 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')]} 09:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:46 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')]} 09:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:46 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 0x7fd37a7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', '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 09:28:46 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 09:28:46 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 09:28:46 INFO - Using env: {'DISPLAY': ':0', 09:28:46 INFO - 'HOME': '/home/cltbld', 09:28:46 INFO - 'LANG': 'en_US.UTF-8', 09:28:46 INFO - 'LANGUAGE': 'en_US:en', 09:28:46 INFO - 'LOGNAME': 'cltbld', 09:28:46 INFO - 'MAIL': '/var/mail/cltbld', 09:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:46 INFO - 'MOZ_NO_REMOTE': '1', 09:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:46 INFO - 'NO_EM_RESTART': '1', 09:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:46 INFO - 'PWD': '/builds/slave/test', 09:28:46 INFO - 'SHELL': '/bin/bash', 09:28:46 INFO - 'SHLVL': '1', 09:28:46 INFO - 'TERM': 'linux', 09:28:46 INFO - 'TMOUT': '86400', 09:28:46 INFO - 'USER': 'cltbld', 09:28:46 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:46 INFO - '_': '/tools/buildbot/bin/python'} 09:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:47 INFO - Downloading/unpacking flake8 09:28:47 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 09:28:47 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 09:28:47 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 09:28:47 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 09:28:47 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 09:28:47 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 09:28:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:28:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:28:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:28:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:28:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:28:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:28:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:28:49 INFO - no previously-included directories found matching 'docs/_build' 09:28:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:28:49 INFO - Running setup.py install for pep8 09:28:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:28:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:28:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:28:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:28:49 INFO - no previously-included directories found matching 'docs/_build' 09:28:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:28:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:28:49 INFO - Cleaning up... 09:28:50 INFO - Return code: 0 09:28:50 INFO - Running post-action listener: _resource_record_post_action 09:28:50 INFO - Running post-action listener: _start_resource_monitoring 09:28:50 INFO - Starting resource monitoring. 09:28:50 INFO - ##### 09:28:50 INFO - ##### Finished create-virtualenv step (success) 09:28:50 INFO - ##### 09:28:50 INFO - ##### 09:28:50 INFO - ##### Running install step. 09:28:50 INFO - ##### 09:28:50 INFO - Running pre-action listener: _resource_record_pre_action 09:28:50 INFO - Running main action method: install 09:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:50 INFO - Reading from file tmpfile_stdout 09:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:28:50 INFO - Reading from file tmpfile_stdout 09:28:50 INFO - Output received: 09:28:50 INFO - Usage: mozinstall [options] installer 09:28:50 INFO - Options: 09:28:50 INFO - -h, --help show this help message and exit 09:28:50 INFO - -d DEST, --destination=DEST 09:28:50 INFO - Directory to install application into. [default: 09:28:50 INFO - "/builds/slave/test"] 09:28:50 INFO - --app=APP Application being installed. [default: firefox] 09:28:50 INFO - mkdir: /builds/slave/test/build/application 09:28:50 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'] 09:28:50 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 09:29:06 INFO - Reading from file tmpfile_stdout 09:29:06 INFO - Output received: 09:29:06 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:06 INFO - Running post-action listener: _resource_record_post_action 09:29:06 INFO - ##### 09:29:06 INFO - ##### Finished install step (success) 09:29:06 INFO - ##### 09:29:06 INFO - ##### 09:29:06 INFO - ##### Running run-tests step. 09:29:06 INFO - ##### 09:29:06 INFO - Running pre-action listener: _resource_record_pre_action 09:29:06 INFO - Running main action method: run_tests 09:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:06 INFO - Python 2.7.3 09:29:06 INFO - Return code: 0 09:29:06 INFO - grabbing minidump binary from tooltool 09:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:06 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 0x1c3e9c0>, '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 0x1c3f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:06 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 09:29:06 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 09:29:06 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 09:29:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:06 INFO - Return code: 0 09:29:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:29:07 INFO - Return code: 0 09:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 09:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 09:29:07 INFO - Using env: {'DISPLAY': ':0', 09:29:07 INFO - 'HOME': '/home/cltbld', 09:29:07 INFO - 'LANG': 'en_US.UTF-8', 09:29:07 INFO - 'LANGUAGE': 'en_US:en', 09:29:07 INFO - 'LOGNAME': 'cltbld', 09:29:07 INFO - 'MAIL': '/var/mail/cltbld', 09:29:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:07 INFO - 'MOZ_NO_REMOTE': '1', 09:29:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:07 INFO - 'NO_EM_RESTART': '1', 09:29:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:07 INFO - 'PWD': '/builds/slave/test', 09:29:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:07 INFO - 'SHELL': '/bin/bash', 09:29:07 INFO - 'SHLVL': '1', 09:29:07 INFO - 'TERM': 'linux', 09:29:07 INFO - 'TMOUT': '86400', 09:29:07 INFO - 'USER': 'cltbld', 09:29:07 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020', 09:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:07 INFO - '_': '/tools/buildbot/bin/python'} 09:29:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 09:29:07 INFO - mozversion application_buildid: 20160511081810 09:29:07 INFO - mozversion application_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 09:29:07 INFO - mozversion application_display_name: Nightly 09:29:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:07 INFO - mozversion application_name: Firefox 09:29:07 INFO - mozversion application_remotingname: firefox 09:29:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:29:07 INFO - mozversion application_vendor: Mozilla 09:29:07 INFO - mozversion application_version: 49.0a1 09:29:07 INFO - mozversion platform_buildid: 20160511081810 09:29:07 INFO - mozversion platform_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 09:29:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:29:07 INFO - mozversion platform_version: 49.0a1 09:29:07 INFO - using testdate: 1462984147 09:29:07 INFO - actual date: 1462984147 09:29:07 INFO - starting webserver on 'localhost:37114' 09:29:07 INFO - SUITE-START | Running 2 tests 09:29:07 INFO - TEST-START | dromaeo_css 09:29:07 INFO - operating with platform_type : linux_ 09:29:07 INFO - Initialising browser for dromaeo_css test... 09:29:07 INFO - TEST-INFO | started process 26684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpygH1ry/profile http://localhost:37114/getInfo.html) 09:29:11 INFO - PROCESS | 26684 | __metrics Screen width/height:1600/1200 09:29:11 INFO - PROCESS | 26684 | colorDepth:24 09:29:11 INFO - PROCESS | 26684 | Browser inner width/height: 1024/697 09:29:11 INFO - PROCESS | 26684 | __metrics 09:29:12 ERROR - PROCESS | 26684 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:29:13 INFO - TEST-INFO | 26684: exit 0 09:29:13 INFO - Browser initialized. 09:29:13 INFO - Running cycle 1/1 for dromaeo_css test... 09:29:13 INFO - TEST-INFO | started process 26764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpygH1ry/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:25 INFO - PROCESS | 26764 | RSS: Main: 154181632 09:29:25 INFO - PROCESS | 26764 | 09:30:16 INFO - PROCESS | 26764 | 1462984216640 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] 09:32:28 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37114/tests/dromaeo/cssquery-ext.html) 09:32:29 INFO - PROCESS | 26764 | RSS: Main: 242339840 09:32:29 INFO - PROCESS | 26764 | 09:35:31 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-ext.html (next: http://localhost:37114/tests/dromaeo/cssquery-jquery.html) 09:35:32 INFO - PROCESS | 26764 | RSS: Main: 233930752 09:35:32 INFO - PROCESS | 26764 | 09:38:34 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37114/tests/dromaeo/cssquery-mootools.html) 09:38:34 INFO - PROCESS | 26764 | RSS: Main: 236466176 09:38:34 INFO - PROCESS | 26764 | 09:41:36 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37114/tests/dromaeo/cssquery-prototype.html) 09:41:37 INFO - PROCESS | 26764 | RSS: Main: 229076992 09:41:37 INFO - PROCESS | 26764 | 09:44:40 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37114/tests/dromaeo/cssquery-yui.html) 09:44:41 INFO - PROCESS | 26764 | RSS: Main: 206905344 09:44:41 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-yui.html (next: http://localhost:37114/tests/dromaeo/cssquery-dojo.html) 09:47:44 INFO - PROCESS | 26764 | RSS: Main: 277504000 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | __start_tp_report 09:47:44 INFO - PROCESS | 26764 | _x_x_mozilla_page_load 09:47:44 INFO - PROCESS | 26764 | _x_x_mozilla_page_load_details 09:47:44 INFO - PROCESS | 26764 | |i|pagename|runs| 09:47:44 INFO - PROCESS | 26764 | |0;dojo.html;2631.1711810779602;2674.05071199724;2705.5941608758685;2715.2125883493777;2719.673639163301;4604.539546045394;4674.041821426608;4731.455882573505;4796.0887431388055;4831.541003604661;4702.835400760974;4708.717476951385;4759.190937540618;4828.806847726096;4839.4918533554;4255.12769882175;4294.26997410441;4374.409454723604;4399.890002749941;4547.022390186109;4464.843730469434;4477.888052798674;4497.347884556753;4507.346434766957;4533.546645335473;4283.164782867358;4338.1540599583095;4365.956340436586;4379.364992076163;4424.712393694432;4368.082702632451;4382.430284063052;4419.823207071713;4421.624161946238;4428.269335559628;4388.648908087345;4405.801738921757;4424.247877860771;4457.576530229656;4464.15181115587;4545.954540454586;4560.771961401917;4611.861644150681;4615.95384046162;4657.930131048037;5025.974870125662;5056.014077254937;5087.542121209072;5094.898102037939;5096.0827051131155;4951.925721114186;5083.110455670243;5085.669431486942;5094.363204599425;5113.769880355393;4763.356946812205;4828.058528586962;4834.830780922721;4844.927326090112;4896.36347274852;5304.23088652151;5304.787808487695;5305.734713264322;5340.225667278223;5359.330083739533;4831.936973865744;4957.851264462072;5038.79844806211;5067.391912970467;5087.186050231945;5077.466865979019;5098.388193416814;5098.515641014098;5122.308488354024;5143.202803565453;5077.111505486525;5097.923531147036;5103.132467480537;5105.438401775802;5146.459621739738;4907.2393778964315;5013.448520662724;5065.214891691794;5069.467705890902;5095.108356037678;4381.868543943687;4401.383806267125;4404.053128577371;4436.44544431946;4452.0205554777895;3810;3836.9616303836606;3837.76973381598;3855.4987851579117;3867.8259478323544;4210.642095421862;4304.139172165579;4322.178786030644;4323.610875021263;4398.274284743045;5030.044291584587;5041.974790126026;5044.949550504448;5059.671121377099;5076;4322.675799315064;4348.43470348859;4351.586599273064;4353.891152721208;4398.076403955141;4424.469063712375;4554;4594.287885377772;4609.539046095364;4610.124076425535;4856.854294371175;4870.902581948341;4872.049950259807;4875.07373599015;4896.510348965075;5008.173651347633;5129.615278854027;5139.280500729826;5143.279940808215;5197.376314842243;4779;4847.418309802846;4848.75756212195;4852.102361063215;4867.58625516835;5029.06962211992;5039.672421292605;5045.5459008689395;5057.519535644108;5109.233614957786;4978.178600530872;5032.974835125801;5100.872478188075;5103.795848166032;5163.483651634807;4941;4975.452700203047;5006.524380184022;5006.949930500648;5041.873953151201;4978.377702787152;4988.575971042502;4993.725345106054;4994.750262486934;5046.646734728533;4753.096911586787;4815.903681926272;4844.0554091951735;4905.068037072945;4975.0796102721115;4952.5542701157065;4976.427710813158;4985.027919555652;5010.874728131826;5020.196768517166;4855.101806165871;4861.611071114373;4864.3189953405845;4868.780904859219;4918.360613120271 09:47:44 INFO - PROCESS | 26764 | |1;ext.html;570.6519023395728;592.2448877680956;616.5838059309965;617.657200253859;621.2234706616729;29235;32302.67697323026;32331.51502727461;32372.410207183428;32376.838115809387;42887.14225715484;43584.56415435845;43860.561394386044;48108.51891481084;48274.51725482744;7966.402519811023;8090.352771778244;8116.553589552572;8129.430939834214;8140.308073813733;8059.556724380157;8142.796430089265;8144.185581441838;8147.674093036271;8149.429539932177;8174.386920980921;8220.671173153067;8221.260086592205;8223.54770487623;8232.670693172266;8080.39397045221;8115.918840811575;8131.552764597945;8141.104478507359;8144.918550814505;8008.119106898236;8085;8088.555129467877;8092.3930705197345;8094.392920530984;39582.406263906065;39821.402678959836;39830.40254396186;39944.201115977805;39947.600523994966;3305.9008229752903;3308.5368048473233;3401.591808982938;3431.879884204041;3538;29535.261618459495;29857.552136717968;30352.392952141054;30909.22726931822;31798.205044873834;3247.983760081208;3313.5692359993045;3316.9834150829333;3389.661033896615;3418;233159;233362;234219;234249;234396;34141.48787768185;35341.46987795185;35382.29235415329;56191;56967.715161424756;36265.818670906476;36320.273594527964;36365.81817090898;36375.63624363722;36407;13749.587512374645;13934.024618276826;13945;13950.23273719955;13950.372233249529;11340.716482088013;11395.715107122389;11412.258203216765;11420.257683250562;11421.42892855354;8469.957650211709;8470.449420787629;8485.236328730443;8529;8545.359098067669;3239.1902024493875;3247.610286765556;3257.641659417462;3270.378628060661;3283.195617073832;920.7007722490217;930.3719989007393;930.8091841172543;982.5136557403988;988.3921388346115;27271.181864544094;28904.710952890622;28905.56641650377;29110.633180473014;29111.563326549694;989.4063561862824;1015.6292953072076;1027.291169093323;1060.8514807926897;1061.1669839176209;15014;15473.613159670873;15545.689086218212;15581.766273505906;15870.761938570931;366971;367818;369645;370738;371615;52741.208881866805;53354.73322633362;53390;53411;53462.19806702903;1142.6800495861173;1180.8523934508187;1236.1285293867802;1259.0619988108917;1300.6033159886326;26838;29596.556051659674;29631.25921851971;30255.243618909702;30385;42820;42950.35574466323;43407.13185736331;43439;43510.34734479048;284813;285149;285243;286171;286922;24077.157299494433;25100.74899250984;25152.11967581126;26187.214383568524;26634.200973970812;41794.58205418028;41856;42103;42182.36726449167;43118.56881431145;35569;35607;35967.82016089903;36128.63871361253;36323.63676363308;35310.646893530735;35501;35867.82066089653;35891.461628076126;36260.637393626785;28885.566716498848;31882.840585796923;35506.28987420185;38884.805575971935;41138.38292425676;31549.52675709912;33366.83316583402;33976.66023339735;34216.828915856255;34435.31129377449;25518.872405637852;26021.65805077552;26037.479250415265;26340.736592633828;26471.867640661672 09:47:44 INFO - PROCESS | 26764 | |2;jquery.html;381.43928425214943;382.22408510723244;391.71992025701627;401.5803485357801;408.0390679948721;15842.683146337067;16875.91562042191;17507.91246043768;17519;17525.29898804048;16468.258928348223;17245.051522166308;17309.221085051173;17313;17320.220590073444;5203.427622961472;5320.893582128355;5398.595105367093;5402.648827826199;5402.945970540283;3716.5540135183815;4551.5676010778925;6170.660613666247;6171.506279497652;6292.056191571255;5997.280326360843;6152.661603611799;6159.10692949522;6168.907466388007;6222.253329600454;5930.288365396159;6184.443400094013;6189.659568723719;6191.380861913773;6195.132681424604;5232.450592687789;5252.947470525284;5354.277172581729;5375.489328513785;5382.165764306539;20690.172393104258;20766.06552705132;20861.37415877526;20884.791152088437;20907.477313067295;2030.451778019941;2243.495213576932;2499.6250562415603;2558.590625499911;2565.8588777617224;12755.298458584773;13206.669833254246;13309.933450332686;13639;13698.52055178064;1659.1704147926037;1699.7365408361725;1712.3664244229715;1784.7412125241897;1807.692692242322;67792;68717.65641171762;69069.30930690678;70094.99999999949;71316.28683713148;9598.95200523993;9755.78052743407;9968.252381071448;10090.293679442515;10154.543045562967;13824;13925.164490130624;13935.651608709863;13940.512082077079;13951.860481395057;7210.567365957954;7225.819354516179;7352.117745870422;7373.557586544717;7483.32650061497;6575.210974682973;6860.382565569123;7059.082319298458;7059.364657180879;7070.222275549685;5993.580449368589;6017.939820601738;6044.730606572581;6181.289151747516;6199.659018754011;1732.4186961427383;1821.2714914034227;1822.2346614421974;1834.7523084383704;1836.9632607348046;837.6597444089408;914.0767824497173;949.2216382566229;956.8421210500329;993.7515621094726;16727.46429174921;17538.123093845257;17617.295308187528;17813;18121.275148993893;925.2181906289175;935.2611436964858;967.4243824924159;972.0231167676582;1032.1691038713757;10151.847722284172;10176;10387.792244155225;10400.115990140772;10431.895681043092;378963;379924;381660;385688;392204;41893;42715.35926961098;45308.77345613317;58462.70768646215;75777.62111189519;920.6685593186447;935.9298052646079;948.6584829461389;972.8589354543693;974.28390133252;12062.396880156133;15167.620809479851;15399.307031183847;16013;16594.75107873407;33068;33471.83264083664;34278.48582271318;34295;34547.136321591155;40614.18771624492;41626;41762.58237417587;42118.36822447727;42131.157376852905;7757.836324551363;7788.844223115392;7828.2954534092205;7841.843163136819;7931.762047138595;11499.425028748361;11728.12039097054;11798.705032373917;11868.195327396026;12165;10339.350180505415;10419;10487.580496780043;10520.15838732915;10642.787144256916;10595.735106622396;10614;10734.141268698642;10765.30025548337;10905.618303359344;10867.51096200657;10884.7278818027;10900;10940.56237750481;11052.502637381498;7479.102507699111;7866.213378662088;8004.279614834692;8122.3502119831455;8143.959280203561;10831.404272765074;10850.945745271223;10940.726481838017;10969.83545246806;11108 09:47:44 INFO - PROCESS | 26764 | |3;mootools.html;1302.1796268350938;1499.9775003374943;1522.048719550281;1667.516420238131;1827.2051657528968;7727.22727727227;8017.19828017198;8051.476654017485;8263.256306932375;8273.751787446372;7995.960020199906;8152.796180095501;8163.59182040897;8173.795655108625;8177.018757749079;2282.8402011859175;2309.08791027544;2309.399556115405;2309.8960546775434;2312.2369618026096;2315.7452680205165;2321.6401457774073;2377.524495100978;2379.0721618568687;2380.666706661069;2292.4841910570153;2295.4031951692514;2317.281642690763;2318.455163036685;2321.872297023663;2217.7782221777857;2237.4853783629774;2253.256425379629;2255.842091053627;2258.0741895822716;2169.262450766747;2175.7715439878903;2176.4994051368117;2177.575372802304;2179.2263746369968;8030.076541197778;8092.231238032377;8135.227153420416;8142.837143257161;8277.710280140167;4858.489858564871;4941.728204948727;4948.653594248404;4974.850754477371;4984.252362145671;2888.162432894458;2890.219640697;2940.3972185701878;3024.9395012099853;3056.5720799088144;861.1474640106312;877.140402405646;884.2881480408269;887.2281115429618;898.8427025270552;11067.667969960914;11075.16936229794;11180.273282236629;11196.384198869058;11202.943985280102;4104.138130992525;4248.086661367821;4270.978645106755;4327.545607711208;4356.716813407118;8735.781605459915;8878.556072196365;8880.644774209088;8881.600327985256;8895.199432051017;4775.5224477552665;4835.685680430831;4842.297866809293;4870.561649451566;4880.585150262267;3734;4188.581141885848;4311.590398912098;4311.76285304305;4497.910041799146;3481.3211423772123;3540.6636369544854;3561.358955388055;3575.070481674731;3644.817759112034;1070.7002039428971;1080.827067669169;1096.8409580610767;1099.8735145458215;1100.9504572294265;757.46977116019;819.5328662662345;920.7237828651378;936.6300311377104;941.3034354577563;5608.158776183605;5661.377248502661;5694.914576281359;5712.742926568314;5987.64074155552;908.6410867707351;942.4957647658607;951.7953639967441;953.4041224234853;963.3930623707159;3813.2945405100145;3900.3564411871725;3913.706472014553;3924.7056470764805;3931.8230679619487;9797.216222702167;10191.23565732573;10193.490325483695;10324.12244959172;10341.84487232677;10034.147097496649;10071.899281007096;10132.392056476487;10147.898521014842;10213.285070045025;7551.395888328921;7689.4232932530285;7775.805604859811;7789.571573563395;7793.337566306814;5548;5658.236138121301;5694.971525142348;5749.741261643152;5849.327327357409;9292.58183381736;9324.254059675346;9412.15290623847;9497;9607.279454040836;9487.810243794947;9518.381305215138;9643.2767542436;9666.661666841626;9712.223022158352;6206.410391012847;6415.903761443676;6420.26166990802;6425.293217746138;6448;7419.29516695913;7530.28462296081;7531.171571127281;7538.208488108669;7539.246075392417;6662.333766623299;6803;6870.381665650116;6924.549904256207;7105.50261481712;6939.340762627744;7128.180259270251;7159.140903091662;7171.892421613576;7179.928200717926;6701.865962680817;6704.128463299935;6710.328967103251;6746.966265168643;6781.491388145811;4848.95151048485;4994.775235114501;5000.974995125001;5011.8245861396135;5047.041062198171;4853.878653033702;4878.121938051185;4911.557959783637;4990.900181996412;5009.499050094962 09:47:44 INFO - PROCESS | 26764 | |4;prototype.html;296.5655314963578;300.0608096657462;310.20896713380876;314.0734832244878;315.1412401206712;4644.256918892977;4738.455077666061;4837.685550439223;4839.951600483999;4860.951390486094;4569.588737013668;4746.264329028997;4771.093492236472;4785.808567657289;4796.136695394827;3768.5289338832645;3804.657580817726;3811.7141214408894;3813.0657988792786;3814.1227517670955;3573.589037260709;3586.982065089671;3753.5683396409354;3766.9811650941706;3799.601041890603;3724.8137593120373;3728.664420202181;3751.4560388743616;3757.962420375802;3775.6790672792845;3693.7045036397026;3720.0097947598174;3735.14091758897;3735.7858695923933;3750.1374683822874;3312.1554003729134;3325.384803811303;3330.2506935939464;3335.6831101045364;3343.69906708395;4465.017696106851;4490.044291927686;4571.6114130298965;4578.496365399803;4612.085984316504;4226.619604235633;4229.830806767725;4243.554426785205;4247.49030116388;4260.744355338689;4919.975400123012;4923.655344125913;4934.55588996992;4936.827211047632;4962.429320628138;3546.3971124908826;3601.819909004539;3624.773951183449;3627.2020155565733;3631.6368363163474;5155.896882062375;5193.805424752328;5208.4374687593945;5221.06020916235;5229.294045303911;3697.260547890379;3711.777293362407;3744.9063773405883;3747.756395834262;3754.530683664542;3769.5288088988877;3770.453284273765;3790.6497971257995;3801.030737162061;3801.847926082981;4090.0388408723925;4230.175115852441;4246.193223287565;4248.553901840324;4248.617624413818;4922.187839006596;4939.407271127416;4963.553280204799;4972.801087956514;4979.850604481871;1247.500999600149;1269.1623528471164;1287.3884904670394;1288.4974859804684;1311.1084462565548;843.409613270713;845.621636732135;857.9442336248123;866.6360128745815;869.8651708985118;3864.806759662006;3899.771571954882;3903.8243279052513;3930.901727456779;3941.896269044672;4433.312836510346;4443.755593442327;4472.217361961643;4496.865094047183;4499.3251012347755;3865.207632435344;3867.207222519377;3872.8063596820048;3917.7845218513257;3933.8229779659982;2417.2989832948247;2434.4522482441307;2530.468601593686;2723.155821695281;2778.8610569471443;4896.4124305083615;4912.459629440758;4932.235503496964;4945.134601444733;4953.8018479261145;5329.840104796862;5330.307060082242;5330.733463326896;5334.546563542142;5357.464253574689;4720.5515476030405;4954.380702412199;4954.727489988013;4962.486441635336;4980.128477516348;5214.687118772886;5229.294045303835;5238.790448382022;5246.842594722164;5254.290670759398;5122.385313762373;5135.023016138739;5147.639665223398;5154.639175257696;5155.200943853709;4670.252759558454;4875.366202393666;4892.828750993698;4893.632977526771;4955.1576232039915;3596.3706351388923;3599.3341231872187;3644.250759635443;3660.615635358249;3663.3772258716617;4968.950310496994;5170.3278573785165;5195.636305458733;5234.869128271824;5243.68537887728;4723.669343145947;4964.503549645006;4982.302477653204;4992.751812046989;5019.799208031638;4956.801727930987;4993.900121997613;4998.575121114601;5005.122054818421;5005.474425185449;4926;4952.232403977389;4952.851414457572;4957.100096443477;4960.23116416956;4897.436794768505;4981.327520784647;5009.298698182184;5022.518357084742;5024.673396229234;4851.49603622878;4884.511548845087;4900.632452566;4918.43438004634;4939.185034469272 09:47:44 INFO - PROCESS | 26764 | |5;yui.html;761.3908872901677;768.6502641298208;808.5714571277222;818.3085292927482;818.5088946632021;12498.875011249886;12802.295873726942;12830.48678052878;12838.679033024167;12850.678733031678;11376.544938202462;12103.152779305452;12928.612141635766;13039.348032598356;13419.0606657534;865.9567021648892;870.5908223135132;876.4916348517844;878.3719640457072;879.7888506758364;861.7888617288742;862.525610913998;868.6395146014396;868.9478631282112;869.326272139091;925.5511077127587;926.865604487349;927.1053433436732;927.2581934452445;927.7124091531647;920.7836158502746;922.5202894494859;922.6908985489869;923.0907556057278;923.155312888706;676.9912829883439;681.3288910423229;681.3493114076045;681.56039354616;681.7954613615944;12011.759764804656;12118.091143164209;12197.08521860864;12200.755984880341;12530.749385012248;12426;12508.249505029728;12511.186772859826;12674.683132921658;12811.743765124646;9388.577514011886;9608.519574021271;9609.903900960971;9647.517624118836;9991.950040249825;3366.7306615470948;3424.828758562087;3443.466262729256;3468.7745296555645;3478.4434490481653;36123.63876361255;39910.401343979865;41327.173456531;41809.16381672349;43622.781886090685;9757.313001445102;9991.700248992542;10068.295219334723;10092.596296148218;10211.795764084825;17571.56071098233;17589.64820703579;17639;17731;17741.55646108832;7122.786316410516;7168;7172.82067948295;7174.461915356369;7180.066591343197;3778.962210377861;4046.109855831712;4058.24922389353;4065.7153999220363;4082.7142100053306;2726.7136950620297;2833.914982550527;2834.7873909456875;2840.815347002438;2841.2328671259056;533.9466053394707;534.9919751203735;535.686623325359;537.2344409216851;546.2079984023183;569.1263909898287;575.6010756482975;596.5227817745786;612.6232367094206;616.3928530397554;8199.631016604268;8763.780905477413;9079.228265597367;9389.718308450758;9435.764105897408;503.8639567316877;565.5673409841474;649.8635286589774;649.8927676933348;660.0594153331483;3671.632836716307;3693.4644476550748;3703.9814800925824;3783.6405541473514;3839.5584507781405;51857;52139.47860521422;53495.73252133792;53608.46391536035;53894;45702.314465283045;46097;46251.76874115608;47272.7636361816;48127.278090828666;42880.57119428766;43002.13995720068;43369.13261734747;43737.343939840925;43745;7244.166920803964;7391.889121663072;7515.398768098648;7526.623668816428;7535.54786712799;28604;28833.711662883103;29346.413071738873;29416.970406035685;29554.113376598736;34571.30857382889;35452.46821297631;38383.04042398962;38392.80803595964;38872.80563597277;9857.30998830075;9875.555599997873;9991.650292239738;10000.949995249977;10299.433531155859;11688.532458701557;11901.880981190077;12101.092418068503;12134.635960921187;12836.935815320863;11778.234414763014;11783.52865885355;11813.40932953366;11841.5855445059;11964.940175299067;11645.88354116448;11841.881581184078;11865.703357416134;11963.162578619413;11997.460114294703;11306.830397544209;11490.77018459643;11518.94240528792;11612.825807612724;11637.243579167327;9642.325037247607;9762.121409073217;10113.29206955506;10191.184705223712;10299.073083422529;9243.445393276425;9977.657484742693;9993.750156246151;10045;10094.495275236355 09:47:44 INFO - PROCESS | 26764 | __end_tp_report 09:47:44 INFO - PROCESS | 26764 | __start_cc_report 09:47:44 INFO - PROCESS | 26764 | _x_x_mozilla_cycle_collect,896 09:47:44 INFO - PROCESS | 26764 | __end_cc_report 09:47:44 INFO - PROCESS | 26764 | __startTimestamp1462985264355__endTimestamp 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | ------- Summary: start ------- 09:47:44 INFO - PROCESS | 26764 | Number of tests: 6 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#0] dojo.html Cycles:165 Average:4715.03 Median:4855.10 stddev:487.79 (10.0%) stddev-sans-first:461.08 09:47:44 INFO - PROCESS | 26764 | Values: 2631.2 2674.1 2705.6 2715.2 2719.7 4604.5 4674.0 4731.5 4796.1 4831.5 4702.8 4708.7 4759.2 4828.8 4839.5 4255.1 4294.3 4374.4 4399.9 4547.0 4464.8 4477.9 4497.3 4507.3 4533.5 4283.2 4338.2 4366.0 4379.4 4424.7 4368.1 4382.4 4419.8 4421.6 4428.3 4388.6 4405.8 4424.2 4457.6 4464.2 4546.0 4560.8 4611.9 4616.0 4657.9 5026.0 5056.0 5087.5 5094.9 5096.1 4951.9 5083.1 5085.7 5094.4 5113.8 4763.4 4828.1 4834.8 4844.9 4896.4 5304.2 5304.8 5305.7 5340.2 5359.3 4831.9 4957.9 5038.8 5067.4 5087.2 5077.5 5098.4 5098.5 5122.3 5143.2 5077.1 5097.9 5103.1 5105.4 5146.5 4907.2 5013.4 5065.2 5069.5 5095.1 4381.9 4401.4 4404.1 4436.4 4452.0 3810.0 3837.0 3837.8 3855.5 3867.8 4210.6 4304.1 4322.2 4323.6 4398.3 5030.0 5042.0 5044.9 5059.7 5076.0 4322.7 4348.4 4351.6 4353.9 4398.1 4424.5 4554.0 4594.3 4609.5 4610.1 4856.9 4870.9 4872.0 4875.1 4896.5 5008.2 5129.6 5139.3 5143.3 5197.4 4779.0 4847.4 4848.8 4852.1 4867.6 5029.1 5039.7 5045.5 5057.5 5109.2 4978.2 5033.0 5100.9 5103.8 5163.5 4941.0 4975.5 5006.5 5006.9 5041.9 4978.4 4988.6 4993.7 4994.8 5046.6 4753.1 4815.9 4844.1 4905.1 4975.1 4952.6 4976.4 4985.0 5010.9 5020.2 4855.1 4861.6 4864.3 4868.8 4918.4 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#1] ext.html Cycles:180 Average:44684.25 Median:35503.64 stddev:79317.86 (223.4%) stddev-sans-first:79471.21 09:47:44 INFO - PROCESS | 26764 | Values: 570.7 592.2 616.6 617.7 621.2 29235.0 32302.7 32331.5 32372.4 32376.8 42887.1 43584.6 43860.6 48108.5 48274.5 7966.4 8090.4 8116.6 8129.4 8140.3 8059.6 8142.8 8144.2 8147.7 8149.4 8174.4 8220.7 8221.3 8223.5 8232.7 8080.4 8115.9 8131.6 8141.1 8144.9 8008.1 8085.0 8088.6 8092.4 8094.4 39582.4 39821.4 39830.4 39944.2 39947.6 3305.9 3308.5 3401.6 3431.9 3538.0 29535.3 29857.6 30352.4 30909.2 31798.2 3248.0 3313.6 3317.0 3389.7 3418.0 233159.0 233362.0 234219.0 234249.0 234396.0 34141.5 35341.5 35382.3 56191.0 56967.7 36265.8 36320.3 36365.8 36375.6 36407.0 13749.6 13934.0 13945.0 13950.2 13950.4 11340.7 11395.7 11412.3 11420.3 11421.4 8470.0 8470.4 8485.2 8529.0 8545.4 3239.2 3247.6 3257.6 3270.4 3283.2 920.7 930.4 930.8 982.5 988.4 27271.2 28904.7 28905.6 29110.6 29111.6 989.4 1015.6 1027.3 1060.9 1061.2 15014.0 15473.6 15545.7 15581.8 15870.8 366971.0 367818.0 369645.0 370738.0 371615.0 52741.2 53354.7 53390.0 53411.0 53462.2 1142.7 1180.9 1236.1 1259.1 1300.6 26838.0 29596.6 29631.3 30255.2 30385.0 42820.0 42950.4 43407.1 43439.0 43510.3 284813.0 285149.0 285243.0 286171.0 286922.0 24077.2 25100.7 25152.1 26187.2 26634.2 41794.6 41856.0 42103.0 42182.4 43118.6 35569.0 35607.0 35967.8 36128.6 36323.6 35310.6 35501.0 35867.8 35891.5 36260.6 28885.6 31882.8 35506.3 38884.8 41138.4 31549.5 33366.8 33976.7 34216.8 34435.3 25518.9 26021.7 26037.5 26340.7 26471.9 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#2] jquery.html Cycles:180 Average:23473.46 Median:190152.72 stddev:62811.69 (33.0%) stddev-sans-first:62963.96 09:47:44 INFO - PROCESS | 26764 | Values: 381.4 382.2 391.7 401.6 408.0 15842.7 16875.9 17507.9 17519.0 17525.3 16468.3 17245.1 17309.2 17313.0 17320.2 5203.4 5320.9 5398.6 5402.6 5402.9 3716.6 4551.6 6170.7 6171.5 6292.1 5997.3 6152.7 6159.1 6168.9 6222.3 5930.3 6184.4 6189.7 6191.4 6195.1 5232.5 5252.9 5354.3 5375.5 5382.2 20690.2 20766.1 20861.4 20884.8 20907.5 2030.5 2243.5 2499.6 2558.6 2565.9 12755.3 13206.7 13309.9 13639.0 13698.5 1659.2 1699.7 1712.4 1784.7 1807.7 67792.0 68717.7 69069.3 70095.0 71316.3 9599.0 9755.8 9968.3 10090.3 10154.5 13824.0 13925.2 13935.7 13940.5 13951.9 7210.6 7225.8 7352.1 7373.6 7483.3 6575.2 6860.4 7059.1 7059.4 7070.2 5993.6 6017.9 6044.7 6181.3 6199.7 1732.4 1821.3 1822.2 1834.8 1837.0 837.7 914.1 949.2 956.8 993.8 16727.5 17538.1 17617.3 17813.0 18121.3 925.2 935.3 967.4 972.0 1032.2 10151.8 10176.0 10387.8 10400.1 10431.9 378963.0 379924.0 381660.0 385688.0 392204.0 41893.0 42715.4 45308.8 58462.7 75777.6 920.7 935.9 948.7 972.9 974.3 12062.4 15167.6 15399.3 16013.0 16594.8 33068.0 33471.8 34278.5 34295.0 34547.1 40614.2 41626.0 41762.6 42118.4 42131.2 7757.8 7788.8 7828.3 7841.8 7931.8 11499.4 11728.1 11798.7 11868.2 12165.0 10339.4 10419.0 10487.6 10520.2 10642.8 10595.7 10614.0 10734.1 10765.3 10905.6 10867.5 10884.7 10900.0 10940.6 11052.5 7479.1 7866.2 8004.3 8122.4 8144.0 10831.4 10850.9 10940.7 10969.8 11108.0 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#3] mootools.html Cycles:180 Average:5354.00 Median:5005.24 stddev:2999.52 (59.9%) stddev-sans-first:2992.48 09:47:44 INFO - PROCESS | 26764 | Values: 1302.2 1500.0 1522.0 1667.5 1827.2 7727.2 8017.2 8051.5 8263.3 8273.8 7996.0 8152.8 8163.6 8173.8 8177.0 2282.8 2309.1 2309.4 2309.9 2312.2 2315.7 2321.6 2377.5 2379.1 2380.7 2292.5 2295.4 2317.3 2318.5 2321.9 2217.8 2237.5 2253.3 2255.8 2258.1 2169.3 2175.8 2176.5 2177.6 2179.2 8030.1 8092.2 8135.2 8142.8 8277.7 4858.5 4941.7 4948.7 4974.9 4984.3 2888.2 2890.2 2940.4 3024.9 3056.6 861.1 877.1 884.3 887.2 898.8 11067.7 11075.2 11180.3 11196.4 11202.9 4104.1 4248.1 4271.0 4327.5 4356.7 8735.8 8878.6 8880.6 8881.6 8895.2 4775.5 4835.7 4842.3 4870.6 4880.6 3734.0 4188.6 4311.6 4311.8 4497.9 3481.3 3540.7 3561.4 3575.1 3644.8 1070.7 1080.8 1096.8 1099.9 1101.0 757.5 819.5 920.7 936.6 941.3 5608.2 5661.4 5694.9 5712.7 5987.6 908.6 942.5 951.8 953.4 963.4 3813.3 3900.4 3913.7 3924.7 3931.8 9797.2 10191.2 10193.5 10324.1 10341.8 10034.1 10071.9 10132.4 10147.9 10213.3 7551.4 7689.4 7775.8 7789.6 7793.3 5548.0 5658.2 5695.0 5749.7 5849.3 9292.6 9324.3 9412.2 9497.0 9607.3 9487.8 9518.4 9643.3 9666.7 9712.2 6206.4 6415.9 6420.3 6425.3 6448.0 7419.3 7530.3 7531.2 7538.2 7539.2 6662.3 6803.0 6870.4 6924.5 7105.5 6939.3 7128.2 7159.1 7171.9 7179.9 6701.9 6704.1 6710.3 6747.0 6781.5 4849.0 4994.8 5001.0 5011.8 5047.0 4853.9 4878.1 4911.6 4990.9 5009.5 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#4] prototype.html Cycles:180 Average:4119.49 Median:4628.17 stddev:1200.93 (25.9%) stddev-sans-first:1169.52 09:47:44 INFO - PROCESS | 26764 | Values: 296.6 300.1 310.2 314.1 315.1 4644.3 4738.5 4837.7 4840.0 4861.0 4569.6 4746.3 4771.1 4785.8 4796.1 3768.5 3804.7 3811.7 3813.1 3814.1 3573.6 3587.0 3753.6 3767.0 3799.6 3724.8 3728.7 3751.5 3758.0 3775.7 3693.7 3720.0 3735.1 3735.8 3750.1 3312.2 3325.4 3330.3 3335.7 3343.7 4465.0 4490.0 4571.6 4578.5 4612.1 4226.6 4229.8 4243.6 4247.5 4260.7 4920.0 4923.7 4934.6 4936.8 4962.4 3546.4 3601.8 3624.8 3627.2 3631.6 5155.9 5193.8 5208.4 5221.1 5229.3 3697.3 3711.8 3744.9 3747.8 3754.5 3769.5 3770.5 3790.6 3801.0 3801.8 4090.0 4230.2 4246.2 4248.6 4248.6 4922.2 4939.4 4963.6 4972.8 4979.9 1247.5 1269.2 1287.4 1288.5 1311.1 843.4 845.6 857.9 866.6 869.9 3864.8 3899.8 3903.8 3930.9 3941.9 4433.3 4443.8 4472.2 4496.9 4499.3 3865.2 3867.2 3872.8 3917.8 3933.8 2417.3 2434.5 2530.5 2723.2 2778.9 4896.4 4912.5 4932.2 4945.1 4953.8 5329.8 5330.3 5330.7 5334.5 5357.5 4720.6 4954.4 4954.7 4962.5 4980.1 5214.7 5229.3 5238.8 5246.8 5254.3 5122.4 5135.0 5147.6 5154.6 5155.2 4670.3 4875.4 4892.8 4893.6 4955.2 3596.4 3599.3 3644.3 3660.6 3663.4 4969.0 5170.3 5195.6 5234.9 5243.7 4723.7 4964.5 4982.3 4992.8 5019.8 4956.8 4993.9 4998.6 5005.1 5005.5 4926.0 4952.2 4952.9 4957.1 4960.2 4897.4 4981.3 5009.3 5022.5 5024.7 4851.5 4884.5 4900.6 4918.4 4939.2 09:47:44 INFO - PROCESS | 26764 | 09:47:44 INFO - PROCESS | 26764 | [#5] yui.html Cycles:180 Average:12748.51 Median:43185.64 stddev:14119.87 (32.7%) stddev-sans-first:14130.79 09:47:44 INFO - PROCESS | 26764 | Values: 761.4 768.7 808.6 818.3 818.5 12498.9 12802.3 12830.5 12838.7 12850.7 11376.5 12103.2 12928.6 13039.3 13419.1 866.0 870.6 876.5 878.4 879.8 861.8 862.5 868.6 868.9 869.3 925.6 926.9 927.1 927.3 927.7 920.8 922.5 922.7 923.1 923.2 677.0 681.3 681.3 681.6 681.8 12011.8 12118.1 12197.1 12200.8 12530.7 12426.0 12508.2 12511.2 12674.7 12811.7 9388.6 9608.5 9609.9 9647.5 9992.0 3366.7 3424.8 3443.5 3468.8 3478.4 36123.6 39910.4 41327.2 41809.2 43622.8 9757.3 9991.7 10068.3 10092.6 10211.8 17571.6 17589.6 17639.0 17731.0 17741.6 7122.8 7168.0 7172.8 7174.5 7180.1 3779.0 4046.1 4058.2 4065.7 4082.7 2726.7 2833.9 2834.8 2840.8 2841.2 533.9 535.0 535.7 537.2 546.2 569.1 575.6 596.5 612.6 616.4 8199.6 8763.8 9079.2 9389.7 9435.8 503.9 565.6 649.9 649.9 660.1 3671.6 3693.5 3704.0 3783.6 3839.6 51857.0 52139.5 53495.7 53608.5 53894.0 45702.3 46097.0 46251.8 47272.8 48127.3 42880.6 43002.1 43369.1 43737.3 43745.0 7244.2 7391.9 7515.4 7526.6 7535.5 28604.0 28833.7 29346.4 29417.0 29554.1 34571.3 35452.5 38383.0 38392.8 38872.8 9857.3 9875.6 9991.7 10000.9 10299.4 11688.5 11901.9 12101.1 12134.6 12836.9 11778.2 11783.5 11813.4 11841.6 11964.9 11645.9 11841.9 11865.7 11963.2 11997.5 11306.8 11490.8 11518.9 11612.8 11637.2 9642.3 9762.1 10113.3 10191.2 10299.1 9243.4 9977.7 9993.8 10045.0 10094.5 09:47:44 INFO - PROCESS | 26764 | -------- Summary: end -------- 09:47:44 INFO - PROCESS | 26764 | 09:47:45 INFO - TEST-INFO | 26764: exit 0 09:47:45 INFO - TEST-OK | dromaeo_css | took 1117814ms 09:47:45 INFO - TEST-START | kraken 09:47:45 INFO - operating with platform_type : linux_ 09:47:45 INFO - Initialising browser for kraken test... 09:47:45 INFO - TEST-INFO | started process 26937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3SOGSL/profile http://localhost:37114/getInfo.html) 09:47:49 INFO - PROCESS | 26937 | __metrics Screen width/height:1600/1200 09:47:49 INFO - PROCESS | 26937 | colorDepth:24 09:47:49 INFO - PROCESS | 26937 | Browser inner width/height: 1024/697 09:47:49 INFO - PROCESS | 26937 | __metrics 09:47:50 ERROR - PROCESS | 26937 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:47:50 INFO - TEST-INFO | 26937: exit 0 09:47:50 INFO - Browser initialized. 09:47:50 INFO - Running cycle 1/1 for kraken test... 09:47:51 INFO - TEST-INFO | started process 27016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3SOGSL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:02 INFO - PROCESS | 27016 | RSS: Main: 154705920 09:48:02 INFO - PROCESS | 27016 | 09:48:05 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:06 INFO - PROCESS | 27016 | RSS: Main: 209784832 09:48:06 INFO - PROCESS | 27016 | 09:48:09 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-dft) 09:48:10 INFO - PROCESS | 27016 | RSS: Main: 197996544 09:48:10 INFO - PROCESS | 27016 | 09:48:13 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-fft) 09:48:14 INFO - PROCESS | 27016 | RSS: Main: 266997760 09:48:14 INFO - PROCESS | 27016 | 09:48:16 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-oscillator) 09:48:16 INFO - PROCESS | 27016 | RSS: Main: 176283648 09:48:16 INFO - PROCESS | 27016 | 09:48:19 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:48:19 INFO - PROCESS | 27016 | RSS: Main: 179838976 09:48:19 INFO - PROCESS | 27016 | 09:48:23 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-darkroom) 09:48:23 INFO - PROCESS | 27016 | RSS: Main: 216182784 09:48:23 INFO - PROCESS | 27016 | 09:48:27 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:28 INFO - PROCESS | 27016 | RSS: Main: 214659072 09:48:28 INFO - PROCESS | 27016 | 09:48:31 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37114/tests/kraken/driver.html?testName=json-parse-financial) 09:48:31 INFO - PROCESS | 27016 | RSS: Main: 215134208 09:48:31 INFO - PROCESS | 27016 | 09:48:33 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:48:34 INFO - PROCESS | 27016 | RSS: Main: 203964416 09:48:34 INFO - PROCESS | 27016 | 09:48:36 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:48:36 INFO - PROCESS | 27016 | RSS: Main: 208130048 09:48:36 INFO - PROCESS | 27016 | 09:48:39 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:48:39 INFO - PROCESS | 27016 | RSS: Main: 215920640 09:48:39 INFO - PROCESS | 27016 | 09:48:42 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:48:43 INFO - PROCESS | 27016 | RSS: Main: 219455488 09:48:43 INFO - PROCESS | 27016 | 09:48:46 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:48:47 INFO - PROCESS | 27016 | RSS: Main: 218431488 09:48:47 INFO - PROCESS | 27016 | 09:48:48 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37114/tests/kraken/driver.html?testName=ai-astar) 09:48:49 INFO - PROCESS | 27016 | RSS: Main: 264318976 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | __start_tp_report 09:48:49 INFO - PROCESS | 27016 | _x_x_mozilla_page_load 09:48:49 INFO - PROCESS | 27016 | _x_x_mozilla_page_load_details 09:48:49 INFO - PROCESS | 27016 | |i|pagename|runs| 09:48:49 INFO - PROCESS | 27016 | |0;ai-astar;113;109;113;113;115;114;114;115;114;113 09:48:49 INFO - PROCESS | 27016 | |1;audio-beat-detection;163;129;157;226;132;152;160;131;202;138 09:48:49 INFO - PROCESS | 27016 | |2;audio-dft;161;160;163;162;163;160;161;161;162;160 09:48:49 INFO - PROCESS | 27016 | |3;audio-fft;76;75;76;150;76;76;78;76;131;76 09:48:49 INFO - PROCESS | 27016 | |4;audio-oscillator;94;93;151;93;93;93;130;93;94;127 09:48:49 INFO - PROCESS | 27016 | |5;imaging-gaussian-blur;117;116;116;118;117;117;117;118;117;117 09:48:49 INFO - PROCESS | 27016 | |6;imaging-darkroom;147;146;147;146;147;145;145;146;146;145 09:48:49 INFO - PROCESS | 27016 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;96 09:48:49 INFO - PROCESS | 27016 | |8;json-parse-financial;66;67;66;67;67;68;66;120;65;64 09:48:49 INFO - PROCESS | 27016 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;66;64;64 09:48:49 INFO - PROCESS | 27016 | |10;stanford-crypto-aes;93;84;83;81;83;83;82;84;83;87 09:48:49 INFO - PROCESS | 27016 | |11;stanford-crypto-ccm;151;144;136;128;131;143;129;132;259;139 09:48:49 INFO - PROCESS | 27016 | |12;stanford-crypto-pbkdf2;178;175;180;177;175;177;170;177;176;173 09:48:49 INFO - PROCESS | 27016 | |13;stanford-crypto-sha256-iterative;68;67;68;75;69;67;67;67;73;65 09:48:49 INFO - PROCESS | 27016 | __end_tp_report 09:48:49 INFO - PROCESS | 27016 | __start_cc_report 09:48:49 INFO - PROCESS | 27016 | _x_x_mozilla_cycle_collect,2094 09:48:49 INFO - PROCESS | 27016 | __end_cc_report 09:48:49 INFO - PROCESS | 27016 | __startTimestamp1462985329093__endTimestamp 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | ------- Summary: start ------- 09:48:49 INFO - PROCESS | 27016 | Number of tests: 14 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 09:48:49 INFO - PROCESS | 27016 | Values: 113.0 109.0 113.0 113.0 115.0 114.0 114.0 115.0 114.0 113.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:158.50 stddev:32.08 (20.2%) stddev-sans-first:33.99 09:48:49 INFO - PROCESS | 27016 | Values: 163.0 129.0 157.0 226.0 132.0 152.0 160.0 131.0 202.0 138.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 09:48:49 INFO - PROCESS | 27016 | Values: 161.0 160.0 163.0 162.0 163.0 160.0 161.0 161.0 162.0 160.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#3] audio-fft Cycles:10 Average:89.00 Median:76.00 stddev:27.52 (36.2%) stddev-sans-first:28.78 09:48:49 INFO - PROCESS | 27016 | Values: 76.0 75.0 76.0 150.0 76.0 76.0 78.0 76.0 131.0 76.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.54 (23.2%) stddev-sans-first:22.39 09:48:49 INFO - PROCESS | 27016 | Values: 94.0 93.0 151.0 93.0 93.0 93.0 130.0 93.0 94.0 127.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:48:49 INFO - PROCESS | 27016 | Values: 117.0 116.0 116.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 09:48:49 INFO - PROCESS | 27016 | Values: 147.0 146.0 147.0 146.0 147.0 145.0 145.0 146.0 146.0 145.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:48:49 INFO - PROCESS | 27016 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:66.50 stddev:17.04 (25.6%) stddev-sans-first:17.96 09:48:49 INFO - PROCESS | 27016 | Values: 66.0 67.0 66.0 67.0 67.0 68.0 66.0 120.0 65.0 64.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:48:49 INFO - PROCESS | 27016 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 66.0 64.0 64.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.43 (4.1%) stddev-sans-first:1.66 09:48:49 INFO - PROCESS | 27016 | Values: 93.0 84.0 83.0 81.0 83.0 83.0 82.0 84.0 83.0 87.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:141.00 stddev:39.28 (27.9%) stddev-sans-first:41.66 09:48:49 INFO - PROCESS | 27016 | Values: 151.0 144.0 136.0 128.0 131.0 143.0 129.0 132.0 259.0 139.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:177.00 stddev:2.78 (1.6%) stddev-sans-first:2.83 09:48:49 INFO - PROCESS | 27016 | Values: 178.0 175.0 180.0 177.0 175.0 177.0 170.0 177.0 176.0 173.0 09:48:49 INFO - PROCESS | 27016 | 09:48:49 INFO - PROCESS | 27016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.06 (4.5%) stddev-sans-first:3.24 09:48:49 INFO - PROCESS | 27016 | Values: 68.0 67.0 68.0 75.0 69.0 67.0 67.0 67.0 73.0 65.0 09:48:49 INFO - PROCESS | 27016 | -------- Summary: end -------- 09:48:49 INFO - PROCESS | 27016 | 09:48:50 INFO - TEST-INFO | 27016: exit 0 09:48:50 INFO - TEST-OK | kraken | took 65039ms 09:48:50 INFO - SUITE-END | took 1182s 09:48:50 INFO - Completed test suite (00:19:42) 09:48:50 INFO - javascript benchmark 09:48:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.1711810779602, 2674.05071199724, 2705.5941608758685, 2715.2125883493777, 2719.673639163301, 4604.539546045394, 4674.041821426608, 4731.455882573505, 4796.0887431388055, 4831.541003604661, 4702.835400760974, 4708.717476951385, 4759.190937540618, 4828.806847726096, 4839.4918533554, 4255.12769882175, 4294.26997410441, 4374.409454723604, 4399.890002749941, 4547.022390186109, 4464.843730469434, 4477.888052798674, 4497.347884556753, 4507.346434766957, 4533.546645335473, 4283.164782867358, 4338.1540599583095, 4365.956340436586, 4379.364992076163, 4424.712393694432, 4368.082702632451, 4382.430284063052, 4419.823207071713, 4421.624161946238, 4428.269335559628, 4388.648908087345, 4405.801738921757, 4424.247877860771, 4457.576530229656, 4464.15181115587, 4545.954540454586, 4560.771961401917, 4611.861644150681, 4615.95384046162, 4657.930131048037, 5025.974870125662, 5056.014077254937, 5087.542121209072, 5094.898102037939, 5096.0827051131155, 4951.925721114186, 5083.110455670243, 5085.669431486942, 5094.363204599425, 5113.769880355393, 4763.356946812205, 4828.058528586962, 4834.830780922721, 4844.927326090112, 4896.36347274852, 5304.23088652151, 5304.787808487695, 5305.734713264322, 5340.225667278223, 5359.330083739533, 4831.936973865744, 4957.851264462072, 5038.79844806211, 5067.391912970467, 5087.186050231945, 5077.466865979019, 5098.388193416814, 5098.515641014098, 5122.308488354024, 5143.202803565453, 5077.111505486525, 5097.923531147036, 5103.132467480537, 5105.438401775802, 5146.459621739738, 4907.2393778964315, 5013.448520662724, 5065.214891691794, 5069.467705890902, 5095.108356037678, 4381.868543943687, 4401.383806267125, 4404.053128577371, 4436.44544431946, 4452.0205554777895, 3810.0, 3836.9616303836606, 3837.76973381598, 3855.4987851579117, 3867.8259478323544, 4210.642095421862, 4304.139172165579, 4322.178786030644, 4323.610875021263, 4398.274284743045, 5030.044291584587, 5041.974790126026, 5044.949550504448, 5059.671121377099, 5076.0, 4322.675799315064, 4348.43470348859, 4351.586599273064, 4353.891152721208, 4398.076403955141, 4424.469063712375, 4554.0, 4594.287885377772, 4609.539046095364, 4610.124076425535, 4856.854294371175, 4870.902581948341, 4872.049950259807, 4875.07373599015, 4896.510348965075, 5008.173651347633, 5129.615278854027, 5139.280500729826, 5143.279940808215, 5197.376314842243, 4779.0, 4847.418309802846, 4848.75756212195, 4852.102361063215, 4867.58625516835, 5029.06962211992, 5039.672421292605, 5045.5459008689395, 5057.519535644108, 5109.233614957786, 4978.178600530872, 5032.974835125801, 5100.872478188075, 5103.795848166032, 5163.483651634807, 4941.0, 4975.452700203047, 5006.524380184022, 5006.949930500648, 5041.873953151201, 4978.377702787152, 4988.575971042502, 4993.725345106054, 4994.750262486934, 5046.646734728533, 4753.096911586787, 4815.903681926272, 4844.0554091951735, 4905.068037072945, 4975.0796102721115, 4952.5542701157065, 4976.427710813158, 4985.027919555652, 5010.874728131826, 5020.196768517166, 4855.101806165871, 4861.611071114373, 4864.3189953405845, 4868.780904859219, 4918.360613120271], "value": 4684.48603600928, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6519023395728, 592.2448877680956, 616.5838059309965, 617.657200253859, 621.2234706616729, 29235.0, 32302.67697323026, 32331.51502727461, 32372.410207183428, 32376.838115809387, 42887.14225715484, 43584.56415435845, 43860.561394386044, 48108.51891481084, 48274.51725482744, 7966.402519811023, 8090.352771778244, 8116.553589552572, 8129.430939834214, 8140.308073813733, 8059.556724380157, 8142.796430089265, 8144.185581441838, 8147.674093036271, 8149.429539932177, 8174.386920980921, 8220.671173153067, 8221.260086592205, 8223.54770487623, 8232.670693172266, 8080.39397045221, 8115.918840811575, 8131.552764597945, 8141.104478507359, 8144.918550814505, 8008.119106898236, 8085.0, 8088.555129467877, 8092.3930705197345, 8094.392920530984, 39582.406263906065, 39821.402678959836, 39830.40254396186, 39944.201115977805, 39947.600523994966, 3305.9008229752903, 3308.5368048473233, 3401.591808982938, 3431.879884204041, 3538.0, 29535.261618459495, 29857.552136717968, 30352.392952141054, 30909.22726931822, 31798.205044873834, 3247.983760081208, 3313.5692359993045, 3316.9834150829333, 3389.661033896615, 3418.0, 233159.0, 233362.0, 234219.0, 234249.0, 234396.0, 34141.48787768185, 35341.46987795185, 35382.29235415329, 56191.0, 56967.715161424756, 36265.818670906476, 36320.273594527964, 36365.81817090898, 36375.63624363722, 36407.0, 13749.587512374645, 13934.024618276826, 13945.0, 13950.23273719955, 13950.372233249529, 11340.716482088013, 11395.715107122389, 11412.258203216765, 11420.257683250562, 11421.42892855354, 8469.957650211709, 8470.449420787629, 8485.236328730443, 8529.0, 8545.359098067669, 3239.1902024493875, 3247.610286765556, 3257.641659417462, 3270.378628060661, 3283.195617073832, 920.7007722490217, 930.3719989007393, 930.8091841172543, 982.5136557403988, 988.3921388346115, 27271.181864544094, 28904.710952890622, 28905.56641650377, 29110.633180473014, 29111.563326549694, 989.4063561862824, 1015.6292953072076, 1027.291169093323, 1060.8514807926897, 1061.1669839176209, 15014.0, 15473.613159670873, 15545.689086218212, 15581.766273505906, 15870.761938570931, 366971.0, 367818.0, 369645.0, 370738.0, 371615.0, 52741.208881866805, 53354.73322633362, 53390.0, 53411.0, 53462.19806702903, 1142.6800495861173, 1180.8523934508187, 1236.1285293867802, 1259.0619988108917, 1300.6033159886326, 26838.0, 29596.556051659674, 29631.25921851971, 30255.243618909702, 30385.0, 42820.0, 42950.35574466323, 43407.13185736331, 43439.0, 43510.34734479048, 284813.0, 285149.0, 285243.0, 286171.0, 286922.0, 24077.157299494433, 25100.74899250984, 25152.11967581126, 26187.214383568524, 26634.200973970812, 41794.58205418028, 41856.0, 42103.0, 42182.36726449167, 43118.56881431145, 35569.0, 35607.0, 35967.82016089903, 36128.63871361253, 36323.63676363308, 35310.646893530735, 35501.0, 35867.82066089653, 35891.461628076126, 36260.637393626785, 28885.566716498848, 31882.840585796923, 35506.28987420185, 38884.805575971935, 41138.38292425676, 31549.52675709912, 33366.83316583402, 33976.66023339735, 34216.828915856255, 34435.31129377449, 25518.872405637852, 26021.65805077552, 26037.479250415265, 26340.736592633828, 26471.867640661672], "value": 16732.488225658377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.43928425214943, 382.22408510723244, 391.71992025701627, 401.5803485357801, 408.0390679948721, 15842.683146337067, 16875.91562042191, 17507.91246043768, 17519.0, 17525.29898804048, 16468.258928348223, 17245.051522166308, 17309.221085051173, 17313.0, 17320.220590073444, 5203.427622961472, 5320.893582128355, 5398.595105367093, 5402.648827826199, 5402.945970540283, 3716.5540135183815, 4551.5676010778925, 6170.660613666247, 6171.506279497652, 6292.056191571255, 5997.280326360843, 6152.661603611799, 6159.10692949522, 6168.907466388007, 6222.253329600454, 5930.288365396159, 6184.443400094013, 6189.659568723719, 6191.380861913773, 6195.132681424604, 5232.450592687789, 5252.947470525284, 5354.277172581729, 5375.489328513785, 5382.165764306539, 20690.172393104258, 20766.06552705132, 20861.37415877526, 20884.791152088437, 20907.477313067295, 2030.451778019941, 2243.495213576932, 2499.6250562415603, 2558.590625499911, 2565.8588777617224, 12755.298458584773, 13206.669833254246, 13309.933450332686, 13639.0, 13698.52055178064, 1659.1704147926037, 1699.7365408361725, 1712.3664244229715, 1784.7412125241897, 1807.692692242322, 67792.0, 68717.65641171762, 69069.30930690678, 70094.99999999949, 71316.28683713148, 9598.95200523993, 9755.78052743407, 9968.252381071448, 10090.293679442515, 10154.543045562967, 13824.0, 13925.164490130624, 13935.651608709863, 13940.512082077079, 13951.860481395057, 7210.567365957954, 7225.819354516179, 7352.117745870422, 7373.557586544717, 7483.32650061497, 6575.210974682973, 6860.382565569123, 7059.082319298458, 7059.364657180879, 7070.222275549685, 5993.580449368589, 6017.939820601738, 6044.730606572581, 6181.289151747516, 6199.659018754011, 1732.4186961427383, 1821.2714914034227, 1822.2346614421974, 1834.7523084383704, 1836.9632607348046, 837.6597444089408, 914.0767824497173, 949.2216382566229, 956.8421210500329, 993.7515621094726, 16727.46429174921, 17538.123093845257, 17617.295308187528, 17813.0, 18121.275148993893, 925.2181906289175, 935.2611436964858, 967.4243824924159, 972.0231167676582, 1032.1691038713757, 10151.847722284172, 10176.0, 10387.792244155225, 10400.115990140772, 10431.895681043092, 378963.0, 379924.0, 381660.0, 385688.0, 392204.0, 41893.0, 42715.35926961098, 45308.77345613317, 58462.70768646215, 75777.62111189519, 920.6685593186447, 935.9298052646079, 948.6584829461389, 972.8589354543693, 974.28390133252, 12062.396880156133, 15167.620809479851, 15399.307031183847, 16013.0, 16594.75107873407, 33068.0, 33471.83264083664, 34278.48582271318, 34295.0, 34547.136321591155, 40614.18771624492, 41626.0, 41762.58237417587, 42118.36822447727, 42131.157376852905, 7757.836324551363, 7788.844223115392, 7828.2954534092205, 7841.843163136819, 7931.762047138595, 11499.425028748361, 11728.12039097054, 11798.705032373917, 11868.195327396026, 12165.0, 10339.350180505415, 10419.0, 10487.580496780043, 10520.15838732915, 10642.787144256916, 10595.735106622396, 10614.0, 10734.141268698642, 10765.30025548337, 10905.618303359344, 10867.51096200657, 10884.7278818027, 10900.0, 10940.56237750481, 11052.502637381498, 7479.102507699111, 7866.213378662088, 8004.279614834692, 8122.3502119831455, 8143.959280203561, 10831.404272765074, 10850.945745271223, 10940.726481838017, 10969.83545246806, 11108.0], "value": 8482.983460466812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.1796268350938, 1499.9775003374943, 1522.048719550281, 1667.516420238131, 1827.2051657528968, 7727.22727727227, 8017.19828017198, 8051.476654017485, 8263.256306932375, 8273.751787446372, 7995.960020199906, 8152.796180095501, 8163.59182040897, 8173.795655108625, 8177.018757749079, 2282.8402011859175, 2309.08791027544, 2309.399556115405, 2309.8960546775434, 2312.2369618026096, 2315.7452680205165, 2321.6401457774073, 2377.524495100978, 2379.0721618568687, 2380.666706661069, 2292.4841910570153, 2295.4031951692514, 2317.281642690763, 2318.455163036685, 2321.872297023663, 2217.7782221777857, 2237.4853783629774, 2253.256425379629, 2255.842091053627, 2258.0741895822716, 2169.262450766747, 2175.7715439878903, 2176.4994051368117, 2177.575372802304, 2179.2263746369968, 8030.076541197778, 8092.231238032377, 8135.227153420416, 8142.837143257161, 8277.710280140167, 4858.489858564871, 4941.728204948727, 4948.653594248404, 4974.850754477371, 4984.252362145671, 2888.162432894458, 2890.219640697, 2940.3972185701878, 3024.9395012099853, 3056.5720799088144, 861.1474640106312, 877.140402405646, 884.2881480408269, 887.2281115429618, 898.8427025270552, 11067.667969960914, 11075.16936229794, 11180.273282236629, 11196.384198869058, 11202.943985280102, 4104.138130992525, 4248.086661367821, 4270.978645106755, 4327.545607711208, 4356.716813407118, 8735.781605459915, 8878.556072196365, 8880.644774209088, 8881.600327985256, 8895.199432051017, 4775.5224477552665, 4835.685680430831, 4842.297866809293, 4870.561649451566, 4880.585150262267, 3734.0, 4188.581141885848, 4311.590398912098, 4311.76285304305, 4497.910041799146, 3481.3211423772123, 3540.6636369544854, 3561.358955388055, 3575.070481674731, 3644.817759112034, 1070.7002039428971, 1080.827067669169, 1096.8409580610767, 1099.8735145458215, 1100.9504572294265, 757.46977116019, 819.5328662662345, 920.7237828651378, 936.6300311377104, 941.3034354577563, 5608.158776183605, 5661.377248502661, 5694.914576281359, 5712.742926568314, 5987.64074155552, 908.6410867707351, 942.4957647658607, 951.7953639967441, 953.4041224234853, 963.3930623707159, 3813.2945405100145, 3900.3564411871725, 3913.706472014553, 3924.7056470764805, 3931.8230679619487, 9797.216222702167, 10191.23565732573, 10193.490325483695, 10324.12244959172, 10341.84487232677, 10034.147097496649, 10071.899281007096, 10132.392056476487, 10147.898521014842, 10213.285070045025, 7551.395888328921, 7689.4232932530285, 7775.805604859811, 7789.571573563395, 7793.337566306814, 5548.0, 5658.236138121301, 5694.971525142348, 5749.741261643152, 5849.327327357409, 9292.58183381736, 9324.254059675346, 9412.15290623847, 9497.0, 9607.279454040836, 9487.810243794947, 9518.381305215138, 9643.2767542436, 9666.661666841626, 9712.223022158352, 6206.410391012847, 6415.903761443676, 6420.26166990802, 6425.293217746138, 6448.0, 7419.29516695913, 7530.28462296081, 7531.171571127281, 7538.208488108669, 7539.246075392417, 6662.333766623299, 6803.0, 6870.381665650116, 6924.549904256207, 7105.50261481712, 6939.340762627744, 7128.180259270251, 7159.140903091662, 7171.892421613576, 7179.928200717926, 6701.865962680817, 6704.128463299935, 6710.328967103251, 6746.966265168643, 6781.491388145811, 4848.95151048485, 4994.775235114501, 5000.974995125001, 5011.8245861396135, 5047.041062198171, 4853.878653033702, 4878.121938051185, 4911.557959783637, 4990.900181996412, 5009.499050094962], "value": 4301.111320427812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5655314963578, 300.0608096657462, 310.20896713380876, 314.0734832244878, 315.1412401206712, 4644.256918892977, 4738.455077666061, 4837.685550439223, 4839.951600483999, 4860.951390486094, 4569.588737013668, 4746.264329028997, 4771.093492236472, 4785.808567657289, 4796.136695394827, 3768.5289338832645, 3804.657580817726, 3811.7141214408894, 3813.0657988792786, 3814.1227517670955, 3573.589037260709, 3586.982065089671, 3753.5683396409354, 3766.9811650941706, 3799.601041890603, 3724.8137593120373, 3728.664420202181, 3751.4560388743616, 3757.962420375802, 3775.6790672792845, 3693.7045036397026, 3720.0097947598174, 3735.14091758897, 3735.7858695923933, 3750.1374683822874, 3312.1554003729134, 3325.384803811303, 3330.2506935939464, 3335.6831101045364, 3343.69906708395, 4465.017696106851, 4490.044291927686, 4571.6114130298965, 4578.496365399803, 4612.085984316504, 4226.619604235633, 4229.830806767725, 4243.554426785205, 4247.49030116388, 4260.744355338689, 4919.975400123012, 4923.655344125913, 4934.55588996992, 4936.827211047632, 4962.429320628138, 3546.3971124908826, 3601.819909004539, 3624.773951183449, 3627.2020155565733, 3631.6368363163474, 5155.896882062375, 5193.805424752328, 5208.4374687593945, 5221.06020916235, 5229.294045303911, 3697.260547890379, 3711.777293362407, 3744.9063773405883, 3747.756395834262, 3754.530683664542, 3769.5288088988877, 3770.453284273765, 3790.6497971257995, 3801.030737162061, 3801.847926082981, 4090.0388408723925, 4230.175115852441, 4246.193223287565, 4248.553901840324, 4248.617624413818, 4922.187839006596, 4939.407271127416, 4963.553280204799, 4972.801087956514, 4979.850604481871, 1247.500999600149, 1269.1623528471164, 1287.3884904670394, 1288.4974859804684, 1311.1084462565548, 843.409613270713, 845.621636732135, 857.9442336248123, 866.6360128745815, 869.8651708985118, 3864.806759662006, 3899.771571954882, 3903.8243279052513, 3930.901727456779, 3941.896269044672, 4433.312836510346, 4443.755593442327, 4472.217361961643, 4496.865094047183, 4499.3251012347755, 3865.207632435344, 3867.207222519377, 3872.8063596820048, 3917.7845218513257, 3933.8229779659982, 2417.2989832948247, 2434.4522482441307, 2530.468601593686, 2723.155821695281, 2778.8610569471443, 4896.4124305083615, 4912.459629440758, 4932.235503496964, 4945.134601444733, 4953.8018479261145, 5329.840104796862, 5330.307060082242, 5330.733463326896, 5334.546563542142, 5357.464253574689, 4720.5515476030405, 4954.380702412199, 4954.727489988013, 4962.486441635336, 4980.128477516348, 5214.687118772886, 5229.294045303835, 5238.790448382022, 5246.842594722164, 5254.290670759398, 5122.385313762373, 5135.023016138739, 5147.639665223398, 5154.639175257696, 5155.200943853709, 4670.252759558454, 4875.366202393666, 4892.828750993698, 4893.632977526771, 4955.1576232039915, 3596.3706351388923, 3599.3341231872187, 3644.250759635443, 3660.615635358249, 3663.3772258716617, 4968.950310496994, 5170.3278573785165, 5195.636305458733, 5234.869128271824, 5243.68537887728, 4723.669343145947, 4964.503549645006, 4982.302477653204, 4992.751812046989, 5019.799208031638, 4956.801727930987, 4993.900121997613, 4998.575121114601, 5005.122054818421, 5005.474425185449, 4926.0, 4952.232403977389, 4952.851414457572, 4957.100096443477, 4960.23116416956, 4897.436794768505, 4981.327520784647, 5009.298698182184, 5022.518357084742, 5024.673396229234, 4851.49603622878, 4884.511548845087, 4900.632452566, 4918.43438004634, 4939.185034469272], "value": 3743.8621742071787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.3908872901677, 768.6502641298208, 808.5714571277222, 818.3085292927482, 818.5088946632021, 12498.875011249886, 12802.295873726942, 12830.48678052878, 12838.679033024167, 12850.678733031678, 11376.544938202462, 12103.152779305452, 12928.612141635766, 13039.348032598356, 13419.0606657534, 865.9567021648892, 870.5908223135132, 876.4916348517844, 878.3719640457072, 879.7888506758364, 861.7888617288742, 862.525610913998, 868.6395146014396, 868.9478631282112, 869.326272139091, 925.5511077127587, 926.865604487349, 927.1053433436732, 927.2581934452445, 927.7124091531647, 920.7836158502746, 922.5202894494859, 922.6908985489869, 923.0907556057278, 923.155312888706, 676.9912829883439, 681.3288910423229, 681.3493114076045, 681.56039354616, 681.7954613615944, 12011.759764804656, 12118.091143164209, 12197.08521860864, 12200.755984880341, 12530.749385012248, 12426.0, 12508.249505029728, 12511.186772859826, 12674.683132921658, 12811.743765124646, 9388.577514011886, 9608.519574021271, 9609.903900960971, 9647.517624118836, 9991.950040249825, 3366.7306615470948, 3424.828758562087, 3443.466262729256, 3468.7745296555645, 3478.4434490481653, 36123.63876361255, 39910.401343979865, 41327.173456531, 41809.16381672349, 43622.781886090685, 9757.313001445102, 9991.700248992542, 10068.295219334723, 10092.596296148218, 10211.795764084825, 17571.56071098233, 17589.64820703579, 17639.0, 17731.0, 17741.55646108832, 7122.786316410516, 7168.0, 7172.82067948295, 7174.461915356369, 7180.066591343197, 3778.962210377861, 4046.109855831712, 4058.24922389353, 4065.7153999220363, 4082.7142100053306, 2726.7136950620297, 2833.914982550527, 2834.7873909456875, 2840.815347002438, 2841.2328671259056, 533.9466053394707, 534.9919751203735, 535.686623325359, 537.2344409216851, 546.2079984023183, 569.1263909898287, 575.6010756482975, 596.5227817745786, 612.6232367094206, 616.3928530397554, 8199.631016604268, 8763.780905477413, 9079.228265597367, 9389.718308450758, 9435.764105897408, 503.8639567316877, 565.5673409841474, 649.8635286589774, 649.8927676933348, 660.0594153331483, 3671.632836716307, 3693.4644476550748, 3703.9814800925824, 3783.6405541473514, 3839.5584507781405, 51857.0, 52139.47860521422, 53495.73252133792, 53608.46391536035, 53894.0, 45702.314465283045, 46097.0, 46251.76874115608, 47272.7636361816, 48127.278090828666, 42880.57119428766, 43002.13995720068, 43369.13261734747, 43737.343939840925, 43745.0, 7244.166920803964, 7391.889121663072, 7515.398768098648, 7526.623668816428, 7535.54786712799, 28604.0, 28833.711662883103, 29346.413071738873, 29416.970406035685, 29554.113376598736, 34571.30857382889, 35452.46821297631, 38383.04042398962, 38392.80803595964, 38872.80563597277, 9857.30998830075, 9875.555599997873, 9991.650292239738, 10000.949995249977, 10299.433531155859, 11688.532458701557, 11901.880981190077, 12101.092418068503, 12134.635960921187, 12836.935815320863, 11778.234414763014, 11783.52865885355, 11813.40932953366, 11841.5855445059, 11964.940175299067, 11645.88354116448, 11841.881581184078, 11865.703357416134, 11963.162578619413, 11997.460114294703, 11306.830397544209, 11490.77018459643, 11518.94240528792, 11612.825807612724, 11637.243579167327, 9642.325037247607, 9762.121409073217, 10113.29206955506, 10191.184705223712, 10299.073083422529, 9243.445393276425, 9977.657484742693, 9993.750156246151, 10045.0, 10094.495275236355], "value": 6095.729568255116, "unit": "score"}], "name": "dromaeo_css", "value": 6345.377373717262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 113.0, 115.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 157.0, 226.0, 132.0, 152.0, 160.0, 131.0, 202.0, 138.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 163.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 150.0, 76.0, 76.0, 78.0, 76.0, 131.0, 76.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 151.0, 93.0, 93.0, 93.0, 130.0, 93.0, 94.0, 127.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 66.0, 120.0, 65.0, 64.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 84.0, 83.0, 81.0, 83.0, 83.0, 82.0, 84.0, 83.0, 87.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 144.0, 136.0, 128.0, 131.0, 143.0, 129.0, 132.0, 259.0, 139.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 180.0, 177.0, 175.0, 177.0, 170.0, 177.0, 176.0, 173.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 75.0, 69.0, 67.0, 67.0, 67.0, 73.0, 65.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1600.3, "alertThreshold": 2.0}]} 09:48:50 INFO - Return code: 0 09:48:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:48:50 ERROR - # TBPL SUCCESS # 09:48:50 INFO - Running post-action listener: _resource_record_post_action 09:48:50 INFO - ##### 09:48:50 INFO - ##### Finished run-tests step (success) 09:48:50 INFO - ##### 09:48:50 INFO - Running post-run listener: _resource_record_post_run 09:48:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 529072128; Read time: 0; Write time: 498312 09:48:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234860544; Read time: 0; Write time: 268852 09:48:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 294211584; Read time: 0; Write time: 229460 09:48:51 INFO - Running post-run listener: _upload_blobber_files 09:48:51 INFO - Blob upload gear active. 09:48:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48:51 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 09:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:48:51 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:53 INFO - (blobuploader) - INFO - Done attempting. 09:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:53 INFO - (blobuploader) - INFO - Done attempting. 09:48:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:48:53 INFO - Return code: 0 09:48:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:48:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:48:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f29a34efb6339e1b2c3cf358c4f26ad5a7cc03bd0d698fddbf7e5d9dfaa61710e20b8e448e1e2c6a3a3e5a88f13c09678e29466973ef3d2c3e2e408482482eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b49b89eb3a8456629ce413524c9528054d8c88d1312959418547ea7f5acaae36539c5082799bff44ce08dd88dc1bb23fa5c827fb25b8d08a8c3551a7842e029"} 09:48:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:48:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:48:53 INFO - Contents: 09:48:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f29a34efb6339e1b2c3cf358c4f26ad5a7cc03bd0d698fddbf7e5d9dfaa61710e20b8e448e1e2c6a3a3e5a88f13c09678e29466973ef3d2c3e2e408482482eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b49b89eb3a8456629ce413524c9528054d8c88d1312959418547ea7f5acaae36539c5082799bff44ce08dd88dc1bb23fa5c827fb25b8d08a8c3551a7842e029"} 09:48:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:48:53 INFO - Copying logs to upload dir... 09:48:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:48:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.774441 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-11 09:48:53.511270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 09:48:53.515238) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f29a34efb6339e1b2c3cf358c4f26ad5a7cc03bd0d698fddbf7e5d9dfaa61710e20b8e448e1e2c6a3a3e5a88f13c09678e29466973ef3d2c3e2e408482482eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b49b89eb3a8456629ce413524c9528054d8c88d1312959418547ea7f5acaae36539c5082799bff44ce08dd88dc1bb23fa5c827fb25b8d08a8c3551a7842e029"} build_url:https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/HoNK1jXTTO6aNwEUcljMOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f29a34efb6339e1b2c3cf358c4f26ad5a7cc03bd0d698fddbf7e5d9dfaa61710e20b8e448e1e2c6a3a3e5a88f13c09678e29466973ef3d2c3e2e408482482eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b49b89eb3a8456629ce413524c9528054d8c88d1312959418547ea7f5acaae36539c5082799bff44ce08dd88dc1bb23fa5c827fb25b8d08a8c3551a7842e029"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 09:48:53.543326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:48:53.543698) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462984092.411925-572171020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:48:53.628998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 09:48:53.629310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 09:48:53.629616) ========= ========= Total master_lag: 0.17 =========