builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1463055700.83 results: success (0) buildid: 20160512023005 builduid: ec6582345bb941c38462adc55d81c658 revision: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:40.830819) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:40.831238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:40.831513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:40.847569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:40.847865) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 05:21:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-12 05:21:41 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.208055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.208374) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.257320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.257659) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3ff04109a8a6e439be36ae44133b2ba68fc79f6 --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 c3ff04109a8a6e439be36ae44133b2ba68fc79f6 --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=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 05:21:41,339 truncating revision to first 12 chars 2016-05-12 05:21:41,339 Setting DEBUG logging. 2016-05-12 05:21:41,339 attempt 1/10 2016-05-12 05:21:41,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3ff04109a8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 05:21:41,619 unpacking tar archive at: fx-team-c3ff04109a8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.852944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.853244) ========= script_repo_revision: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.853640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.853922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 05:21:41.864610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-12 05:21:41.865111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:42 INFO - MultiFileLogger online at 20160512 05:21:42 in /builds/slave/test 05:21:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:21:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:42 INFO - {'append_to_log': False, 05:21:42 INFO - 'base_work_dir': '/builds/slave/test', 05:21:42 INFO - 'blob_upload_branch': 'Fx-Team', 05:21:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:42 INFO - 'branch': 'Fx-Team', 05:21:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:42 INFO - 'config_files': ('talos/linux_config.py',), 05:21:42 INFO - 'default_actions': ('clobber', 05:21:42 INFO - 'read-buildbot-config', 05:21:42 INFO - 'download-and-extract', 05:21:42 INFO - 'populate-webroot', 05:21:42 INFO - 'create-virtualenv', 05:21:42 INFO - 'install', 05:21:42 INFO - 'run-tests'), 05:21:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:42 INFO - 'download_minidump_stackwalk': True, 05:21:42 INFO - 'download_symbols': 'ondemand', 05:21:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:42 INFO - 'installer_path': 'installer.exe', 05:21:42 INFO - 'log_level': 'info', 05:21:42 INFO - 'log_name': 'talos', 05:21:42 INFO - 'log_to_console': True, 05:21:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:42 INFO - 'opt_config_files': (), 05:21:42 INFO - 'pip_index': False, 05:21:42 INFO - 'sps_profile': False, 05:21:42 INFO - 'sps_profile_interval': 0, 05:21:42 INFO - 'suite': 'dromaeojs', 05:21:42 INFO - 'system_bits': '32', 05:21:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:42 INFO - 'title': 'talos-linux64-ix-042', 05:21:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:42 INFO - 'use_talos_json': True, 05:21:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:42 INFO - 'work_dir': 'build'} 05:21:42 INFO - ##### 05:21:42 INFO - ##### Running clobber step. 05:21:42 INFO - ##### 05:21:42 INFO - Running pre-action listener: _resource_record_pre_action 05:21:42 INFO - Running main action method: clobber 05:21:42 INFO - rmtree: /builds/slave/test/build 05:21:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:42 INFO - Running post-action listener: _resource_record_post_action 05:21:42 INFO - ##### 05:21:42 INFO - ##### Finished clobber step (success) 05:21:42 INFO - ##### 05:21:42 INFO - ##### 05:21:42 INFO - ##### Running read-buildbot-config step. 05:21:42 INFO - ##### 05:21:42 INFO - Running pre-action listener: _resource_record_pre_action 05:21:42 INFO - Running main action method: read_buildbot_config 05:21:42 INFO - Using buildbot properties: 05:21:42 INFO - { 05:21:42 INFO - "project": "", 05:21:42 INFO - "product": "firefox", 05:21:42 INFO - "script_repo_revision": "production", 05:21:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:42 INFO - "repository": "", 05:21:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:21:42 INFO - "buildid": "20160512023005", 05:21:42 INFO - "pgo_build": "True", 05:21:42 INFO - "basedir": "/builds/slave/test", 05:21:42 INFO - "buildnumber": 1146, 05:21:42 INFO - "slavename": "talos-linux64-ix-042", 05:21:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:21:42 INFO - "platform": "ubuntu64_hw", 05:21:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:21:42 INFO - "branch": "fx-team", 05:21:42 INFO - "repo_path": "integration/fx-team", 05:21:42 INFO - "revision": "c3ff04109a8a6e439be36ae44133b2ba68fc79f6", 05:21:42 INFO - "stage_platform": "linux64-pgo", 05:21:42 INFO - "builduid": "ec6582345bb941c38462adc55d81c658", 05:21:42 INFO - "slavebuilddir": "test" 05:21:42 INFO - } 05:21:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:21:42 INFO - Running post-action listener: _resource_record_post_action 05:21:42 INFO - ##### 05:21:42 INFO - ##### Finished read-buildbot-config step (success) 05:21:42 INFO - ##### 05:21:42 INFO - ##### 05:21:42 INFO - ##### Running download-and-extract step. 05:21:42 INFO - ##### 05:21:42 INFO - Running pre-action listener: _resource_record_pre_action 05:21:42 INFO - Running main action method: download_and_extract 05:21:42 INFO - mkdir: /builds/slave/test/build/tests 05:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:42 INFO - https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:21:48 INFO - Downloaded 1361 bytes. 05:21:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:21:48 INFO - Using the following test package requirements: 05:21:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'jsshell-linux-x86_64.zip'], 05:21:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:48 INFO - https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:21:59 INFO - Downloaded 23902275 bytes. 05:21:59 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'] 05:21:59 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 05:22:01 INFO - Return code: 0 05:22:01 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 05:22:01 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')]} 05:22:01 INFO - https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:02 INFO - Downloaded 23902275 bytes. 05:22:02 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'] 05:22:02 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 05:22:03 INFO - Return code: 0 05:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:03 INFO - https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:04 INFO - Downloaded 10840152 bytes. 05:22:04 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'] 05:22:04 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 05:22:04 INFO - Return code: 0 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 INFO - https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:22:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mV7LDAR2CnVRmLYvfCmw/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 05:22:06 INFO - Downloaded 58340576 bytes. 05:22:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:06 INFO - mkdir: /builds/slave/test/properties 05:22:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:06 INFO - Contents: 05:22:06 INFO - build_url:https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:07 INFO - Running post-action listener: _resource_record_post_action 05:22:07 INFO - Running post-action listener: set_extra_try_arguments 05:22:07 INFO - ##### 05:22:07 INFO - ##### Finished download-and-extract step (success) 05:22:07 INFO - ##### 05:22:07 INFO - ##### 05:22:07 INFO - ##### Running populate-webroot step. 05:22:07 INFO - ##### 05:22:07 INFO - Running pre-action listener: _resource_record_pre_action 05:22:07 INFO - Running main action method: populate_webroot 05:22:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:07 INFO - '--tppagecycles', 05:22:07 INFO - '7'], 05:22:07 INFO - 'tests': ['tsvgm']}}, 05:22:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['damp', 'tps']}, 05:22:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'tests': ['damp', 'tps']}, 05:22:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['dromaeo_dom']}, 05:22:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['a11yr', 05:22:07 INFO - 'ts_paint', 05:22:07 INFO - 'tpaint', 05:22:07 INFO - 'sessionrestore', 05:22:07 INFO - 'sessionrestore_no_auto_restore', 05:22:07 INFO - 'tabpaint']}, 05:22:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['tsvgx', 05:22:07 INFO - 'tsvgr_opacity', 05:22:07 INFO - 'tart', 05:22:07 INFO - 'tscrollx', 05:22:07 INFO - 'cart']}, 05:22:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:07 INFO - 'tsvgr_opacity', 05:22:07 INFO - 'tart', 05:22:07 INFO - 'tscrollx', 05:22:07 INFO - 'cart']}, 05:22:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'talos_options': ['--disable-e10s'], 05:22:07 INFO - 'tests': ['tp5o']}, 05:22:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'tests': ['tp5o']}, 05:22:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'talos_options': ['--disable-e10s', 05:22:07 INFO - '--xperf_path', 05:22:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:07 INFO - 'tests': ['tp5n']}, 05:22:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:07 INFO - 'talos_options': ['--xperf_path', 05:22:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:07 INFO - 'tests': ['tp5n']}}, 05:22:07 INFO - 'talos.zip': {'path': '', 05:22:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:07 INFO - Running post-action listener: _resource_record_post_action 05:22:07 INFO - ##### 05:22:07 INFO - ##### Finished populate-webroot step (success) 05:22:07 INFO - ##### 05:22:07 INFO - ##### 05:22:07 INFO - ##### Running create-virtualenv step. 05:22:07 INFO - ##### 05:22:07 INFO - Running pre-action listener: _resource_record_pre_action 05:22:07 INFO - Running main action method: create_virtualenv 05:22:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:07 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 05:22:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:07 INFO - Using real prefix '/usr' 05:22:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:09 INFO - Installing pip.................done. 05:22:09 INFO - Return code: 0 05:22:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:09 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 05:22:09 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 05:22:09 INFO - Using env: {'DISPLAY': ':0', 05:22:09 INFO - 'HOME': '/home/cltbld', 05:22:09 INFO - 'LANG': 'en_US.UTF-8', 05:22:09 INFO - 'LANGUAGE': 'en_US:en', 05:22:09 INFO - 'LOGNAME': 'cltbld', 05:22:09 INFO - 'MAIL': '/var/mail/cltbld', 05:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:09 INFO - 'MOZ_NO_REMOTE': '1', 05:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:09 INFO - 'NO_EM_RESTART': '1', 05:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:09 INFO - 'PWD': '/builds/slave/test', 05:22:09 INFO - 'SHELL': '/bin/bash', 05:22:09 INFO - 'SHLVL': '1', 05:22:09 INFO - 'TERM': 'linux', 05:22:09 INFO - 'TMOUT': '86400', 05:22:09 INFO - 'USER': 'cltbld', 05:22:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:09 INFO - '_': '/tools/buildbot/bin/python'} 05:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:10 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 05:22:10 INFO - Cleaning up... 05:22:10 INFO - Return code: 0 05:22:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:22:10 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')]} 05:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:10 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')]} 05:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:10 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:10 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 05:22:10 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 05:22:10 INFO - Using env: {'DISPLAY': ':0', 05:22:10 INFO - 'HOME': '/home/cltbld', 05:22:10 INFO - 'LANG': 'en_US.UTF-8', 05:22:10 INFO - 'LANGUAGE': 'en_US:en', 05:22:10 INFO - 'LOGNAME': 'cltbld', 05:22:10 INFO - 'MAIL': '/var/mail/cltbld', 05:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:10 INFO - 'MOZ_NO_REMOTE': '1', 05:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:10 INFO - 'NO_EM_RESTART': '1', 05:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:10 INFO - 'PWD': '/builds/slave/test', 05:22:10 INFO - 'SHELL': '/bin/bash', 05:22:10 INFO - 'SHLVL': '1', 05:22:10 INFO - 'TERM': 'linux', 05:22:10 INFO - 'TMOUT': '86400', 05:22:10 INFO - 'USER': 'cltbld', 05:22:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:10 INFO - '_': '/tools/buildbot/bin/python'} 05:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:10 INFO - Downloading/unpacking psutil>=0.7.1 05:22:10 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 05:22:10 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 05:22:10 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 05:22:10 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 05:22:10 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 05:22:10 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 05:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:12 INFO - Installing collected packages: psutil 05:22:12 INFO - Running setup.py install for psutil 05:22:12 INFO - building 'psutil._psutil_linux' extension 05:22:12 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 05:22:12 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 05:22:12 INFO - building 'psutil._psutil_posix' extension 05:22:12 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 05:22:12 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 05:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:12 INFO - Successfully installed psutil 05:22:12 INFO - Cleaning up... 05:22:12 INFO - Return code: 0 05:22:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:22:12 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')]} 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 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')]} 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:12 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 05:22:12 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 05:22:12 INFO - Using env: {'DISPLAY': ':0', 05:22:12 INFO - 'HOME': '/home/cltbld', 05:22:12 INFO - 'LANG': 'en_US.UTF-8', 05:22:12 INFO - 'LANGUAGE': 'en_US:en', 05:22:12 INFO - 'LOGNAME': 'cltbld', 05:22:12 INFO - 'MAIL': '/var/mail/cltbld', 05:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:12 INFO - 'MOZ_NO_REMOTE': '1', 05:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:12 INFO - 'NO_EM_RESTART': '1', 05:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:12 INFO - 'PWD': '/builds/slave/test', 05:22:12 INFO - 'SHELL': '/bin/bash', 05:22:12 INFO - 'SHLVL': '1', 05:22:12 INFO - 'TERM': 'linux', 05:22:12 INFO - 'TMOUT': '86400', 05:22:12 INFO - 'USER': 'cltbld', 05:22:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:12 INFO - '_': '/tools/buildbot/bin/python'} 05:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:22:12 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 05:22:12 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 05:22:12 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 05:22:12 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 05:22:12 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 05:22:12 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 05:22:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:22:14 INFO - Installing collected packages: mozsystemmonitor 05:22:14 INFO - Running setup.py install for mozsystemmonitor 05:22:15 INFO - Successfully installed mozsystemmonitor 05:22:15 INFO - Cleaning up... 05:22:16 INFO - Return code: 0 05:22:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:16 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')]} 05:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:16 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')]} 05:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:16 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:16 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 05:22:16 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 05:22:16 INFO - Using env: {'DISPLAY': ':0', 05:22:16 INFO - 'HOME': '/home/cltbld', 05:22:16 INFO - 'LANG': 'en_US.UTF-8', 05:22:16 INFO - 'LANGUAGE': 'en_US:en', 05:22:16 INFO - 'LOGNAME': 'cltbld', 05:22:16 INFO - 'MAIL': '/var/mail/cltbld', 05:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:16 INFO - 'MOZ_NO_REMOTE': '1', 05:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:16 INFO - 'NO_EM_RESTART': '1', 05:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:16 INFO - 'PWD': '/builds/slave/test', 05:22:16 INFO - 'SHELL': '/bin/bash', 05:22:16 INFO - 'SHLVL': '1', 05:22:16 INFO - 'TERM': 'linux', 05:22:16 INFO - 'TMOUT': '86400', 05:22:16 INFO - 'USER': 'cltbld', 05:22:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:16 INFO - '_': '/tools/buildbot/bin/python'} 05:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:16 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 05:22:16 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 05:22:16 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 05:22:16 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 05:22:16 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 05:22:16 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 05:22:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 INFO - Downloading docopt-0.6.1.tar.gz 05:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:18 INFO - Running setup.py install for blobuploader 05:22:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:18 INFO - Running setup.py install for requests 05:22:19 INFO - Running setup.py install for docopt 05:22:19 INFO - Successfully installed blobuploader requests docopt 05:22:19 INFO - Cleaning up... 05:22:19 INFO - Return code: 0 05:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:19 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:19 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 05:22:19 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 05:22:19 INFO - Using env: {'DISPLAY': ':0', 05:22:19 INFO - 'HOME': '/home/cltbld', 05:22:19 INFO - 'LANG': 'en_US.UTF-8', 05:22:19 INFO - 'LANGUAGE': 'en_US:en', 05:22:19 INFO - 'LOGNAME': 'cltbld', 05:22:19 INFO - 'MAIL': '/var/mail/cltbld', 05:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:19 INFO - 'MOZ_NO_REMOTE': '1', 05:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:19 INFO - 'NO_EM_RESTART': '1', 05:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:19 INFO - 'PWD': '/builds/slave/test', 05:22:19 INFO - 'SHELL': '/bin/bash', 05:22:19 INFO - 'SHLVL': '1', 05:22:19 INFO - 'TERM': 'linux', 05:22:19 INFO - 'TMOUT': '86400', 05:22:19 INFO - 'USER': 'cltbld', 05:22:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:19 INFO - '_': '/tools/buildbot/bin/python'} 05:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:19 INFO - Running setup.py (path:/tmp/pip-EUks5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:19 INFO - Running setup.py (path:/tmp/pip-ZVPVPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:19 INFO - Running setup.py (path:/tmp/pip-9hz6hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:19 INFO - Running setup.py (path:/tmp/pip-U3aW9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:19 INFO - Running setup.py (path:/tmp/pip-e_83tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:20 INFO - Running setup.py (path:/tmp/pip-c134Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:20 INFO - Running setup.py (path:/tmp/pip-euCuFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:20 INFO - Running setup.py (path:/tmp/pip-rnrBmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:20 INFO - Running setup.py (path:/tmp/pip-Zw2wHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:20 INFO - Running setup.py (path:/tmp/pip-dOdJi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:20 INFO - Running setup.py (path:/tmp/pip-9O9dWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:20 INFO - Running setup.py (path:/tmp/pip-xD8LSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:20 INFO - Running setup.py (path:/tmp/pip-afWs6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:20 INFO - Running setup.py (path:/tmp/pip-eajSjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:20 INFO - Running setup.py (path:/tmp/pip-MCCkv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:20 INFO - Running setup.py (path:/tmp/pip-c5_dVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:20 INFO - Running setup.py (path:/tmp/pip-JaBw2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:20 INFO - Running setup.py install for manifestparser 05:22:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:20 INFO - Running setup.py install for mozcrash 05:22:21 INFO - Running setup.py install for mozdebug 05:22:21 INFO - Running setup.py install for mozdevice 05:22:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozfile 05:22:21 INFO - Running setup.py install for mozhttpd 05:22:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozinfo 05:22:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozInstall 05:22:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozleak 05:22:21 INFO - Running setup.py install for mozlog 05:22:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for moznetwork 05:22:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:21 INFO - Running setup.py install for mozprocess 05:22:22 INFO - Running setup.py install for mozprofile 05:22:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Running setup.py install for mozrunner 05:22:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Running setup.py install for mozscreenshot 05:22:22 INFO - Running setup.py install for moztest 05:22:22 INFO - Running setup.py install for mozversion 05:22:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:22 INFO - Cleaning up... 05:22:22 INFO - Return code: 0 05:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:22 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')]} 05:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:22 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')]} 05:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:22 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:22 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 05:22:22 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 05:22:22 INFO - Using env: {'DISPLAY': ':0', 05:22:22 INFO - 'HOME': '/home/cltbld', 05:22:22 INFO - 'LANG': 'en_US.UTF-8', 05:22:22 INFO - 'LANGUAGE': 'en_US:en', 05:22:22 INFO - 'LOGNAME': 'cltbld', 05:22:22 INFO - 'MAIL': '/var/mail/cltbld', 05:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:22 INFO - 'MOZ_NO_REMOTE': '1', 05:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:22 INFO - 'NO_EM_RESTART': '1', 05:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:22 INFO - 'PWD': '/builds/slave/test', 05:22:22 INFO - 'SHELL': '/bin/bash', 05:22:22 INFO - 'SHLVL': '1', 05:22:22 INFO - 'TERM': 'linux', 05:22:22 INFO - 'TMOUT': '86400', 05:22:22 INFO - 'USER': 'cltbld', 05:22:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:22 INFO - '_': '/tools/buildbot/bin/python'} 05:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:22 INFO - Running setup.py (path:/tmp/pip-JWWGX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:22 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)) 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:22 INFO - Running setup.py (path:/tmp/pip-DsvZwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:22 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)) 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:22 INFO - Running setup.py (path:/tmp/pip-IurexO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:23 INFO - Running setup.py (path:/tmp/pip-E5Qybm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:23 INFO - Running setup.py (path:/tmp/pip-tRod_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:23 INFO - Running setup.py (path:/tmp/pip-Hw9Vi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:23 INFO - Running setup.py (path:/tmp/pip-8IY5S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:23 INFO - Running setup.py (path:/tmp/pip-7yXMrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:23 INFO - Running setup.py (path:/tmp/pip-RLemY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:23 INFO - Running setup.py (path:/tmp/pip-_knoTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:23 INFO - Running setup.py (path:/tmp/pip-AvB9uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:23 INFO - Running setup.py (path:/tmp/pip-U6IP9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:23 INFO - Running setup.py (path:/tmp/pip-sb0Hfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:23 INFO - Running setup.py (path:/tmp/pip-SKGmAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:23 INFO - Running setup.py (path:/tmp/pip-U1kRxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:23 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)) 05:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:23 INFO - Running setup.py (path:/tmp/pip-CkfiJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:24 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)) 05:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:24 INFO - Running setup.py (path:/tmp/pip-KLOuOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:24 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)) 05:22:24 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)) 05:22:24 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)) 05:22:24 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)) 05:22:24 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)) 05:22:24 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)) 05:22:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:24 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 05:22:24 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 05:22:24 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 05:22:24 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 05:22:24 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 05:22:24 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 05:22:25 INFO - Downloading blessings-1.6.tar.gz 05:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:26 INFO - Installing collected packages: blessings 05:22:26 INFO - Running setup.py install for blessings 05:22:26 INFO - Successfully installed blessings 05:22:26 INFO - Cleaning up... 05:22:26 INFO - Return code: 0 05:22:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:26 INFO - Reading from file tmpfile_stdout 05:22:26 INFO - Current package versions: 05:22:26 INFO - argparse == 1.2.1 05:22:26 INFO - blessings == 1.6 05:22:26 INFO - blobuploader == 1.2.4 05:22:26 INFO - docopt == 0.6.1 05:22:26 INFO - manifestparser == 1.1 05:22:26 INFO - mozInstall == 1.12 05:22:26 INFO - mozcrash == 0.17 05:22:26 INFO - mozdebug == 0.1 05:22:26 INFO - mozdevice == 0.48 05:22:26 INFO - mozfile == 1.2 05:22:26 INFO - mozhttpd == 0.7 05:22:26 INFO - mozinfo == 0.9 05:22:26 INFO - mozleak == 0.1 05:22:26 INFO - mozlog == 3.1 05:22:26 INFO - moznetwork == 0.27 05:22:26 INFO - mozprocess == 0.22 05:22:26 INFO - mozprofile == 0.28 05:22:26 INFO - mozrunner == 6.11 05:22:26 INFO - mozscreenshot == 0.1 05:22:26 INFO - mozsystemmonitor == 0.0 05:22:26 INFO - moztest == 0.7 05:22:26 INFO - mozversion == 1.4 05:22:26 INFO - psutil == 3.1.1 05:22:26 INFO - requests == 1.2.3 05:22:26 INFO - wsgiref == 0.1.2 05:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:26 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:26 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 05:22:26 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 05:22:26 INFO - Using env: {'DISPLAY': ':0', 05:22:26 INFO - 'HOME': '/home/cltbld', 05:22:26 INFO - 'LANG': 'en_US.UTF-8', 05:22:26 INFO - 'LANGUAGE': 'en_US:en', 05:22:26 INFO - 'LOGNAME': 'cltbld', 05:22:26 INFO - 'MAIL': '/var/mail/cltbld', 05:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:26 INFO - 'MOZ_NO_REMOTE': '1', 05:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:26 INFO - 'NO_EM_RESTART': '1', 05:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:26 INFO - 'PWD': '/builds/slave/test', 05:22:26 INFO - 'SHELL': '/bin/bash', 05:22:26 INFO - 'SHLVL': '1', 05:22:26 INFO - 'TERM': 'linux', 05:22:26 INFO - 'TMOUT': '86400', 05:22:26 INFO - 'USER': 'cltbld', 05:22:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:26 INFO - '_': '/tools/buildbot/bin/python'} 05:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 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)) 05:22:26 INFO - Cleaning up... 05:22:26 INFO - Return code: 0 05:22:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:26 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:26 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 05:22:26 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 05:22:26 INFO - Using env: {'DISPLAY': ':0', 05:22:26 INFO - 'HOME': '/home/cltbld', 05:22:26 INFO - 'LANG': 'en_US.UTF-8', 05:22:26 INFO - 'LANGUAGE': 'en_US:en', 05:22:26 INFO - 'LOGNAME': 'cltbld', 05:22:26 INFO - 'MAIL': '/var/mail/cltbld', 05:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:26 INFO - 'MOZ_NO_REMOTE': '1', 05:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:26 INFO - 'NO_EM_RESTART': '1', 05:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:26 INFO - 'PWD': '/builds/slave/test', 05:22:26 INFO - 'SHELL': '/bin/bash', 05:22:26 INFO - 'SHLVL': '1', 05:22:26 INFO - 'TERM': 'linux', 05:22:26 INFO - 'TMOUT': '86400', 05:22:26 INFO - 'USER': 'cltbld', 05:22:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:26 INFO - '_': '/tools/buildbot/bin/python'} 05:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:26 INFO - Downloading/unpacking jsonschema 05:22:26 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 05:22:26 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 05:22:26 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 05:22:26 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 05:22:26 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 05:22:26 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 05:22:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:28 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:29 INFO - warning: no files found matching '*.txt' 05:22:29 INFO - no previously-included directories found matching 'build' 05:22:29 INFO - no previously-included directories found matching 'dist' 05:22:29 INFO - no previously-included directories found matching '.git*' 05:22:29 INFO - Installing collected packages: jsonschema, functools32 05:22:29 INFO - Running setup.py install for functools32 05:22:29 INFO - warning: no files found matching '*.txt' 05:22:29 INFO - no previously-included directories found matching 'build' 05:22:29 INFO - no previously-included directories found matching 'dist' 05:22:29 INFO - no previously-included directories found matching '.git*' 05:22:29 INFO - Successfully installed jsonschema functools32 05:22:29 INFO - Cleaning up... 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22:29 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')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x7f5b512a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1517770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', '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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'DISPLAY': ':0', 05:22:29 INFO - 'HOME': '/home/cltbld', 05:22:29 INFO - 'LANG': 'en_US.UTF-8', 05:22:29 INFO - 'LANGUAGE': 'en_US:en', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MAIL': '/var/mail/cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SHLVL': '1', 05:22:29 INFO - 'TERM': 'linux', 05:22:29 INFO - 'TMOUT': '86400', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - '_': '/tools/buildbot/bin/python'} 05:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:29 INFO - Downloading/unpacking flake8 05:22:29 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 05:22:29 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 05:22:29 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 05:22:29 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 05:22:29 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 05:22:29 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 05:22:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:32 INFO - no previously-included directories found matching 'docs/_build' 05:22:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:32 INFO - Running setup.py install for pep8 05:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:32 INFO - no previously-included directories found matching 'docs/_build' 05:22:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:32 INFO - Cleaning up... 05:22:32 INFO - Return code: 0 05:22:32 INFO - Running post-action listener: _resource_record_post_action 05:22:32 INFO - Running post-action listener: _start_resource_monitoring 05:22:32 INFO - Starting resource monitoring. 05:22:32 INFO - ##### 05:22:32 INFO - ##### Finished create-virtualenv step (success) 05:22:32 INFO - ##### 05:22:32 INFO - ##### 05:22:32 INFO - ##### Running install step. 05:22:32 INFO - ##### 05:22:32 INFO - Running pre-action listener: _resource_record_pre_action 05:22:32 INFO - Running main action method: install 05:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:32 INFO - Reading from file tmpfile_stdout 05:22:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:32 INFO - Reading from file tmpfile_stdout 05:22:32 INFO - Output received: 05:22:32 INFO - Usage: mozinstall [options] installer 05:22:32 INFO - Options: 05:22:32 INFO - -h, --help show this help message and exit 05:22:32 INFO - -d DEST, --destination=DEST 05:22:32 INFO - Directory to install application into. [default: 05:22:32 INFO - "/builds/slave/test"] 05:22:32 INFO - --app=APP Application being installed. [default: firefox] 05:22:32 INFO - mkdir: /builds/slave/test/build/application 05:22:32 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'] 05:22:32 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 05:22:49 INFO - Reading from file tmpfile_stdout 05:22:49 INFO - Output received: 05:22:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:49 INFO - Running post-action listener: _resource_record_post_action 05:22:49 INFO - ##### 05:22:49 INFO - ##### Finished install step (success) 05:22:49 INFO - ##### 05:22:49 INFO - ##### 05:22:49 INFO - ##### Running run-tests step. 05:22:49 INFO - ##### 05:22:49 INFO - Running pre-action listener: _resource_record_pre_action 05:22:49 INFO - Running main action method: run_tests 05:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:49 INFO - Python 2.7.3 05:22:49 INFO - Return code: 0 05:22:49 INFO - grabbing minidump binary from tooltool 05:22:49 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')]} 05:22:49 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 0x15a69c0>, '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 0x15a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:49 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 05:22:49 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 05:22:49 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 05:22:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:49 INFO - Return code: 0 05:22:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:50 INFO - Return code: 0 05:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 05:22:50 INFO - Using env: {'DISPLAY': ':0', 05:22:50 INFO - 'HOME': '/home/cltbld', 05:22:50 INFO - 'LANG': 'en_US.UTF-8', 05:22:50 INFO - 'LANGUAGE': 'en_US:en', 05:22:50 INFO - 'LOGNAME': 'cltbld', 05:22:50 INFO - 'MAIL': '/var/mail/cltbld', 05:22:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:50 INFO - 'MOZ_NO_REMOTE': '1', 05:22:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:50 INFO - 'NO_EM_RESTART': '1', 05:22:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:50 INFO - 'PWD': '/builds/slave/test', 05:22:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:50 INFO - 'SHELL': '/bin/bash', 05:22:50 INFO - 'SHLVL': '1', 05:22:50 INFO - 'TERM': 'linux', 05:22:50 INFO - 'TMOUT': '86400', 05:22:50 INFO - 'USER': 'cltbld', 05:22:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486', 05:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:50 INFO - '_': '/tools/buildbot/bin/python'} 05:22:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:22:50 INFO - mozversion application_buildid: 20160512023005 05:22:50 INFO - mozversion application_changeset: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 05:22:50 INFO - mozversion application_display_name: Nightly 05:22:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:50 INFO - mozversion application_name: Firefox 05:22:50 INFO - mozversion application_remotingname: firefox 05:22:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:50 INFO - mozversion application_vendor: Mozilla 05:22:50 INFO - mozversion application_version: 49.0a1 05:22:50 INFO - mozversion platform_buildid: 20160512023005 05:22:50 INFO - mozversion platform_changeset: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 05:22:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:50 INFO - mozversion platform_version: 49.0a1 05:22:50 INFO - using testdate: 1463055770 05:22:50 INFO - actual date: 1463055770 05:22:50 INFO - starting webserver on 'localhost:35420' 05:22:50 INFO - SUITE-START | Running 2 tests 05:22:50 INFO - TEST-START | dromaeo_css 05:22:50 INFO - operating with platform_type : linux_ 05:22:50 INFO - Initialising browser for dromaeo_css test... 05:22:50 INFO - TEST-INFO | started process 6583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2R__82/profile http://localhost:35420/getInfo.html) 05:22:54 INFO - PROCESS | 6583 | __metrics Screen width/height:1600/1200 05:22:54 INFO - PROCESS | 6583 | colorDepth:24 05:22:54 INFO - PROCESS | 6583 | Browser inner width/height: 1024/697 05:22:54 INFO - PROCESS | 6583 | __metrics 05:22:55 ERROR - PROCESS | 6583 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:22:56 INFO - TEST-INFO | 6583: exit 0 05:22:56 INFO - Browser initialized. 05:22:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:56 INFO - TEST-INFO | started process 6665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2R__82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:08 INFO - PROCESS | 6665 | RSS: Main: 152678400 05:23:08 INFO - PROCESS | 6665 | 05:23:59 INFO - PROCESS | 6665 | 1463055839622 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] 05:26:07 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35420/tests/dromaeo/cssquery-ext.html) 05:26:08 INFO - PROCESS | 6665 | RSS: Main: 241745920 05:26:08 INFO - PROCESS | 6665 | 05:29:11 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-ext.html (next: http://localhost:35420/tests/dromaeo/cssquery-jquery.html) 05:29:11 INFO - PROCESS | 6665 | RSS: Main: 245506048 05:29:11 INFO - PROCESS | 6665 | 05:32:13 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35420/tests/dromaeo/cssquery-mootools.html) 05:32:14 INFO - PROCESS | 6665 | RSS: Main: 249085952 05:32:14 INFO - PROCESS | 6665 | 05:35:16 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35420/tests/dromaeo/cssquery-prototype.html) 05:35:16 INFO - PROCESS | 6665 | RSS: Main: 248610816 05:35:16 INFO - PROCESS | 6665 | 05:38:19 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35420/tests/dromaeo/cssquery-yui.html) 05:38:20 INFO - PROCESS | 6665 | RSS: Main: 224649216 05:38:20 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:35420/tests/dromaeo/cssquery-yui.html (next: http://localhost:35420/tests/dromaeo/cssquery-dojo.html) 05:41:22 INFO - PROCESS | 6665 | RSS: Main: 279912448 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | __start_tp_report 05:41:22 INFO - PROCESS | 6665 | _x_x_mozilla_page_load 05:41:22 INFO - PROCESS | 6665 | _x_x_mozilla_page_load_details 05:41:22 INFO - PROCESS | 6665 | |i|pagename|runs| 05:41:22 INFO - PROCESS | 6665 | |0;dojo.html;3165.651778304386;3166.7783255172135;3190.6011748531428;3203.6956489133554;3218;5192.71440070796;5276.34045744282;5290.523852853243;5322.095243808547;5354.384245811732;5302.708351040691;5318.521333080022;5348.117560602505;5392.622516423852;5413.864653383657;4806.519348065183;4814.711117332971;4839.419269687624;4848.6363522735755;4977.278294647274;4879.170541008037;4928.827491037797;4943.826966056189;4948.208286674133;4954.603631709472;4716.221823399135;4779.402574678165;4810.927836082462;4850.975745121252;4899.706017638935;4795.904081918377;4807.639427042951;4819.1325561398935;4861.416630004387;4891.486393928657;4818.951810481885;4824.324594556765;4826;4831.589314908237;4833.468318484964;5182.378114626231;5251.212318152269;5338.412774594792;5349.679019258818;5404.162354835007;5763.711814409263;5851.502622277069;5856.795012174553;5858.794942177046;5860.501857342131;5558.110702287655;5918.082697181943;5919.230500034968;5945.910811337833;5948.494377977877;5390.272313237702;5409.134538473864;5433.728313584305;5493.450654934474;5507.834764957018;5954.970225148846;5992.730327135289;6006.12911127884;6009.579329446984;6011.428914253139;5484.972575137179;5772.884542309131;5779.248697669276;5779.450952159538;5781.219535362757;5689.317281926195;5708.372079071299;5714.485696287354;5769.913451298234;5772.682502462405;5680.062789639664;5721.542276617861;5735.483806457439;5745.023346031185;5745.195672605839;5434.809781657623;5640.605157638925;5732.541396688255;5751.654900705971;5759.452851979139;4335.653147748172;4358.3680366347335;4382.737035777864;4391.451068616359;4429.490608580055;3925.450436938831;3929.0766669832565;3930.1746633206776;3934.213157368538;3974;5352.2506849041165;5404.351477822686;5479.123340265538;5542.695151766691;5578.330600327906;5839.416058394211;5859.384764599656;5864.061750120046;5879.323877754113;5883;5556.97221513898;5563.082091454865;5564.805231816867;5565.387807341189;5567.4432556744005;4761.833335833298;4984.825531106394;5017.297578339036;5041.218611115283;5076.568491678248;6073.48375388097;6073.696315184223;6092.238470191226;6095.939040609537;6138.539609529304;5890.352061273171;5895.145203945318;5900.0264956281735;5904.61619994699;5904.61619994699;5806.738696758572;5871.559633027455;5909.70451477433;5911.113333000085;6089.451949324582;5657.4908258256955;5657.6888271143835;5665.178549110274;5670.432956704297;5676.545876329801;5720.0585243503565;5733.140028995684;5784.566157538286;5786;5790.594658373873;5543.362513311021;5677.602567820213;5679;5728.341240757366;5749.022666146849;5699.601027928005;5700.8289751305865;5703.287089113861;5704.657720536781;5717.885642287214;5341.305630268041;5595.384507704068;5600.131979543177;5635.549156067586;5649.802256921153;5649.71751412436;5692.203091567101;5743.8851222976145;5813.970930145322;5816.941830581809;5628.380878103323;5634.464725851038;5635.211070450058;5636.1545768133465;5671.773129074956 05:41:22 INFO - PROCESS | 6665 | |1;ext.html;627.6359711367407;648.795629376746;649.8960166373381;656.8883289840727;669.568128557081;44514.777426112865;45637.77181114094;45645.77177114114;48310;48329.7583512082;44161;44869.32696009563;44892.551074489245;44938;44954.550454495526;8533.40266181366;8682.392232543725;8711.869321960145;8717.738467845975;8722.084181160983;8935.865962010575;9066.45601263923;9067.047959964175;9069.501177435239;9071.455712657262;9049.502277374742;9062.275017998578;9119.544022798833;9126.77183070422;9133.36066475347;9003.14470125337;9060.818783624356;9069.093090690943;9076.500792456412;9077.273818094569;8822.808920795675;8935.463872167626;8954.910450895473;8954.955225223897;8961.955190224073;42797.786011069744;43227.78386108081;43278.13443731139;43321.78339108284;43484.13031739347;3472.2187507810795;3622.094476380905;3674.0998455378603;3741.28915506053;4060.553339132693;31708.682913170804;32320.191995200308;32543.83728081368;32651.346973060645;35210;3990.38149086892;3990.4812374391436;4017.4375587417785;4044.090079732037;4112.992316882353;306365;306754;307432;307543;307787;60431;60653.696731516946;60919.344839309786;61161.38838611646;61363.6931815338;59756.402435975084;63730.6813465939;65042;65171.348286517474;71384;16176.514704558882;16221;16258.837411625733;16397.83602163987;16406.83593164077;11068.28056176346;12422.254664720145;12428.192167509083;12438.875611243953;12467.812982805266;18507.814921850608;18658;19001.23995040183;19527.804721952598;19574.70637940432;6636.2368327642935;6691.397774200345;6706.83232919181;6817.829554261183;7041;958.6500927161675;1061.368485750977;1114.6656003199007;1148.2536351371675;1192.0701852554848;32729.509057364157;32984.3403131936;33262;33266.66733332684;33552.66447335544;1098.780243951213;1148.052856393462;1166.9416529173507;1223.3944197622234;1224.6632176151452;17703.645927081645;17724.645507089786;17779.822201778075;17808.267019233375;17926.5518362042;444278;446045;448955;450465;450716;60876.391236087955;60889.39110608926;60916;60969.39030609726;60997.39002610006;1254.6737848159544;1356.7083077138464;1367.6444124527495;1396.6717821311984;1403.3404299978993;32664.673353266164;34204.65795342114;34599.13502162466;34884.30231395409;34884.82557587196;52047.47952520426;52164.7391763054;52683.73658131685;52693.47306527039;52708.47291527036;363686;365401;367808;369470;372385;37819.62180378161;46536.301955471376;47555.52444475649;47607;47917.5208247913;49667.75166124291;50314.74842625763;50522;51004.48995510146;51506;42425.36361954511;42543;43415.13169736651;43427;44423.333649995926;42813;43129.3530597035;43366;43481.78259108811;43834.342484862114;41052;41480.58519414888;43994;44415.333769994126;44467;36525.26949461049;38008.429873551366;38223.617763822;38353.616463835;38582;28730.856345718974;29061.273468163465;29473;29509.409811804075;29714.405711886073 05:41:22 INFO - PROCESS | 6665 | |2;jquery.html;391.1141265034695;396.3954968672772;401.80512451461044;407.5598353777919;423.49392475991186;13154.139482940463;18068.186931588076;19572.11925463354;19663.31178408756;20015.799842001612;14847.851521484781;18450.72323915139;18917.90541047293;19714.112864921077;19982.300619478323;5670;5793.33376661683;5827.854303642401;5838.357780644125;5851.093080572518;5694.971525142369;5756.856078598048;5780.710964451781;5781.942180578203;5782.624129431573;4092.4679791627045;4270.338097594862;5588.636738611997;6371;6384.07430922516;6376.585521941059;6465.547411681184;6478.902816457757;6489.967550162266;6490.188726409199;5592.916106258409;5699.601027928046;5707.71461426927;5734.4265573442735;5747.62640428375;23258.06967721289;23314.417139571648;23428.531429371316;23687.526249474915;24142;2305.654151877215;2499.687539057618;2886.1197334812873;3126.120384017838;3231.5475833383343;9987.950060249725;14000.22998735069;14221.786673199911;14447.78328325076;15096.320665569965;1937.7674679038464;1980.23760852073;2003.2788196249485;2033.3290014295394;2042.7548694156649;83903;84304.15695843025;84428;88074.55962720145;88782.55608721916;9068.773280668036;9739.220862330996;9862.063104005108;9999.35004224723;10092;13347.933260333637;13503.59489215325;13571.86428135706;13628.454861805614;13650.931745341408;7626.656800443993;7817.960910195527;7842.882356764653;7952.1650226726515;7989.2809647132035;7822.1004584472375;7855.960720196476;7871.685132594632;7920.960395198103;8051.919480805234;4145.253854306194;4158.91682166355;4195.664346852244;4197.391378250137;4488.663350248745;1834.2204563060645;1946.1826033066145;1952.5704345044066;1993.0831817364176;2014.4963759060236;456.64609927306606;460.2245216809686;975.3611384543135;1057.5740525898984;1082.2478377527543;10677.572897084185;10971.451427428598;11111.222214444912;11170.218084734153;11225.438728063564;463.5781438890661;467.50211025257994;470.5506241539322;474.10867568970804;480.57229066131174;5936.465718085306;6032.969835150796;6036.879262414727;6040.09398590215;6151;531518;531585;531974;533140;553957;92875;94673;96013.5199323999;96040;96324;516.8036146264395;516.9612279079084;524.3026774390052;525.5270256768938;526.9947300527023;10776.946115269373;11273.7745245093;11315.773684526428;11375.886241137483;11390.772184556428;37242.44136337903;38053.61946380501;38797.6120238794;39137;39534;54032.72983635057;55088.44911550994;55244;55481;55499.44500554943;8707.3034157266;8763.824723505622;8921.776955575902;9030.503322317336;9052.592633331647;10183.490825458846;10671.35971841692;13546.32268386557;13690.65773355674;13776.586702398945;11560.364179970182;11814.409279536161;12008.279503229835;12024.218425802295;12390.380480976095;11640.35978021217;11648.35934023603;11756.647300580997;11843.763124737285;11986;11847.289162650268;12064.276143431422;12112.939435302767;12228.144029918176;12271.325077120488;8917.28661707075;8971.192592666692;8996.100389961213;9035.909640903506;9189.908100918905;8923.241524470493;11155.888441115485;11494.597689080842;11748.58879939198;11894.881051189723 05:41:22 INFO - PROCESS | 6665 | |3;mootools.html;1379.7723375643022;1394.623451668049;1456.6795305032892;1526.8167819861612;1749.641323528676;8220.671173153067;8425.83148337033;8435.072142064368;8666.176713212251;8682.86975695365;8417.579121043955;8573.785655358619;8603.655853765858;8623.310135189186;8637.438566493174;1966.48871293464;2258.390234636647;2276.8520046197027;2310.514791893704;2315.7915787579113;2311.05246848792;2311.9422014449688;2312.479692069288;2313.2366319114735;2313.6413855852284;2237.496563273267;2298.9310320690324;2300.2869110575775;2303.1478353009325;2304.7810458006547;1944.4652720501833;2222.299975507718;2290.931272061841;2293.2203050962585;2308.6190778521523;2275.7724227577273;2297.310806757966;2301.9309420717404;2302.3898666853297;2306.7693230676964;8580.099089595566;8605.053444121142;8606.956965215133;8622.482651040958;8629.784255393603;5127.512886275797;5250.212468129773;5257.106291930381;5282.656627319212;5290.497402746733;3123.3909387669414;3213.7589680774036;3221.5650887130173;3233.401820663185;3249.723773479257;986.5954958467066;999.5801763259449;1000.5697550053474;1007.1892126837893;1017.5624481473037;11574.71063223426;11577.710557236052;11611.245269057485;11653;11821.231619944761;4660.464046634613;4767.165745994437;4768.856934291976;4799.280107983761;4820.156472617278;9833.901660983442;9853;9889.554970026365;9919.603215871428;10056.74858128538;4572.634189264851;5071.467495912876;5244.475552444801;5251.212318152231;5253.3958594761325;4276.871693849127;4386.8025938832825;4392.714473559208;4750.12122757291;4886.291487734258;3926.587708290588;3970.662493688011;4032.1532478179324;4044.51465824103;4142.902130935305;1184.224333061846;1190.7201807575213;1211.8000529912642;1259.6598918292193;1264.2730430002784;974.2595627323285;974.7270764186039;988;988.3431304174583;992.3599278465493;5715.085586306171;5760.251167348218;5825.155352473867;5876.44173803488;5937.82186534396;444.23147954039695;450.73406690053025;450.83769842856543;451.14958303597297;461.803733413298;4005.0588111793704;4054.0675644601906;4062.878113656595;4083.1629515949157;4085.346344584852;9856.901430985597;10486.213533984981;10494.632687855888;10549.578016879239;10557.102646275;10188.286819922683;10333.896661033294;10396.636117735994;10465.058144767008;10483.737906552396;7847.215278472221;7911.485753426124;7927.5243485391065;7967.123616402191;7991.68033278674;5606.943930560642;5680.857978550569;5744.454276843693;5770.192173095854;5916.7041647918295;9456.385334953206;9481.146696797321;9513.191378732885;9660.903390966001;9778.119969202806;9630.181434577858;9771.267154963263;9847.261455390731;9884.456354900549;9936.602535898483;6542.149520562297;7150.141982962078;7300.087489063867;7545.170031296443;7552.848943020999;8330;8473.152684731724;8507.82984340322;8536.871946920677;8544.74365769028;7561.09266887977;7770.766876993699;7784.455088143775;7795.610219489116;7813.531188128731;7492;7500.549967001779;7587.165411804586;7640.388768898586;7729.845403092019;7100.715971361295;7104.11198600175;7115.822104447223;7122.967169760252;7141.535800172972;4724.314974328634;4862.951370486391;4894.657373983787;4969.304297398295;4983.601311895112;4988.825391111293;5005.424376196784;5073.695578265316;5156.948430515647;5302.28419163408 05:41:22 INFO - PROCESS | 6665 | |4;prototype.html;325.54748899030346;332.20602759405017;336.27700444045297;342.16682378408564;343.93465241604093;5201.817936372227;5252.89494210116;5261.210818377245;5273.472652734725;5324.813631522898;5257.605679574028;5281.705982034407;5283.339582552181;5287.259783630295;5305.336832895888;3882.4664257618224;3908.374660054392;4050.9189816203657;4056.8782936511952;4126.195391898581;4076.347784354504;4079.551759125512;4098.9590104099025;4114.300568903293;4117.9176416471655;3880.3120642520453;4032.1935612877396;4055.290324193269;4058.472398588179;4076.184763047402;3939.5469521005166;4073.7594323122166;4084.1627466369323;4095.7133000689964;4096.73371230869;3639.1448009717697;3639.5450568678916;3640.854365825364;3643.2713457308646;3660.3228402745312;5018.04657115147;5022.648414610979;5023.824166154167;5069.847904562869;5080.187170052811;4585.395111710908;4697.107549565571;4715.1748444022505;4715.41057367829;4718.221493453576;5296.311479507678;5354.651947623392;5397;5397.136458166675;5402.729863506848;4003.5195776507007;4019;4020.618041286073;4023.2556976959354;4032.3145065338963;5420;5634.098544232903;5644.266245388073;5672.716364181774;5699.116636921284;3959.8614048508166;3965.40518922164;3965.4448377227213;3968.2261958917734;4005.899852503711;4022.778747168934;4061.5735347788645;4061.918761624751;4065.4511640928686;4071;4468.977655111704;4571.702839315434;4621.930671039937;4649.69776964503;4658.627309815207;5420.83737487876;5447.400785913546;5477.452254774491;5489.6980666062955;5503.284573005483;1381.4336122189854;1405.641561401836;1410.1961881727316;1413;1418.7517184492879;911.9680811171577;920.8940971788196;1001.1240164855751;1022.6318525330875;1023.5138309303021;5177.741112944413;5194.246834209094;5215.556677682363;5244.449332819999;5295.391030031596;5501.642393244506;5522.447755224445;5533.6403133796175;5549.250851135045;5567.498925096761;4986.326845875833;5129.666571672829;5166.302549155891;5213.635045546851;5229.660072095302;2887.321479452327;2892.7975041746877;2930.1941965959104;2944.617199764017;2952.468555659959;5459.426760190202;5616.803411880564;5654.6889921054735;5660.15097735343;5685.687287199161;5443.646162999393;5526.640768350045;5547.41752116022;5572.746132120241;5602.467765562265;5573.888522229533;5604.159376093537;5649.802256921071;5692.63755541454;5702.460335709418;5362.892742145214;5495.005222153855;5511.751971161227;5528.612997090165;5549.694766787866;5326.41409444953;5458.263134476795;5459.781608735606;5463.644863083887;5477.4796394342475;5569.832905012856;5596.1605759136455;5634.7464364104535;5641.702408445998;5694.373618902;3947.526296844397;4089.815958281825;4096.856610018635;4097.405876148002;4097.713160078766;5438.483344082306;5461.563074954073;5495.917561236504;5498.80754173602;5510.201020852034;5342.572594192533;5362.1420572708175;5368.382635996911;5387.353517577916;5389.464002759351;5157.613179011514;5432.6468779529205;5511.917321240265;5529.225908372911;5557.41647127062;5180.248863914787;5221.843344699665;5329.653572517774;5369.301990741179;5384.784608615611;5513;5529.917051244315;5554.194641776839;5560.638558493685;5563.332400112013;5452.727363631882;5472.112121318139;5473.2063850742215;5498.285222920995;5508.531774799187 05:41:22 INFO - PROCESS | 6665 | |5;yui.html;659.6800551732409;734.6914295995681;756.7654027251549;757.5038349880823;766.0194950463407;13488.123271987326;14105.788413173797;14110.435582576698;14181.43274269028;15399.384024639001;13416.396262168202;13460.125091869022;13537.323133843318;13567.253801040939;13569.796453053212;703.8557095795376;834;834.5118105908051;859.0679113162226;866.8483015472299;854.5769843927264;854.9444286121383;856.1524091149779;856.3063918226226;856.9485830850138;900.5767289373983;903.5391950105461;903.661127077346;904.9140331668481;905.7961958559305;722.0613202836319;866.6576702202658;886.4193952960821;891.8038031633031;893.4415990006246;648.0861984601736;648.1412128929188;648.1541588227361;648.2933602373389;648.9286178520359;14250.2162381069;14262.85737142636;14294.571162865132;14302.427902883872;14302.856971430256;12889;13167.60497185086;13242.404091815892;13265.071444998854;13463.596092117154;11319.717007074807;11360.318380897173;11373.943130284379;11456.4844581994;11651.126165537618;4225.176090662322;4310.870673879788;4333.4799824021;4449;4473.463184417858;52861;53025.46974530244;53026.73486632581;53133;53195.20207196895;9119.680811171576;9250.4912229828;9331.90668093324;9392.201662858597;9745.951270243604;18862.811371886106;19107.23571057142;19108;19108.904455477634;19585.608287834162;8108.2297181767635;8139.918600814034;8149.429539932148;8167.509949403055;8331.16688331162;4112.527059388209;4214.957850421518;4224.345226489899;4244.108737165168;4260.680448966278;3253.3818574470774;3347.7656564040285;3349.1794510344635;3351.2292172799903;3353.2622822978906;614.7295190116424;619.5663035874906;620.0079872204437;637.7225906730587;645.5674697952384;529.20090663099;555.2088274209235;619.5229673151738;625.3121566277059;625.7547480513745;8300.750977470685;8449.57752112392;8528.488290702579;8588.785280367916;8607.913920860712;535.9946400536023;563.7068724263443;600.8477307091706;601.5187849720206;610.5725991805754;4066.2070896175555;4082.4488694026522;4088.202800453883;4126.525449573277;4185.6232939035635;58750.11874821796;61018.69490652518;65323;66371;66515.33484665188;41298.174036519704;43668.78165609215;45795.54204457979;56493.43506564882;57961.710191449616;51091.233631495554;51118;51955.74022129865;52347;52768;8465.195806398382;8575.485470871768;8599.226069653761;8600.741977740678;8634.654613815377;31625.683743163194;32889;33029.66970330362;33199;34725;38587;39700;44101;44534.331985019606;44748.32877506775;9940.701778946643;9951.950240248752;10276.280660353703;11355.716107097389;11491.655250342503;10691.518881650189;10727.249092563447;10796.352218866894;10818.837717434402;10959.178061645567;10583.417912014605;10612.893871061191;10866.0220580145;10918.727031824268;11393;10573.788524229627;10763.246572739834;10770.246082774443;10838.349699018085;10962.451877406258;10365.63720269787;10526.157907367546;10539.314944528582;10720.946395267974;10929.726756831144;8511.446755960842;9129.668693386277;9263.583138758637;9356.157945784911;9393.154616084585;8696.913030869864;8851.380403371702;8879.556022198993;8893.510856902674;9127.497987610745 05:41:22 INFO - PROCESS | 6665 | __end_tp_report 05:41:22 INFO - PROCESS | 6665 | __start_cc_report 05:41:22 INFO - PROCESS | 6665 | _x_x_mozilla_cycle_collect,862 05:41:22 INFO - PROCESS | 6665 | __end_cc_report 05:41:22 INFO - PROCESS | 6665 | __startTimestamp1463056882787__endTimestamp 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | ------- Summary: start ------- 05:41:22 INFO - PROCESS | 6665 | Number of tests: 6 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#0] dojo.html Cycles:165 Average:5370.91 Median:5628.38 stddev:625.89 (11.1%) stddev-sans-first:603.43 05:41:22 INFO - PROCESS | 6665 | Values: 3165.7 3166.8 3190.6 3203.7 3218.0 5192.7 5276.3 5290.5 5322.1 5354.4 5302.7 5318.5 5348.1 5392.6 5413.9 4806.5 4814.7 4839.4 4848.6 4977.3 4879.2 4928.8 4943.8 4948.2 4954.6 4716.2 4779.4 4810.9 4851.0 4899.7 4795.9 4807.6 4819.1 4861.4 4891.5 4819.0 4824.3 4826.0 4831.6 4833.5 5182.4 5251.2 5338.4 5349.7 5404.2 5763.7 5851.5 5856.8 5858.8 5860.5 5558.1 5918.1 5919.2 5945.9 5948.5 5390.3 5409.1 5433.7 5493.5 5507.8 5955.0 5992.7 6006.1 6009.6 6011.4 5485.0 5772.9 5779.2 5779.5 5781.2 5689.3 5708.4 5714.5 5769.9 5772.7 5680.1 5721.5 5735.5 5745.0 5745.2 5434.8 5640.6 5732.5 5751.7 5759.5 4335.7 4358.4 4382.7 4391.5 4429.5 3925.5 3929.1 3930.2 3934.2 3974.0 5352.3 5404.4 5479.1 5542.7 5578.3 5839.4 5859.4 5864.1 5879.3 5883.0 5557.0 5563.1 5564.8 5565.4 5567.4 4761.8 4984.8 5017.3 5041.2 5076.6 6073.5 6073.7 6092.2 6095.9 6138.5 5890.4 5895.1 5900.0 5904.6 5904.6 5806.7 5871.6 5909.7 5911.1 6089.5 5657.5 5657.7 5665.2 5670.4 5676.5 5720.1 5733.1 5784.6 5786.0 5790.6 5543.4 5677.6 5679.0 5728.3 5749.0 5699.6 5700.8 5703.3 5704.7 5717.9 5341.3 5595.4 5600.1 5635.5 5649.8 5649.7 5692.2 5743.9 5814.0 5816.9 5628.4 5634.5 5635.2 5636.2 5671.8 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#1] ext.html Cycles:180 Average:56082.52 Median:43390.57 stddev:99594.58 (229.5%) stddev-sans-first:99786.93 05:41:22 INFO - PROCESS | 6665 | Values: 627.6 648.8 649.9 656.9 669.6 44514.8 45637.8 45645.8 48310.0 48329.8 44161.0 44869.3 44892.6 44938.0 44954.6 8533.4 8682.4 8711.9 8717.7 8722.1 8935.9 9066.5 9067.0 9069.5 9071.5 9049.5 9062.3 9119.5 9126.8 9133.4 9003.1 9060.8 9069.1 9076.5 9077.3 8822.8 8935.5 8954.9 8955.0 8962.0 42797.8 43227.8 43278.1 43321.8 43484.1 3472.2 3622.1 3674.1 3741.3 4060.6 31708.7 32320.2 32543.8 32651.3 35210.0 3990.4 3990.5 4017.4 4044.1 4113.0 306365.0 306754.0 307432.0 307543.0 307787.0 60431.0 60653.7 60919.3 61161.4 61363.7 59756.4 63730.7 65042.0 65171.3 71384.0 16176.5 16221.0 16258.8 16397.8 16406.8 11068.3 12422.3 12428.2 12438.9 12467.8 18507.8 18658.0 19001.2 19527.8 19574.7 6636.2 6691.4 6706.8 6817.8 7041.0 958.7 1061.4 1114.7 1148.3 1192.1 32729.5 32984.3 33262.0 33266.7 33552.7 1098.8 1148.1 1166.9 1223.4 1224.7 17703.6 17724.6 17779.8 17808.3 17926.6 444278.0 446045.0 448955.0 450465.0 450716.0 60876.4 60889.4 60916.0 60969.4 60997.4 1254.7 1356.7 1367.6 1396.7 1403.3 32664.7 34204.7 34599.1 34884.3 34884.8 52047.5 52164.7 52683.7 52693.5 52708.5 363686.0 365401.0 367808.0 369470.0 372385.0 37819.6 46536.3 47555.5 47607.0 47917.5 49667.8 50314.7 50522.0 51004.5 51506.0 42425.4 42543.0 43415.1 43427.0 44423.3 42813.0 43129.4 43366.0 43481.8 43834.3 41052.0 41480.6 43994.0 44415.3 44467.0 36525.3 38008.4 38223.6 38353.6 38582.0 28730.9 29061.3 29473.0 29509.4 29714.4 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#2] jquery.html Cycles:180 Average:29763.91 Median:2346.92 stddev:88451.92 (3768.9%) stddev-sans-first:88672.56 05:41:22 INFO - PROCESS | 6665 | Values: 391.1 396.4 401.8 407.6 423.5 13154.1 18068.2 19572.1 19663.3 20015.8 14847.9 18450.7 18917.9 19714.1 19982.3 5670.0 5793.3 5827.9 5838.4 5851.1 5695.0 5756.9 5780.7 5781.9 5782.6 4092.5 4270.3 5588.6 6371.0 6384.1 6376.6 6465.5 6478.9 6490.0 6490.2 5592.9 5699.6 5707.7 5734.4 5747.6 23258.1 23314.4 23428.5 23687.5 24142.0 2305.7 2499.7 2886.1 3126.1 3231.5 9988.0 14000.2 14221.8 14447.8 15096.3 1937.8 1980.2 2003.3 2033.3 2042.8 83903.0 84304.2 84428.0 88074.6 88782.6 9068.8 9739.2 9862.1 9999.4 10092.0 13347.9 13503.6 13571.9 13628.5 13650.9 7626.7 7818.0 7842.9 7952.2 7989.3 7822.1 7856.0 7871.7 7921.0 8051.9 4145.3 4158.9 4195.7 4197.4 4488.7 1834.2 1946.2 1952.6 1993.1 2014.5 456.6 460.2 975.4 1057.6 1082.2 10677.6 10971.5 11111.2 11170.2 11225.4 463.6 467.5 470.6 474.1 480.6 5936.5 6033.0 6036.9 6040.1 6151.0 531518.0 531585.0 531974.0 533140.0 553957.0 92875.0 94673.0 96013.5 96040.0 96324.0 516.8 517.0 524.3 525.5 527.0 10776.9 11273.8 11315.8 11375.9 11390.8 37242.4 38053.6 38797.6 39137.0 39534.0 54032.7 55088.4 55244.0 55481.0 55499.4 8707.3 8763.8 8921.8 9030.5 9052.6 10183.5 10671.4 13546.3 13690.7 13776.6 11560.4 11814.4 12008.3 12024.2 12390.4 11640.4 11648.4 11756.6 11843.8 11986.0 11847.3 12064.3 12112.9 12228.1 12271.3 8917.3 8971.2 8996.1 9035.9 9189.9 8923.2 11155.9 11494.6 11748.6 11894.9 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#3] mootools.html Cycles:180 Average:5622.90 Median:5038.45 stddev:3182.07 (63.2%) stddev-sans-first:3175.02 05:41:22 INFO - PROCESS | 6665 | Values: 1379.8 1394.6 1456.7 1526.8 1749.6 8220.7 8425.8 8435.1 8666.2 8682.9 8417.6 8573.8 8603.7 8623.3 8637.4 1966.5 2258.4 2276.9 2310.5 2315.8 2311.1 2311.9 2312.5 2313.2 2313.6 2237.5 2298.9 2300.3 2303.1 2304.8 1944.5 2222.3 2290.9 2293.2 2308.6 2275.8 2297.3 2301.9 2302.4 2306.8 8580.1 8605.1 8607.0 8622.5 8629.8 5127.5 5250.2 5257.1 5282.7 5290.5 3123.4 3213.8 3221.6 3233.4 3249.7 986.6 999.6 1000.6 1007.2 1017.6 11574.7 11577.7 11611.2 11653.0 11821.2 4660.5 4767.2 4768.9 4799.3 4820.2 9833.9 9853.0 9889.6 9919.6 10056.7 4572.6 5071.5 5244.5 5251.2 5253.4 4276.9 4386.8 4392.7 4750.1 4886.3 3926.6 3970.7 4032.2 4044.5 4142.9 1184.2 1190.7 1211.8 1259.7 1264.3 974.3 974.7 988.0 988.3 992.4 5715.1 5760.3 5825.2 5876.4 5937.8 444.2 450.7 450.8 451.1 461.8 4005.1 4054.1 4062.9 4083.2 4085.3 9856.9 10486.2 10494.6 10549.6 10557.1 10188.3 10333.9 10396.6 10465.1 10483.7 7847.2 7911.5 7927.5 7967.1 7991.7 5606.9 5680.9 5744.5 5770.2 5916.7 9456.4 9481.1 9513.2 9660.9 9778.1 9630.2 9771.3 9847.3 9884.5 9936.6 6542.1 7150.1 7300.1 7545.2 7552.8 8330.0 8473.2 8507.8 8536.9 8544.7 7561.1 7770.8 7784.5 7795.6 7813.5 7492.0 7500.5 7587.2 7640.4 7729.8 7100.7 7104.1 7115.8 7123.0 7141.5 4724.3 4863.0 4894.7 4969.3 4983.6 4988.8 5005.4 5073.7 5156.9 5302.3 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#4] prototype.html Cycles:180 Average:4576.94 Median:5248.67 stddev:1323.45 (25.2%) stddev-sans-first:1288.12 05:41:22 INFO - PROCESS | 6665 | Values: 325.5 332.2 336.3 342.2 343.9 5201.8 5252.9 5261.2 5273.5 5324.8 5257.6 5281.7 5283.3 5287.3 5305.3 3882.5 3908.4 4050.9 4056.9 4126.2 4076.3 4079.6 4099.0 4114.3 4117.9 3880.3 4032.2 4055.3 4058.5 4076.2 3939.5 4073.8 4084.2 4095.7 4096.7 3639.1 3639.5 3640.9 3643.3 3660.3 5018.0 5022.6 5023.8 5069.8 5080.2 4585.4 4697.1 4715.2 4715.4 4718.2 5296.3 5354.7 5397.0 5397.1 5402.7 4003.5 4019.0 4020.6 4023.3 4032.3 5420.0 5634.1 5644.3 5672.7 5699.1 3959.9 3965.4 3965.4 3968.2 4005.9 4022.8 4061.6 4061.9 4065.5 4071.0 4469.0 4571.7 4621.9 4649.7 4658.6 5420.8 5447.4 5477.5 5489.7 5503.3 1381.4 1405.6 1410.2 1413.0 1418.8 912.0 920.9 1001.1 1022.6 1023.5 5177.7 5194.2 5215.6 5244.4 5295.4 5501.6 5522.4 5533.6 5549.3 5567.5 4986.3 5129.7 5166.3 5213.6 5229.7 2887.3 2892.8 2930.2 2944.6 2952.5 5459.4 5616.8 5654.7 5660.2 5685.7 5443.6 5526.6 5547.4 5572.7 5602.5 5573.9 5604.2 5649.8 5692.6 5702.5 5362.9 5495.0 5511.8 5528.6 5549.7 5326.4 5458.3 5459.8 5463.6 5477.5 5569.8 5596.2 5634.7 5641.7 5694.4 3947.5 4089.8 4096.9 4097.4 4097.7 5438.5 5461.6 5495.9 5498.8 5510.2 5342.6 5362.1 5368.4 5387.4 5389.5 5157.6 5432.6 5511.9 5529.2 5557.4 5180.2 5221.8 5329.7 5369.3 5384.8 5513.0 5529.9 5554.2 5560.6 5563.3 5452.7 5472.1 5473.2 5498.3 5508.5 05:41:22 INFO - PROCESS | 6665 | 05:41:22 INFO - PROCESS | 6665 | [#5] yui.html Cycles:180 Average:14104.23 Median:52814.50 stddev:16809.56 (31.8%) stddev-sans-first:16826.40 05:41:22 INFO - PROCESS | 6665 | Values: 659.7 734.7 756.8 757.5 766.0 13488.1 14105.8 14110.4 14181.4 15399.4 13416.4 13460.1 13537.3 13567.3 13569.8 703.9 834.0 834.5 859.1 866.8 854.6 854.9 856.2 856.3 856.9 900.6 903.5 903.7 904.9 905.8 722.1 866.7 886.4 891.8 893.4 648.1 648.1 648.2 648.3 648.9 14250.2 14262.9 14294.6 14302.4 14302.9 12889.0 13167.6 13242.4 13265.1 13463.6 11319.7 11360.3 11373.9 11456.5 11651.1 4225.2 4310.9 4333.5 4449.0 4473.5 52861.0 53025.5 53026.7 53133.0 53195.2 9119.7 9250.5 9331.9 9392.2 9746.0 18862.8 19107.2 19108.0 19108.9 19585.6 8108.2 8139.9 8149.4 8167.5 8331.2 4112.5 4215.0 4224.3 4244.1 4260.7 3253.4 3347.8 3349.2 3351.2 3353.3 614.7 619.6 620.0 637.7 645.6 529.2 555.2 619.5 625.3 625.8 8300.8 8449.6 8528.5 8588.8 8607.9 536.0 563.7 600.8 601.5 610.6 4066.2 4082.4 4088.2 4126.5 4185.6 58750.1 61018.7 65323.0 66371.0 66515.3 41298.2 43668.8 45795.5 56493.4 57961.7 51091.2 51118.0 51955.7 52347.0 52768.0 8465.2 8575.5 8599.2 8600.7 8634.7 31625.7 32889.0 33029.7 33199.0 34725.0 38587.0 39700.0 44101.0 44534.3 44748.3 9940.7 9952.0 10276.3 11355.7 11491.7 10691.5 10727.2 10796.4 10818.8 10959.2 10583.4 10612.9 10866.0 10918.7 11393.0 10573.8 10763.2 10770.2 10838.3 10962.5 10365.6 10526.2 10539.3 10720.9 10929.7 8511.4 9129.7 9263.6 9356.2 9393.2 8696.9 8851.4 8879.6 8893.5 9127.5 05:41:22 INFO - PROCESS | 6665 | -------- Summary: end -------- 05:41:22 INFO - PROCESS | 6665 | 05:41:23 INFO - TEST-INFO | 6665: exit 0 05:41:23 INFO - TEST-OK | dromaeo_css | took 1113122ms 05:41:23 INFO - TEST-START | kraken 05:41:23 INFO - operating with platform_type : linux_ 05:41:23 INFO - Initialising browser for kraken test... 05:41:23 INFO - TEST-INFO | started process 6841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYwKbfV/profile http://localhost:35420/getInfo.html) 05:41:27 INFO - PROCESS | 6841 | __metrics Screen width/height:1600/1200 05:41:27 INFO - PROCESS | 6841 | colorDepth:24 05:41:27 INFO - PROCESS | 6841 | Browser inner width/height: 1024/697 05:41:27 INFO - PROCESS | 6841 | __metrics 05:41:28 ERROR - PROCESS | 6841 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:41:29 INFO - TEST-INFO | 6841: exit 0 05:41:29 INFO - Browser initialized. 05:41:29 INFO - Running cycle 1/1 for kraken test... 05:41:29 INFO - TEST-INFO | started process 6920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYwKbfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:41 INFO - PROCESS | 6920 | RSS: Main: 152252416 05:41:41 INFO - PROCESS | 6920 | 05:41:43 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35420/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:44 INFO - PROCESS | 6920 | RSS: Main: 208236544 05:41:44 INFO - PROCESS | 6920 | 05:41:47 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35420/tests/kraken/driver.html?testName=audio-dft) 05:41:47 INFO - PROCESS | 6920 | RSS: Main: 197181440 05:41:47 INFO - PROCESS | 6920 | 05:41:51 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35420/tests/kraken/driver.html?testName=audio-fft) 05:41:51 INFO - PROCESS | 6920 | RSS: Main: 264962048 05:41:51 INFO - PROCESS | 6920 | 05:41:53 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35420/tests/kraken/driver.html?testName=audio-oscillator) 05:41:54 INFO - PROCESS | 6920 | RSS: Main: 174395392 05:41:54 INFO - PROCESS | 6920 | 05:41:56 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:57 INFO - PROCESS | 6920 | RSS: Main: 178647040 05:41:57 INFO - PROCESS | 6920 | 05:42:00 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35420/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:01 INFO - PROCESS | 6920 | RSS: Main: 214466560 05:42:01 INFO - PROCESS | 6920 | 05:42:04 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35420/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:05 INFO - PROCESS | 6920 | RSS: Main: 212262912 05:42:05 INFO - PROCESS | 6920 | 05:42:08 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35420/tests/kraken/driver.html?testName=json-parse-financial) 05:42:08 INFO - PROCESS | 6920 | RSS: Main: 213127168 05:42:08 INFO - PROCESS | 6920 | 05:42:10 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:11 INFO - PROCESS | 6920 | RSS: Main: 202678272 05:42:11 INFO - PROCESS | 6920 | 05:42:13 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:13 INFO - PROCESS | 6920 | RSS: Main: 206675968 05:42:13 INFO - PROCESS | 6920 | 05:42:15 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:16 INFO - PROCESS | 6920 | RSS: Main: 214749184 05:42:16 INFO - PROCESS | 6920 | 05:42:19 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:19 INFO - PROCESS | 6920 | RSS: Main: 223309824 05:42:19 INFO - PROCESS | 6920 | 05:42:22 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:23 INFO - PROCESS | 6920 | RSS: Main: 219660288 05:42:23 INFO - PROCESS | 6920 | 05:42:24 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:35420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35420/tests/kraken/driver.html?testName=ai-astar) 05:42:25 INFO - PROCESS | 6920 | RSS: Main: 265252864 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | __start_tp_report 05:42:25 INFO - PROCESS | 6920 | _x_x_mozilla_page_load 05:42:25 INFO - PROCESS | 6920 | _x_x_mozilla_page_load_details 05:42:25 INFO - PROCESS | 6920 | |i|pagename|runs| 05:42:25 INFO - PROCESS | 6920 | |0;ai-astar;113;107;111;112;108;109;110;109;109;109 05:42:25 INFO - PROCESS | 6920 | |1;audio-beat-detection;148;130;158;221;126;164;155;133;183;123 05:42:25 INFO - PROCESS | 6920 | |2;audio-dft;160;159;160;160;161;162;160;160;160;160 05:42:25 INFO - PROCESS | 6920 | |3;audio-fft;76;75;76;156;76;75;78;75;129;74 05:42:25 INFO - PROCESS | 6920 | |4;audio-oscillator;93;91;150;92;92;92;117;91;91;137 05:42:25 INFO - PROCESS | 6920 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;116;116;117 05:42:25 INFO - PROCESS | 6920 | |6;imaging-darkroom;145;146;146;145;146;146;145;146;146;145 05:42:25 INFO - PROCESS | 6920 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:42:25 INFO - PROCESS | 6920 | |8;json-parse-financial;61;59;58;59;58;65;58;117;56;57 05:42:25 INFO - PROCESS | 6920 | |9;json-stringify-tinderbox;59;57;59;58;58;58;57;58;58;59 05:42:25 INFO - PROCESS | 6920 | |10;stanford-crypto-aes;82;84;79;79;79;80;81;80;79;82 05:42:25 INFO - PROCESS | 6920 | |11;stanford-crypto-ccm;126;123;123;123;120;129;120;123;185;124 05:42:25 INFO - PROCESS | 6920 | |12;stanford-crypto-pbkdf2;167;165;166;166;164;164;164;167;164;166 05:42:25 INFO - PROCESS | 6920 | |13;stanford-crypto-sha256-iterative;66;64;65;65;68;64;68;64;67;63 05:42:25 INFO - PROCESS | 6920 | __end_tp_report 05:42:25 INFO - PROCESS | 6920 | __start_cc_report 05:42:25 INFO - PROCESS | 6920 | _x_x_mozilla_cycle_collect,1824 05:42:25 INFO - PROCESS | 6920 | __end_cc_report 05:42:25 INFO - PROCESS | 6920 | __startTimestamp1463056945087__endTimestamp 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | ------- Summary: start ------- 05:42:25 INFO - PROCESS | 6920 | Number of tests: 14 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#0] ai-astar Cycles:10 Average:109.70 Median:109.50 stddev:1.83 (1.7%) stddev-sans-first:1.50 05:42:25 INFO - PROCESS | 6920 | Values: 113.0 107.0 111.0 112.0 108.0 109.0 110.0 109.0 109.0 109.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:156.50 stddev:30.27 (19.3%) stddev-sans-first:32.02 05:42:25 INFO - PROCESS | 6920 | Values: 148.0 130.0 158.0 221.0 126.0 164.0 155.0 133.0 183.0 123.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:42:25 INFO - PROCESS | 6920 | Values: 160.0 159.0 160.0 160.0 161.0 162.0 160.0 160.0 160.0 160.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#3] audio-fft Cycles:10 Average:89.00 Median:75.50 stddev:28.93 (38.3%) stddev-sans-first:30.29 05:42:25 INFO - PROCESS | 6920 | Values: 76.0 75.0 76.0 156.0 76.0 75.0 78.0 75.0 129.0 74.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:91.50 stddev:22.19 (24.2%) stddev-sans-first:23.13 05:42:25 INFO - PROCESS | 6920 | Values: 93.0 91.0 150.0 92.0 92.0 92.0 117.0 91.0 91.0 137.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:42:25 INFO - PROCESS | 6920 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:42:25 INFO - PROCESS | 6920 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:42:25 INFO - PROCESS | 6920 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:58.50 stddev:18.51 (31.6%) stddev-sans-first:19.58 05:42:25 INFO - PROCESS | 6920 | Values: 61.0 59.0 58.0 59.0 58.0 65.0 58.0 117.0 56.0 57.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 05:42:25 INFO - PROCESS | 6920 | Values: 59.0 57.0 59.0 58.0 58.0 58.0 57.0 58.0 58.0 59.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:1.72 (2.1%) stddev-sans-first:1.73 05:42:25 INFO - PROCESS | 6920 | Values: 82.0 84.0 79.0 79.0 79.0 80.0 81.0 80.0 79.0 82.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:123.50 stddev:19.64 (15.9%) stddev-sans-first:20.79 05:42:25 INFO - PROCESS | 6920 | Values: 126.0 123.0 123.0 123.0 120.0 129.0 120.0 123.0 185.0 124.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 05:42:25 INFO - PROCESS | 6920 | Values: 167.0 165.0 166.0 166.0 164.0 164.0 164.0 167.0 164.0 166.0 05:42:25 INFO - PROCESS | 6920 | 05:42:25 INFO - PROCESS | 6920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.78 (2.7%) stddev-sans-first:1.87 05:42:25 INFO - PROCESS | 6920 | Values: 66.0 64.0 65.0 65.0 68.0 64.0 68.0 64.0 67.0 63.0 05:42:25 INFO - PROCESS | 6920 | -------- Summary: end -------- 05:42:25 INFO - PROCESS | 6920 | 05:42:26 INFO - TEST-INFO | 6920: exit 0 05:42:26 INFO - TEST-OK | kraken | took 62595ms 05:42:26 INFO - SUITE-END | took 1175s 05:42:26 INFO - Completed test suite (00:19:35) 05:42:26 INFO - javascript benchmark 05:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.651778304386, 3166.7783255172135, 3190.6011748531428, 3203.6956489133554, 3218.0, 5192.71440070796, 5276.34045744282, 5290.523852853243, 5322.095243808547, 5354.384245811732, 5302.708351040691, 5318.521333080022, 5348.117560602505, 5392.622516423852, 5413.864653383657, 4806.519348065183, 4814.711117332971, 4839.419269687624, 4848.6363522735755, 4977.278294647274, 4879.170541008037, 4928.827491037797, 4943.826966056189, 4948.208286674133, 4954.603631709472, 4716.221823399135, 4779.402574678165, 4810.927836082462, 4850.975745121252, 4899.706017638935, 4795.904081918377, 4807.639427042951, 4819.1325561398935, 4861.416630004387, 4891.486393928657, 4818.951810481885, 4824.324594556765, 4826.0, 4831.589314908237, 4833.468318484964, 5182.378114626231, 5251.212318152269, 5338.412774594792, 5349.679019258818, 5404.162354835007, 5763.711814409263, 5851.502622277069, 5856.795012174553, 5858.794942177046, 5860.501857342131, 5558.110702287655, 5918.082697181943, 5919.230500034968, 5945.910811337833, 5948.494377977877, 5390.272313237702, 5409.134538473864, 5433.728313584305, 5493.450654934474, 5507.834764957018, 5954.970225148846, 5992.730327135289, 6006.12911127884, 6009.579329446984, 6011.428914253139, 5484.972575137179, 5772.884542309131, 5779.248697669276, 5779.450952159538, 5781.219535362757, 5689.317281926195, 5708.372079071299, 5714.485696287354, 5769.913451298234, 5772.682502462405, 5680.062789639664, 5721.542276617861, 5735.483806457439, 5745.023346031185, 5745.195672605839, 5434.809781657623, 5640.605157638925, 5732.541396688255, 5751.654900705971, 5759.452851979139, 4335.653147748172, 4358.3680366347335, 4382.737035777864, 4391.451068616359, 4429.490608580055, 3925.450436938831, 3929.0766669832565, 3930.1746633206776, 3934.213157368538, 3974.0, 5352.2506849041165, 5404.351477822686, 5479.123340265538, 5542.695151766691, 5578.330600327906, 5839.416058394211, 5859.384764599656, 5864.061750120046, 5879.323877754113, 5883.0, 5556.97221513898, 5563.082091454865, 5564.805231816867, 5565.387807341189, 5567.4432556744005, 4761.833335833298, 4984.825531106394, 5017.297578339036, 5041.218611115283, 5076.568491678248, 6073.48375388097, 6073.696315184223, 6092.238470191226, 6095.939040609537, 6138.539609529304, 5890.352061273171, 5895.145203945318, 5900.0264956281735, 5904.61619994699, 5904.61619994699, 5806.738696758572, 5871.559633027455, 5909.70451477433, 5911.113333000085, 6089.451949324582, 5657.4908258256955, 5657.6888271143835, 5665.178549110274, 5670.432956704297, 5676.545876329801, 5720.0585243503565, 5733.140028995684, 5784.566157538286, 5786.0, 5790.594658373873, 5543.362513311021, 5677.602567820213, 5679.0, 5728.341240757366, 5749.022666146849, 5699.601027928005, 5700.8289751305865, 5703.287089113861, 5704.657720536781, 5717.885642287214, 5341.305630268041, 5595.384507704068, 5600.131979543177, 5635.549156067586, 5649.802256921153, 5649.71751412436, 5692.203091567101, 5743.8851222976145, 5813.970930145322, 5816.941830581809, 5628.380878103323, 5634.464725851038, 5635.211070450058, 5636.1545768133465, 5671.773129074956], "value": 5328.479535093483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.6359711367407, 648.795629376746, 649.8960166373381, 656.8883289840727, 669.568128557081, 44514.777426112865, 45637.77181114094, 45645.77177114114, 48310.0, 48329.7583512082, 44161.0, 44869.32696009563, 44892.551074489245, 44938.0, 44954.550454495526, 8533.40266181366, 8682.392232543725, 8711.869321960145, 8717.738467845975, 8722.084181160983, 8935.865962010575, 9066.45601263923, 9067.047959964175, 9069.501177435239, 9071.455712657262, 9049.502277374742, 9062.275017998578, 9119.544022798833, 9126.77183070422, 9133.36066475347, 9003.14470125337, 9060.818783624356, 9069.093090690943, 9076.500792456412, 9077.273818094569, 8822.808920795675, 8935.463872167626, 8954.910450895473, 8954.955225223897, 8961.955190224073, 42797.786011069744, 43227.78386108081, 43278.13443731139, 43321.78339108284, 43484.13031739347, 3472.2187507810795, 3622.094476380905, 3674.0998455378603, 3741.28915506053, 4060.553339132693, 31708.682913170804, 32320.191995200308, 32543.83728081368, 32651.346973060645, 35210.0, 3990.38149086892, 3990.4812374391436, 4017.4375587417785, 4044.090079732037, 4112.992316882353, 306365.0, 306754.0, 307432.0, 307543.0, 307787.0, 60431.0, 60653.696731516946, 60919.344839309786, 61161.38838611646, 61363.6931815338, 59756.402435975084, 63730.6813465939, 65042.0, 65171.348286517474, 71384.0, 16176.514704558882, 16221.0, 16258.837411625733, 16397.83602163987, 16406.83593164077, 11068.28056176346, 12422.254664720145, 12428.192167509083, 12438.875611243953, 12467.812982805266, 18507.814921850608, 18658.0, 19001.23995040183, 19527.804721952598, 19574.70637940432, 6636.2368327642935, 6691.397774200345, 6706.83232919181, 6817.829554261183, 7041.0, 958.6500927161675, 1061.368485750977, 1114.6656003199007, 1148.2536351371675, 1192.0701852554848, 32729.509057364157, 32984.3403131936, 33262.0, 33266.66733332684, 33552.66447335544, 1098.780243951213, 1148.052856393462, 1166.9416529173507, 1223.3944197622234, 1224.6632176151452, 17703.645927081645, 17724.645507089786, 17779.822201778075, 17808.267019233375, 17926.5518362042, 444278.0, 446045.0, 448955.0, 450465.0, 450716.0, 60876.391236087955, 60889.39110608926, 60916.0, 60969.39030609726, 60997.39002610006, 1254.6737848159544, 1356.7083077138464, 1367.6444124527495, 1396.6717821311984, 1403.3404299978993, 32664.673353266164, 34204.65795342114, 34599.13502162466, 34884.30231395409, 34884.82557587196, 52047.47952520426, 52164.7391763054, 52683.73658131685, 52693.47306527039, 52708.47291527036, 363686.0, 365401.0, 367808.0, 369470.0, 372385.0, 37819.62180378161, 46536.301955471376, 47555.52444475649, 47607.0, 47917.5208247913, 49667.75166124291, 50314.74842625763, 50522.0, 51004.48995510146, 51506.0, 42425.36361954511, 42543.0, 43415.13169736651, 43427.0, 44423.333649995926, 42813.0, 43129.3530597035, 43366.0, 43481.78259108811, 43834.342484862114, 41052.0, 41480.58519414888, 43994.0, 44415.333769994126, 44467.0, 36525.26949461049, 38008.429873551366, 38223.617763822, 38353.616463835, 38582.0, 28730.856345718974, 29061.273468163465, 29473.0, 29509.409811804075, 29714.405711886073], "value": 20598.80621228149, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1141265034695, 396.3954968672772, 401.80512451461044, 407.5598353777919, 423.49392475991186, 13154.139482940463, 18068.186931588076, 19572.11925463354, 19663.31178408756, 20015.799842001612, 14847.851521484781, 18450.72323915139, 18917.90541047293, 19714.112864921077, 19982.300619478323, 5670.0, 5793.33376661683, 5827.854303642401, 5838.357780644125, 5851.093080572518, 5694.971525142369, 5756.856078598048, 5780.710964451781, 5781.942180578203, 5782.624129431573, 4092.4679791627045, 4270.338097594862, 5588.636738611997, 6371.0, 6384.07430922516, 6376.585521941059, 6465.547411681184, 6478.902816457757, 6489.967550162266, 6490.188726409199, 5592.916106258409, 5699.601027928046, 5707.71461426927, 5734.4265573442735, 5747.62640428375, 23258.06967721289, 23314.417139571648, 23428.531429371316, 23687.526249474915, 24142.0, 2305.654151877215, 2499.687539057618, 2886.1197334812873, 3126.120384017838, 3231.5475833383343, 9987.950060249725, 14000.22998735069, 14221.786673199911, 14447.78328325076, 15096.320665569965, 1937.7674679038464, 1980.23760852073, 2003.2788196249485, 2033.3290014295394, 2042.7548694156649, 83903.0, 84304.15695843025, 84428.0, 88074.55962720145, 88782.55608721916, 9068.773280668036, 9739.220862330996, 9862.063104005108, 9999.35004224723, 10092.0, 13347.933260333637, 13503.59489215325, 13571.86428135706, 13628.454861805614, 13650.931745341408, 7626.656800443993, 7817.960910195527, 7842.882356764653, 7952.1650226726515, 7989.2809647132035, 7822.1004584472375, 7855.960720196476, 7871.685132594632, 7920.960395198103, 8051.919480805234, 4145.253854306194, 4158.91682166355, 4195.664346852244, 4197.391378250137, 4488.663350248745, 1834.2204563060645, 1946.1826033066145, 1952.5704345044066, 1993.0831817364176, 2014.4963759060236, 456.64609927306606, 460.2245216809686, 975.3611384543135, 1057.5740525898984, 1082.2478377527543, 10677.572897084185, 10971.451427428598, 11111.222214444912, 11170.218084734153, 11225.438728063564, 463.5781438890661, 467.50211025257994, 470.5506241539322, 474.10867568970804, 480.57229066131174, 5936.465718085306, 6032.969835150796, 6036.879262414727, 6040.09398590215, 6151.0, 531518.0, 531585.0, 531974.0, 533140.0, 553957.0, 92875.0, 94673.0, 96013.5199323999, 96040.0, 96324.0, 516.8036146264395, 516.9612279079084, 524.3026774390052, 525.5270256768938, 526.9947300527023, 10776.946115269373, 11273.7745245093, 11315.773684526428, 11375.886241137483, 11390.772184556428, 37242.44136337903, 38053.61946380501, 38797.6120238794, 39137.0, 39534.0, 54032.72983635057, 55088.44911550994, 55244.0, 55481.0, 55499.44500554943, 8707.3034157266, 8763.824723505622, 8921.776955575902, 9030.503322317336, 9052.592633331647, 10183.490825458846, 10671.35971841692, 13546.32268386557, 13690.65773355674, 13776.586702398945, 11560.364179970182, 11814.409279536161, 12008.279503229835, 12024.218425802295, 12390.380480976095, 11640.35978021217, 11648.35934023603, 11756.647300580997, 11843.763124737285, 11986.0, 11847.289162650268, 12064.276143431422, 12112.939435302767, 12228.144029918176, 12271.325077120488, 8917.28661707075, 8971.192592666692, 8996.100389961213, 9035.909640903506, 9189.908100918905, 8923.241524470493, 11155.888441115485, 11494.597689080842, 11748.58879939198, 11894.881051189723], "value": 8492.21974942014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.7723375643022, 1394.623451668049, 1456.6795305032892, 1526.8167819861612, 1749.641323528676, 8220.671173153067, 8425.83148337033, 8435.072142064368, 8666.176713212251, 8682.86975695365, 8417.579121043955, 8573.785655358619, 8603.655853765858, 8623.310135189186, 8637.438566493174, 1966.48871293464, 2258.390234636647, 2276.8520046197027, 2310.514791893704, 2315.7915787579113, 2311.05246848792, 2311.9422014449688, 2312.479692069288, 2313.2366319114735, 2313.6413855852284, 2237.496563273267, 2298.9310320690324, 2300.2869110575775, 2303.1478353009325, 2304.7810458006547, 1944.4652720501833, 2222.299975507718, 2290.931272061841, 2293.2203050962585, 2308.6190778521523, 2275.7724227577273, 2297.310806757966, 2301.9309420717404, 2302.3898666853297, 2306.7693230676964, 8580.099089595566, 8605.053444121142, 8606.956965215133, 8622.482651040958, 8629.784255393603, 5127.512886275797, 5250.212468129773, 5257.106291930381, 5282.656627319212, 5290.497402746733, 3123.3909387669414, 3213.7589680774036, 3221.5650887130173, 3233.401820663185, 3249.723773479257, 986.5954958467066, 999.5801763259449, 1000.5697550053474, 1007.1892126837893, 1017.5624481473037, 11574.71063223426, 11577.710557236052, 11611.245269057485, 11653.0, 11821.231619944761, 4660.464046634613, 4767.165745994437, 4768.856934291976, 4799.280107983761, 4820.156472617278, 9833.901660983442, 9853.0, 9889.554970026365, 9919.603215871428, 10056.74858128538, 4572.634189264851, 5071.467495912876, 5244.475552444801, 5251.212318152231, 5253.3958594761325, 4276.871693849127, 4386.8025938832825, 4392.714473559208, 4750.12122757291, 4886.291487734258, 3926.587708290588, 3970.662493688011, 4032.1532478179324, 4044.51465824103, 4142.902130935305, 1184.224333061846, 1190.7201807575213, 1211.8000529912642, 1259.6598918292193, 1264.2730430002784, 974.2595627323285, 974.7270764186039, 988.0, 988.3431304174583, 992.3599278465493, 5715.085586306171, 5760.251167348218, 5825.155352473867, 5876.44173803488, 5937.82186534396, 444.23147954039695, 450.73406690053025, 450.83769842856543, 451.14958303597297, 461.803733413298, 4005.0588111793704, 4054.0675644601906, 4062.878113656595, 4083.1629515949157, 4085.346344584852, 9856.901430985597, 10486.213533984981, 10494.632687855888, 10549.578016879239, 10557.102646275, 10188.286819922683, 10333.896661033294, 10396.636117735994, 10465.058144767008, 10483.737906552396, 7847.215278472221, 7911.485753426124, 7927.5243485391065, 7967.123616402191, 7991.68033278674, 5606.943930560642, 5680.857978550569, 5744.454276843693, 5770.192173095854, 5916.7041647918295, 9456.385334953206, 9481.146696797321, 9513.191378732885, 9660.903390966001, 9778.119969202806, 9630.181434577858, 9771.267154963263, 9847.261455390731, 9884.456354900549, 9936.602535898483, 6542.149520562297, 7150.141982962078, 7300.087489063867, 7545.170031296443, 7552.848943020999, 8330.0, 8473.152684731724, 8507.82984340322, 8536.871946920677, 8544.74365769028, 7561.09266887977, 7770.766876993699, 7784.455088143775, 7795.610219489116, 7813.531188128731, 7492.0, 7500.549967001779, 7587.165411804586, 7640.388768898586, 7729.845403092019, 7100.715971361295, 7104.11198600175, 7115.822104447223, 7122.967169760252, 7141.535800172972, 4724.314974328634, 4862.951370486391, 4894.657373983787, 4969.304297398295, 4983.601311895112, 4988.825391111293, 5005.424376196784, 5073.695578265316, 5156.948430515647, 5302.28419163408], "value": 4428.114753953293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.54748899030346, 332.20602759405017, 336.27700444045297, 342.16682378408564, 343.93465241604093, 5201.817936372227, 5252.89494210116, 5261.210818377245, 5273.472652734725, 5324.813631522898, 5257.605679574028, 5281.705982034407, 5283.339582552181, 5287.259783630295, 5305.336832895888, 3882.4664257618224, 3908.374660054392, 4050.9189816203657, 4056.8782936511952, 4126.195391898581, 4076.347784354504, 4079.551759125512, 4098.9590104099025, 4114.300568903293, 4117.9176416471655, 3880.3120642520453, 4032.1935612877396, 4055.290324193269, 4058.472398588179, 4076.184763047402, 3939.5469521005166, 4073.7594323122166, 4084.1627466369323, 4095.7133000689964, 4096.73371230869, 3639.1448009717697, 3639.5450568678916, 3640.854365825364, 3643.2713457308646, 3660.3228402745312, 5018.04657115147, 5022.648414610979, 5023.824166154167, 5069.847904562869, 5080.187170052811, 4585.395111710908, 4697.107549565571, 4715.1748444022505, 4715.41057367829, 4718.221493453576, 5296.311479507678, 5354.651947623392, 5397.0, 5397.136458166675, 5402.729863506848, 4003.5195776507007, 4019.0, 4020.618041286073, 4023.2556976959354, 4032.3145065338963, 5420.0, 5634.098544232903, 5644.266245388073, 5672.716364181774, 5699.116636921284, 3959.8614048508166, 3965.40518922164, 3965.4448377227213, 3968.2261958917734, 4005.899852503711, 4022.778747168934, 4061.5735347788645, 4061.918761624751, 4065.4511640928686, 4071.0, 4468.977655111704, 4571.702839315434, 4621.930671039937, 4649.69776964503, 4658.627309815207, 5420.83737487876, 5447.400785913546, 5477.452254774491, 5489.6980666062955, 5503.284573005483, 1381.4336122189854, 1405.641561401836, 1410.1961881727316, 1413.0, 1418.7517184492879, 911.9680811171577, 920.8940971788196, 1001.1240164855751, 1022.6318525330875, 1023.5138309303021, 5177.741112944413, 5194.246834209094, 5215.556677682363, 5244.449332819999, 5295.391030031596, 5501.642393244506, 5522.447755224445, 5533.6403133796175, 5549.250851135045, 5567.498925096761, 4986.326845875833, 5129.666571672829, 5166.302549155891, 5213.635045546851, 5229.660072095302, 2887.321479452327, 2892.7975041746877, 2930.1941965959104, 2944.617199764017, 2952.468555659959, 5459.426760190202, 5616.803411880564, 5654.6889921054735, 5660.15097735343, 5685.687287199161, 5443.646162999393, 5526.640768350045, 5547.41752116022, 5572.746132120241, 5602.467765562265, 5573.888522229533, 5604.159376093537, 5649.802256921071, 5692.63755541454, 5702.460335709418, 5362.892742145214, 5495.005222153855, 5511.751971161227, 5528.612997090165, 5549.694766787866, 5326.41409444953, 5458.263134476795, 5459.781608735606, 5463.644863083887, 5477.4796394342475, 5569.832905012856, 5596.1605759136455, 5634.7464364104535, 5641.702408445998, 5694.373618902, 3947.526296844397, 4089.815958281825, 4096.856610018635, 4097.405876148002, 4097.713160078766, 5438.483344082306, 5461.563074954073, 5495.917561236504, 5498.80754173602, 5510.201020852034, 5342.572594192533, 5362.1420572708175, 5368.382635996911, 5387.353517577916, 5389.464002759351, 5157.613179011514, 5432.6468779529205, 5511.917321240265, 5529.225908372911, 5557.41647127062, 5180.248863914787, 5221.843344699665, 5329.653572517774, 5369.301990741179, 5384.784608615611, 5513.0, 5529.917051244315, 5554.194641776839, 5560.638558493685, 5563.332400112013, 5452.727363631882, 5472.112121318139, 5473.2063850742215, 5498.285222920995, 5508.531774799187], "value": 4160.891955567818, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.6800551732409, 734.6914295995681, 756.7654027251549, 757.5038349880823, 766.0194950463407, 13488.123271987326, 14105.788413173797, 14110.435582576698, 14181.43274269028, 15399.384024639001, 13416.396262168202, 13460.125091869022, 13537.323133843318, 13567.253801040939, 13569.796453053212, 703.8557095795376, 834.0, 834.5118105908051, 859.0679113162226, 866.8483015472299, 854.5769843927264, 854.9444286121383, 856.1524091149779, 856.3063918226226, 856.9485830850138, 900.5767289373983, 903.5391950105461, 903.661127077346, 904.9140331668481, 905.7961958559305, 722.0613202836319, 866.6576702202658, 886.4193952960821, 891.8038031633031, 893.4415990006246, 648.0861984601736, 648.1412128929188, 648.1541588227361, 648.2933602373389, 648.9286178520359, 14250.2162381069, 14262.85737142636, 14294.571162865132, 14302.427902883872, 14302.856971430256, 12889.0, 13167.60497185086, 13242.404091815892, 13265.071444998854, 13463.596092117154, 11319.717007074807, 11360.318380897173, 11373.943130284379, 11456.4844581994, 11651.126165537618, 4225.176090662322, 4310.870673879788, 4333.4799824021, 4449.0, 4473.463184417858, 52861.0, 53025.46974530244, 53026.73486632581, 53133.0, 53195.20207196895, 9119.680811171576, 9250.4912229828, 9331.90668093324, 9392.201662858597, 9745.951270243604, 18862.811371886106, 19107.23571057142, 19108.0, 19108.904455477634, 19585.608287834162, 8108.2297181767635, 8139.918600814034, 8149.429539932148, 8167.509949403055, 8331.16688331162, 4112.527059388209, 4214.957850421518, 4224.345226489899, 4244.108737165168, 4260.680448966278, 3253.3818574470774, 3347.7656564040285, 3349.1794510344635, 3351.2292172799903, 3353.2622822978906, 614.7295190116424, 619.5663035874906, 620.0079872204437, 637.7225906730587, 645.5674697952384, 529.20090663099, 555.2088274209235, 619.5229673151738, 625.3121566277059, 625.7547480513745, 8300.750977470685, 8449.57752112392, 8528.488290702579, 8588.785280367916, 8607.913920860712, 535.9946400536023, 563.7068724263443, 600.8477307091706, 601.5187849720206, 610.5725991805754, 4066.2070896175555, 4082.4488694026522, 4088.202800453883, 4126.525449573277, 4185.6232939035635, 58750.11874821796, 61018.69490652518, 65323.0, 66371.0, 66515.33484665188, 41298.174036519704, 43668.78165609215, 45795.54204457979, 56493.43506564882, 57961.710191449616, 51091.233631495554, 51118.0, 51955.74022129865, 52347.0, 52768.0, 8465.195806398382, 8575.485470871768, 8599.226069653761, 8600.741977740678, 8634.654613815377, 31625.683743163194, 32889.0, 33029.66970330362, 33199.0, 34725.0, 38587.0, 39700.0, 44101.0, 44534.331985019606, 44748.32877506775, 9940.701778946643, 9951.950240248752, 10276.280660353703, 11355.716107097389, 11491.655250342503, 10691.518881650189, 10727.249092563447, 10796.352218866894, 10818.837717434402, 10959.178061645567, 10583.417912014605, 10612.893871061191, 10866.0220580145, 10918.727031824268, 11393.0, 10573.788524229627, 10763.246572739834, 10770.246082774443, 10838.349699018085, 10962.451877406258, 10365.63720269787, 10526.157907367546, 10539.314944528582, 10720.946395267974, 10929.726756831144, 8511.446755960842, 9129.668693386277, 9263.583138758637, 9356.157945784911, 9393.154616084585, 8696.913030869864, 8851.380403371702, 8879.556022198993, 8893.510856902674, 9127.497987610745], "value": 6366.332698563094, "unit": "score"}], "name": "dromaeo_css", "value": 6915.147739945687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 112.0, 108.0, 109.0, 110.0, 109.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 158.0, 221.0, 126.0, 164.0, 155.0, 133.0, 183.0, 123.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 156.0, 76.0, 75.0, 78.0, 75.0, 129.0, 74.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 150.0, 92.0, 92.0, 92.0, 117.0, 91.0, 91.0, 137.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 59.0, 58.0, 65.0, 58.0, 117.0, 56.0, 57.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 59.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 79.0, 79.0, 79.0, 80.0, 81.0, 80.0, 79.0, 82.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 123.0, 123.0, 120.0, 129.0, 120.0, 123.0, 185.0, 124.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 166.0, 164.0, 164.0, 164.0, 167.0, 164.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 68.0, 64.0, 68.0, 64.0, 67.0, 63.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1538.5, "alertThreshold": 2.0}]} 05:42:26 INFO - Return code: 0 05:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:26 ERROR - # TBPL SUCCESS # 05:42:26 INFO - Running post-action listener: _resource_record_post_action 05:42:26 INFO - ##### 05:42:26 INFO - ##### Finished run-tests step (success) 05:42:26 INFO - ##### 05:42:26 INFO - Running post-run listener: _resource_record_post_run 05:42:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 196608; Write bytes: 295915520; Read time: 48; Write time: 292576 05:42:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11673600; Read time: 0; Write time: 2640 05:42:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 196608; Write bytes: 284241920; Read time: 48; Write time: 289936 05:42:27 INFO - Running post-run listener: _upload_blobber_files 05:42:27 INFO - Blob upload gear active. 05:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:27 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 05:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:28 INFO - (blobuploader) - INFO - Done attempting. 05:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:29 INFO - (blobuploader) - INFO - Done attempting. 05:42:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:29 INFO - Return code: 0 05:42:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd267e1e1b3642a99976da0b79a5775727b3877d605054ccc7b997f6958bdf337129bc54057d5744cff8846a96b69f6ecd23977aa08731bdff0f39aad3dd2769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d4a3e457245a0384efd54cc76d94bb6405fa700c01d5bfef4e28396af322c35941397525c798c9abd19691775ba3273e8de620abe0006f6dfc78280b3228edd"} 05:42:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:29 INFO - Contents: 05:42:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd267e1e1b3642a99976da0b79a5775727b3877d605054ccc7b997f6958bdf337129bc54057d5744cff8846a96b69f6ecd23977aa08731bdff0f39aad3dd2769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d4a3e457245a0384efd54cc76d94bb6405fa700c01d5bfef4e28396af322c35941397525c798c9abd19691775ba3273e8de620abe0006f6dfc78280b3228edd"} 05:42:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:29 INFO - Copying logs to upload dir... 05:42:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.680959 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-12 05:42:29.571497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 05:42:29.578192) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd267e1e1b3642a99976da0b79a5775727b3877d605054ccc7b997f6958bdf337129bc54057d5744cff8846a96b69f6ecd23977aa08731bdff0f39aad3dd2769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d4a3e457245a0384efd54cc76d94bb6405fa700c01d5bfef4e28396af322c35941397525c798c9abd19691775ba3273e8de620abe0006f6dfc78280b3228edd"} build_url:https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/L4mV7LDAR2CnVRmLYvfCmw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd267e1e1b3642a99976da0b79a5775727b3877d605054ccc7b997f6958bdf337129bc54057d5744cff8846a96b69f6ecd23977aa08731bdff0f39aad3dd2769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d4a3e457245a0384efd54cc76d94bb6405fa700c01d5bfef4e28396af322c35941397525c798c9abd19691775ba3273e8de620abe0006f6dfc78280b3228edd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 05:42:29.606013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:42:29.606471) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463055657.500990-1091019486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 05:42:29.685525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 05:42:29.685867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 05:42:29.686176) ========= ========= Total master_lag: 0.17 =========