builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1462795857.13 results: success (0) buildid: 20160509042143 builduid: 1b31992cf06444a89046370bf69c67af revision: 27bbfef7a520f127d7dc0e880de7adf4548dca8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.133273) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.133759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.134032) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.147537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.147806) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 05:10:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-05-09 05:10:57 (21.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.277297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.277649) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014320 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.327895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.328247) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27bbfef7a520f127d7dc0e880de7adf4548dca8b --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 27bbfef7a520f127d7dc0e880de7adf4548dca8b --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=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 05:10:57,491 truncating revision to first 12 chars 2016-05-09 05:10:57,491 Setting DEBUG logging. 2016-05-09 05:10:57,491 attempt 1/10 2016-05-09 05:10:57,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27bbfef7a520?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:10:57,782 unpacking tar archive at: fx-team-27bbfef7a520/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.932820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.933137) ========= script_repo_revision: 27bbfef7a520f127d7dc0e880de7adf4548dca8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.933537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.933802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:10:57.942608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 05:10:57.942874) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:58 INFO - MultiFileLogger online at 20160509 05:10:58 in /builds/slave/test 05:10:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:10:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:58 INFO - {'append_to_log': False, 05:10:58 INFO - 'base_work_dir': '/builds/slave/test', 05:10:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:10:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:58 INFO - 'branch': 'Fx-Team-Non-PGO', 05:10:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:58 INFO - 'config_files': ('talos/linux_config.py',), 05:10:58 INFO - 'default_actions': ('clobber', 05:10:58 INFO - 'read-buildbot-config', 05:10:58 INFO - 'download-and-extract', 05:10:58 INFO - 'populate-webroot', 05:10:58 INFO - 'create-virtualenv', 05:10:58 INFO - 'install', 05:10:58 INFO - 'run-tests'), 05:10:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:58 INFO - 'download_minidump_stackwalk': True, 05:10:58 INFO - 'download_symbols': 'ondemand', 05:10:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:58 INFO - 'installer_path': 'installer.exe', 05:10:58 INFO - 'log_level': 'info', 05:10:58 INFO - 'log_name': 'talos', 05:10:58 INFO - 'log_to_console': True, 05:10:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:58 INFO - 'opt_config_files': (), 05:10:58 INFO - 'pip_index': False, 05:10:58 INFO - 'sps_profile': False, 05:10:58 INFO - 'sps_profile_interval': 0, 05:10:58 INFO - 'suite': 'dromaeojs', 05:10:58 INFO - 'system_bits': '32', 05:10:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:58 INFO - 'title': 'talos-linux64-ix-004', 05:10:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:58 INFO - 'use_talos_json': True, 05:10:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:58 INFO - 'work_dir': 'build'} 05:10:58 INFO - ##### 05:10:58 INFO - ##### Running clobber step. 05:10:58 INFO - ##### 05:10:58 INFO - Running pre-action listener: _resource_record_pre_action 05:10:58 INFO - Running main action method: clobber 05:10:58 INFO - rmtree: /builds/slave/test/build 05:10:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:59 INFO - Running post-action listener: _resource_record_post_action 05:10:59 INFO - ##### 05:10:59 INFO - ##### Finished clobber step (success) 05:10:59 INFO - ##### 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running read-buildbot-config step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: read_buildbot_config 05:10:59 INFO - Using buildbot properties: 05:10:59 INFO - { 05:10:59 INFO - "project": "", 05:10:59 INFO - "product": "firefox", 05:10:59 INFO - "script_repo_revision": "production", 05:10:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:10:59 INFO - "repository": "", 05:10:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:10:59 INFO - "buildid": "20160509042143", 05:10:59 INFO - "pgo_build": "False", 05:10:59 INFO - "basedir": "/builds/slave/test", 05:10:59 INFO - "buildnumber": 1670, 05:10:59 INFO - "slavename": "talos-linux64-ix-004", 05:10:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:59 INFO - "platform": "ubuntu64_hw", 05:10:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:10:59 INFO - "branch": "fx-team", 05:10:59 INFO - "repo_path": "integration/fx-team", 05:10:59 INFO - "revision": "27bbfef7a520f127d7dc0e880de7adf4548dca8b", 05:10:59 INFO - "stage_platform": "linux64", 05:10:59 INFO - "builduid": "1b31992cf06444a89046370bf69c67af", 05:10:59 INFO - "slavebuilddir": "test" 05:10:59 INFO - } 05:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:10:59 INFO - Running post-action listener: _resource_record_post_action 05:10:59 INFO - ##### 05:10:59 INFO - ##### Finished read-buildbot-config step (success) 05:10:59 INFO - ##### 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running download-and-extract step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: download_and_extract 05:10:59 INFO - mkdir: /builds/slave/test/build/tests 05:10:59 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:10:59 INFO - https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:10:59 INFO - Downloaded 1361 bytes. 05:10:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:10:59 INFO - Using the following test package requirements: 05:10:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'jsshell-linux-x86_64.zip'], 05:10:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:59 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:10:59 INFO - https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:00 INFO - Downloaded 22322863 bytes. 05:11:00 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:11:00 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:11:02 INFO - Return code: 0 05:11:02 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:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:02 INFO - https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:03 INFO - Downloaded 22322863 bytes. 05:11:03 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:11:03 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:11:04 INFO - Return code: 0 05:11: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:11:04 INFO - https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:05 INFO - Downloaded 10840152 bytes. 05:11:05 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:11:05 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:11:05 INFO - Return code: 0 05:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:05 INFO - https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ec9URdT1StCIucoQLQHEBA/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:11:07 INFO - Downloaded 54858774 bytes. 05:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:07 INFO - mkdir: /builds/slave/test/properties 05:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:07 INFO - Contents: 05:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - Running post-action listener: set_extra_try_arguments 05:11:07 INFO - ##### 05:11:07 INFO - ##### Finished download-and-extract step (success) 05:11:07 INFO - ##### 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running populate-webroot step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: populate_webroot 05:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:07 INFO - '--tppagecycles', 05:11:07 INFO - '7'], 05:11:07 INFO - 'tests': ['tsvgm']}}, 05:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['damp', 'tps']}, 05:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'tests': ['damp', 'tps']}, 05:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['dromaeo_dom']}, 05:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['a11yr', 05:11:07 INFO - 'ts_paint', 05:11:07 INFO - 'tpaint', 05:11:07 INFO - 'sessionrestore', 05:11:07 INFO - 'sessionrestore_no_auto_restore', 05:11:07 INFO - 'tabpaint']}, 05:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['tsvgx', 05:11:07 INFO - 'tsvgr_opacity', 05:11:07 INFO - 'tart', 05:11:07 INFO - 'tscrollx', 05:11:07 INFO - 'cart']}, 05:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:07 INFO - 'tsvgr_opacity', 05:11:07 INFO - 'tart', 05:11:07 INFO - 'tscrollx', 05:11:07 INFO - 'cart']}, 05:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'talos_options': ['--disable-e10s'], 05:11:07 INFO - 'tests': ['tp5o']}, 05:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'tests': ['tp5o']}, 05:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'talos_options': ['--disable-e10s', 05:11:07 INFO - '--xperf_path', 05:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:07 INFO - 'tests': ['tp5n']}, 05:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:07 INFO - 'talos_options': ['--xperf_path', 05:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:07 INFO - 'tests': ['tp5n']}}, 05:11:07 INFO - 'talos.zip': {'path': '', 05:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - ##### 05:11:07 INFO - ##### Finished populate-webroot step (success) 05:11:07 INFO - ##### 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running create-virtualenv step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: create_virtualenv 05:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11: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:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:08 INFO - Using real prefix '/usr' 05:11:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:10 INFO - Installing pip.................done. 05:11:10 INFO - Return code: 0 05:11:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11: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:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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', 'pip>=1.5'] in /builds/slave/test/build 05:11: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 pip>=1.5 05:11:10 INFO - Using env: {'DISPLAY': ':0', 05:11:10 INFO - 'HOME': '/home/cltbld', 05:11:10 INFO - 'LANG': 'en_US.UTF-8', 05:11:10 INFO - 'LANGUAGE': 'en_US:en', 05:11:10 INFO - 'LOGNAME': 'cltbld', 05:11:10 INFO - 'MAIL': '/var/mail/cltbld', 05:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:10 INFO - 'MOZ_NO_REMOTE': '1', 05:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:10 INFO - 'NO_EM_RESTART': '1', 05:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:10 INFO - 'PWD': '/builds/slave/test', 05:11:10 INFO - 'SHELL': '/bin/bash', 05:11:10 INFO - 'SHLVL': '1', 05:11:10 INFO - 'TERM': 'linux', 05:11:10 INFO - 'TMOUT': '86400', 05:11:10 INFO - 'USER': 'cltbld', 05:11:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:10 INFO - '_': '/tools/buildbot/bin/python'} 05:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11: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:11:10 INFO - Cleaning up... 05:11:10 INFO - Return code: 0 05:11:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:11: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:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:10 INFO - Using env: {'DISPLAY': ':0', 05:11:10 INFO - 'HOME': '/home/cltbld', 05:11:10 INFO - 'LANG': 'en_US.UTF-8', 05:11:10 INFO - 'LANGUAGE': 'en_US:en', 05:11:10 INFO - 'LOGNAME': 'cltbld', 05:11:10 INFO - 'MAIL': '/var/mail/cltbld', 05:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:10 INFO - 'MOZ_NO_REMOTE': '1', 05:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:10 INFO - 'NO_EM_RESTART': '1', 05:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:10 INFO - 'PWD': '/builds/slave/test', 05:11:10 INFO - 'SHELL': '/bin/bash', 05:11:10 INFO - 'SHLVL': '1', 05:11:10 INFO - 'TERM': 'linux', 05:11:10 INFO - 'TMOUT': '86400', 05:11:10 INFO - 'USER': 'cltbld', 05:11:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:10 INFO - '_': '/tools/buildbot/bin/python'} 05:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:10 INFO - Downloading/unpacking psutil>=0.7.1 05:11: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:11: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:11: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:11: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:11: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:11: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:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:12 INFO - Installing collected packages: psutil 05:11:12 INFO - Running setup.py install for psutil 05:11:13 INFO - building 'psutil._psutil_linux' extension 05:11:13 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:11:13 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:11:13 INFO - building 'psutil._psutil_posix' extension 05:11:13 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:11:13 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:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:13 INFO - Successfully installed psutil 05:11:13 INFO - Cleaning up... 05:11:13 INFO - Return code: 0 05:11:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11:13 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:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 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:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:13 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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11:13 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:11:13 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:11:13 INFO - Using env: {'DISPLAY': ':0', 05:11:13 INFO - 'HOME': '/home/cltbld', 05:11:13 INFO - 'LANG': 'en_US.UTF-8', 05:11:13 INFO - 'LANGUAGE': 'en_US:en', 05:11:13 INFO - 'LOGNAME': 'cltbld', 05:11:13 INFO - 'MAIL': '/var/mail/cltbld', 05:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:13 INFO - 'MOZ_NO_REMOTE': '1', 05:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:13 INFO - 'NO_EM_RESTART': '1', 05:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:13 INFO - 'PWD': '/builds/slave/test', 05:11:13 INFO - 'SHELL': '/bin/bash', 05:11:13 INFO - 'SHLVL': '1', 05:11:13 INFO - 'TERM': 'linux', 05:11:13 INFO - 'TMOUT': '86400', 05:11:13 INFO - 'USER': 'cltbld', 05:11:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:13 INFO - '_': '/tools/buildbot/bin/python'} 05:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:13 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:11:13 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:11:13 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:11:13 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:11:13 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:11:13 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:11:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:15 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:11:15 INFO - Installing collected packages: mozsystemmonitor 05:11:15 INFO - Running setup.py install for mozsystemmonitor 05:11:15 INFO - Successfully installed mozsystemmonitor 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11:15 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:11:15 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:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:11: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:11: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:11: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:11: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:11: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:11: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:11:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:18 INFO - Downloading docopt-0.6.1.tar.gz 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:18 INFO - Running setup.py install for blobuploader 05:11:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:18 INFO - Running setup.py install for requests 05:11:19 INFO - Running setup.py install for docopt 05:11:19 INFO - Successfully installed blobuploader requests docopt 05:11:19 INFO - Cleaning up... 05:11:19 INFO - Return code: 0 05:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:19 INFO - Using env: {'DISPLAY': ':0', 05:11:19 INFO - 'HOME': '/home/cltbld', 05:11:19 INFO - 'LANG': 'en_US.UTF-8', 05:11:19 INFO - 'LANGUAGE': 'en_US:en', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MAIL': '/var/mail/cltbld', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SHLVL': '1', 05:11:19 INFO - 'TERM': 'linux', 05:11:19 INFO - 'TMOUT': '86400', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - '_': '/tools/buildbot/bin/python'} 05:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:19 INFO - Running setup.py (path:/tmp/pip-EjipOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:19 INFO - Running setup.py (path:/tmp/pip-4C_sVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:19 INFO - Running setup.py (path:/tmp/pip-qLfuw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:19 INFO - Running setup.py (path:/tmp/pip-LNF1zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:19 INFO - Running setup.py (path:/tmp/pip-cwAdp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:19 INFO - Running setup.py (path:/tmp/pip-PFxy54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:19 INFO - Running setup.py (path:/tmp/pip-8WqZ9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:19 INFO - Running setup.py (path:/tmp/pip-4M1VWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:20 INFO - Running setup.py (path:/tmp/pip-uy_9Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:20 INFO - Running setup.py (path:/tmp/pip-swxNHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:20 INFO - Running setup.py (path:/tmp/pip-nN8JQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:20 INFO - Running setup.py (path:/tmp/pip-Lf3B7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:20 INFO - Running setup.py (path:/tmp/pip-LVUdJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:20 INFO - Running setup.py (path:/tmp/pip-i2UgIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:20 INFO - Running setup.py (path:/tmp/pip-J8J604-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:20 INFO - Running setup.py (path:/tmp/pip-3oPV7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:20 INFO - Running setup.py (path:/tmp/pip-4nc19G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:20 INFO - Running setup.py install for manifestparser 05:11:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:20 INFO - Running setup.py install for mozcrash 05:11:20 INFO - Running setup.py install for mozdebug 05:11:20 INFO - Running setup.py install for mozdevice 05:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozfile 05:11:21 INFO - Running setup.py install for mozhttpd 05:11:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozinfo 05:11:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozInstall 05:11:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozleak 05:11:21 INFO - Running setup.py install for mozlog 05:11:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for moznetwork 05:11:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozprocess 05:11:21 INFO - Running setup.py install for mozprofile 05:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozrunner 05:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozscreenshot 05:11:22 INFO - Running setup.py install for moztest 05:11:22 INFO - Running setup.py install for mozversion 05:11:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:22 INFO - Cleaning up... 05:11:22 INFO - Return code: 0 05:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:22 INFO - Using env: {'DISPLAY': ':0', 05:11:22 INFO - 'HOME': '/home/cltbld', 05:11:22 INFO - 'LANG': 'en_US.UTF-8', 05:11:22 INFO - 'LANGUAGE': 'en_US:en', 05:11:22 INFO - 'LOGNAME': 'cltbld', 05:11:22 INFO - 'MAIL': '/var/mail/cltbld', 05:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:22 INFO - 'MOZ_NO_REMOTE': '1', 05:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:22 INFO - 'NO_EM_RESTART': '1', 05:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:22 INFO - 'PWD': '/builds/slave/test', 05:11:22 INFO - 'SHELL': '/bin/bash', 05:11:22 INFO - 'SHLVL': '1', 05:11:22 INFO - 'TERM': 'linux', 05:11:22 INFO - 'TMOUT': '86400', 05:11:22 INFO - 'USER': 'cltbld', 05:11:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:22 INFO - '_': '/tools/buildbot/bin/python'} 05:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:22 INFO - Running setup.py (path:/tmp/pip-AyYYRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11: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:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:22 INFO - Running setup.py (path:/tmp/pip-1xfG_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11: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:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:22 INFO - Running setup.py (path:/tmp/pip-qXza6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:22 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:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:22 INFO - Running setup.py (path:/tmp/pip-QXCddi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:22 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:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:22 INFO - Running setup.py (path:/tmp/pip-rZS2dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:23 INFO - Running setup.py (path:/tmp/pip-BqHdAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:23 INFO - Running setup.py (path:/tmp/pip-XEsL3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:23 INFO - Running setup.py (path:/tmp/pip-kHUhKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:23 INFO - Running setup.py (path:/tmp/pip-QskDYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:23 INFO - Running setup.py (path:/tmp/pip-a6gimM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:23 INFO - Running setup.py (path:/tmp/pip-fhD4yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:23 INFO - Running setup.py (path:/tmp/pip-PyseFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:23 INFO - Running setup.py (path:/tmp/pip-JhIM2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:23 INFO - Running setup.py (path:/tmp/pip-nE7OA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:23 INFO - Running setup.py (path:/tmp/pip-kFaG1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11: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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:23 INFO - Running setup.py (path:/tmp/pip-K8fbEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:23 INFO - Running setup.py (path:/tmp/pip-bnva5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:23 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:11:23 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:11:23 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:11:23 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:11:23 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:11:23 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:11:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:23 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:11:23 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:11:23 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:11:23 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:11:23 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:11:23 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:11:25 INFO - Downloading blessings-1.6.tar.gz 05:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:25 INFO - Installing collected packages: blessings 05:11:25 INFO - Running setup.py install for blessings 05:11:25 INFO - Successfully installed blessings 05:11:25 INFO - Cleaning up... 05:11:26 INFO - Return code: 0 05:11:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:26 INFO - Reading from file tmpfile_stdout 05:11:26 INFO - Current package versions: 05:11:26 INFO - argparse == 1.2.1 05:11:26 INFO - blessings == 1.6 05:11:26 INFO - blobuploader == 1.2.4 05:11:26 INFO - docopt == 0.6.1 05:11:26 INFO - manifestparser == 1.1 05:11:26 INFO - mozInstall == 1.12 05:11:26 INFO - mozcrash == 0.17 05:11:26 INFO - mozdebug == 0.1 05:11:26 INFO - mozdevice == 0.48 05:11:26 INFO - mozfile == 1.2 05:11:26 INFO - mozhttpd == 0.7 05:11:26 INFO - mozinfo == 0.9 05:11:26 INFO - mozleak == 0.1 05:11:26 INFO - mozlog == 3.1 05:11:26 INFO - moznetwork == 0.27 05:11:26 INFO - mozprocess == 0.22 05:11:26 INFO - mozprofile == 0.28 05:11:26 INFO - mozrunner == 6.11 05:11:26 INFO - mozscreenshot == 0.1 05:11:26 INFO - mozsystemmonitor == 0.0 05:11:26 INFO - moztest == 0.7 05:11:26 INFO - mozversion == 1.4 05:11:26 INFO - psutil == 3.1.1 05:11:26 INFO - requests == 1.2.3 05:11:26 INFO - wsgiref == 0.1.2 05:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:26 INFO - Using env: {'DISPLAY': ':0', 05:11:26 INFO - 'HOME': '/home/cltbld', 05:11:26 INFO - 'LANG': 'en_US.UTF-8', 05:11:26 INFO - 'LANGUAGE': 'en_US:en', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MAIL': '/var/mail/cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SHLVL': '1', 05:11:26 INFO - 'TERM': 'linux', 05:11:26 INFO - 'TMOUT': '86400', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - '_': '/tools/buildbot/bin/python'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11: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:11: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:11: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:11: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:11: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:11: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:11: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:11: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:11: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:11: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:11: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:11:26 INFO - Cleaning up... 05:11:26 INFO - Return code: 0 05:11:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11: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:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:26 INFO - Using env: {'DISPLAY': ':0', 05:11:26 INFO - 'HOME': '/home/cltbld', 05:11:26 INFO - 'LANG': 'en_US.UTF-8', 05:11:26 INFO - 'LANGUAGE': 'en_US:en', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MAIL': '/var/mail/cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SHLVL': '1', 05:11:26 INFO - 'TERM': 'linux', 05:11:26 INFO - 'TMOUT': '86400', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - '_': '/tools/buildbot/bin/python'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:26 INFO - Downloading/unpacking jsonschema 05:11: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:11: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:11: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:11: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:11: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:11: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:11:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:28 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:28 INFO - warning: no files found matching '*.txt' 05:11:28 INFO - no previously-included directories found matching 'build' 05:11:28 INFO - no previously-included directories found matching 'dist' 05:11:28 INFO - no previously-included directories found matching '.git*' 05:11:28 INFO - Installing collected packages: jsonschema, functools32 05:11:28 INFO - Running setup.py install for functools32 05:11:28 INFO - warning: no files found matching '*.txt' 05:11:28 INFO - no previously-included directories found matching 'build' 05:11:28 INFO - no previously-included directories found matching 'dist' 05:11:28 INFO - no previously-included directories found matching '.git*' 05:11:28 INFO - Successfully installed jsonschema functools32 05:11:28 INFO - Cleaning up... 05:11:29 INFO - Return code: 0 05:11:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11: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:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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 0x7f2b0245bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', '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:11: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:11: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:11:29 INFO - Using env: {'DISPLAY': ':0', 05:11:29 INFO - 'HOME': '/home/cltbld', 05:11:29 INFO - 'LANG': 'en_US.UTF-8', 05:11:29 INFO - 'LANGUAGE': 'en_US:en', 05:11:29 INFO - 'LOGNAME': 'cltbld', 05:11:29 INFO - 'MAIL': '/var/mail/cltbld', 05:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:29 INFO - 'MOZ_NO_REMOTE': '1', 05:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:29 INFO - 'NO_EM_RESTART': '1', 05:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:29 INFO - 'PWD': '/builds/slave/test', 05:11:29 INFO - 'SHELL': '/bin/bash', 05:11:29 INFO - 'SHLVL': '1', 05:11:29 INFO - 'TERM': 'linux', 05:11:29 INFO - 'TMOUT': '86400', 05:11:29 INFO - 'USER': 'cltbld', 05:11:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:29 INFO - '_': '/tools/buildbot/bin/python'} 05:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:29 INFO - Downloading/unpacking flake8 05:11: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:11: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:11: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:11: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:11: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:11: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:11:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:31 INFO - no previously-included directories found matching 'docs/_build' 05:11:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:31 INFO - Running setup.py install for pep8 05:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:31 INFO - no previously-included directories found matching 'docs/_build' 05:11:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:32 INFO - Cleaning up... 05:11:32 INFO - Return code: 0 05:11:32 INFO - Running post-action listener: _resource_record_post_action 05:11:32 INFO - Running post-action listener: _start_resource_monitoring 05:11:32 INFO - Starting resource monitoring. 05:11:32 INFO - ##### 05:11:32 INFO - ##### Finished create-virtualenv step (success) 05:11:32 INFO - ##### 05:11:32 INFO - ##### 05:11:32 INFO - ##### Running install step. 05:11:32 INFO - ##### 05:11:32 INFO - Running pre-action listener: _resource_record_pre_action 05:11:32 INFO - Running main action method: install 05:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:32 INFO - Reading from file tmpfile_stdout 05:11:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:32 INFO - Reading from file tmpfile_stdout 05:11:32 INFO - Output received: 05:11:32 INFO - Usage: mozinstall [options] installer 05:11:32 INFO - Options: 05:11:32 INFO - -h, --help show this help message and exit 05:11:32 INFO - -d DEST, --destination=DEST 05:11:32 INFO - Directory to install application into. [default: 05:11:32 INFO - "/builds/slave/test"] 05:11:32 INFO - --app=APP Application being installed. [default: firefox] 05:11:32 INFO - mkdir: /builds/slave/test/build/application 05:11: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:11: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:11:48 INFO - Reading from file tmpfile_stdout 05:11:48 INFO - Output received: 05:11:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:48 INFO - Running post-action listener: _resource_record_post_action 05:11:48 INFO - ##### 05:11:48 INFO - ##### Finished install step (success) 05:11:48 INFO - ##### 05:11:48 INFO - ##### 05:11:48 INFO - ##### Running run-tests step. 05:11:48 INFO - ##### 05:11:48 INFO - Running pre-action listener: _resource_record_pre_action 05:11:48 INFO - Running main action method: run_tests 05:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:48 INFO - Python 2.7.3 05:11:48 INFO - Return code: 0 05:11:48 INFO - grabbing minidump binary from tooltool 05:11: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:11:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e9c0>, '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 0x1e9f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:48 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:11:48 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:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:48 INFO - Return code: 0 05:11:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:49 INFO - Return code: 0 05:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:11:49 INFO - Using env: {'DISPLAY': ':0', 05:11:49 INFO - 'HOME': '/home/cltbld', 05:11:49 INFO - 'LANG': 'en_US.UTF-8', 05:11:49 INFO - 'LANGUAGE': 'en_US:en', 05:11:49 INFO - 'LOGNAME': 'cltbld', 05:11:49 INFO - 'MAIL': '/var/mail/cltbld', 05:11:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:49 INFO - 'MOZ_NO_REMOTE': '1', 05:11:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:49 INFO - 'NO_EM_RESTART': '1', 05:11:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:49 INFO - 'PWD': '/builds/slave/test', 05:11:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:49 INFO - 'SHELL': '/bin/bash', 05:11:49 INFO - 'SHLVL': '1', 05:11:49 INFO - 'TERM': 'linux', 05:11:49 INFO - 'TMOUT': '86400', 05:11:49 INFO - 'USER': 'cltbld', 05:11:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263', 05:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:49 INFO - '_': '/tools/buildbot/bin/python'} 05:11:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:11:49 INFO - mozversion application_buildid: 20160509042143 05:11:49 INFO - mozversion application_changeset: 27bbfef7a520f127d7dc0e880de7adf4548dca8b 05:11:49 INFO - mozversion application_display_name: Nightly 05:11:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:49 INFO - mozversion application_name: Firefox 05:11:49 INFO - mozversion application_remotingname: firefox 05:11:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:49 INFO - mozversion application_vendor: Mozilla 05:11:49 INFO - mozversion application_version: 49.0a1 05:11:49 INFO - mozversion platform_buildid: 20160509042143 05:11:49 INFO - mozversion platform_changeset: 27bbfef7a520f127d7dc0e880de7adf4548dca8b 05:11:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:49 INFO - mozversion platform_version: 49.0a1 05:11:49 INFO - using testdate: 1462795909 05:11:49 INFO - actual date: 1462795909 05:11:49 INFO - starting webserver on 'localhost:36456' 05:11:49 INFO - SUITE-START | Running 2 tests 05:11:49 INFO - TEST-START | dromaeo_css 05:11:49 INFO - operating with platform_type : linux_ 05:11:49 INFO - Initialising browser for dromaeo_css test... 05:11:49 INFO - TEST-INFO | started process 914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDVtBj/profile http://localhost:36456/getInfo.html) 05:11:54 INFO - PROCESS | 914 | __metrics Screen width/height:1600/1200 05:11:54 INFO - PROCESS | 914 | colorDepth:24 05:11:54 INFO - PROCESS | 914 | Browser inner width/height: 1024/697 05:11:54 INFO - PROCESS | 914 | __metrics 05:11:55 ERROR - PROCESS | 914 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:11:56 INFO - TEST-INFO | 914: exit 0 05:11:56 INFO - Browser initialized. 05:11:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:56 INFO - TEST-INFO | started process 997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDVtBj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:08 INFO - PROCESS | 997 | RSS: Main: 154001408 05:12:08 INFO - PROCESS | 997 | 05:12:59 INFO - PROCESS | 997 | 1462795979223 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:15:11 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36456/tests/dromaeo/cssquery-ext.html) 05:15:12 INFO - PROCESS | 997 | RSS: Main: 245805056 05:15:12 INFO - PROCESS | 997 | 05:18:15 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-ext.html (next: http://localhost:36456/tests/dromaeo/cssquery-jquery.html) 05:18:15 INFO - PROCESS | 997 | RSS: Main: 234356736 05:18:15 INFO - PROCESS | 997 | 05:21:18 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36456/tests/dromaeo/cssquery-mootools.html) 05:21:18 INFO - PROCESS | 997 | RSS: Main: 242974720 05:21:18 INFO - PROCESS | 997 | 05:24:20 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36456/tests/dromaeo/cssquery-prototype.html) 05:24:21 INFO - PROCESS | 997 | RSS: Main: 239730688 05:24:21 INFO - PROCESS | 997 | 05:27:24 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36456/tests/dromaeo/cssquery-yui.html) 05:27:25 INFO - PROCESS | 997 | RSS: Main: 224194560 05:27:25 INFO - PROCESS | 997 | 05:30:27 INFO - PROCESS | 997 | Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-yui.html (next: http://localhost:36456/tests/dromaeo/cssquery-dojo.html) 05:30:28 INFO - PROCESS | 997 | RSS: Main: 259223552 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | __start_tp_report 05:30:28 INFO - PROCESS | 997 | _x_x_mozilla_page_load 05:30:28 INFO - PROCESS | 997 | _x_x_mozilla_page_load_details 05:30:28 INFO - PROCESS | 997 | |i|pagename|runs| 05:30:28 INFO - PROCESS | 997 | |0;dojo.html;2651.2311429685387;2658.0962472759256;2684.798640101993;2696.90560830371;2703.783697304216;4536.228841097013;4632.884177895546;4647.744374059425;4738.17082010648;4780.856574302772;4652.232381657022;4679.461861885884;4681.64887633428;4708;4760.66675332726;4302.247106756313;4318.956810431902;4371.672124590653;4428.158649856517;4495.168393847149;4405.339199120125;4453.198424283628;4480.103979204172;4509.594136527712;4512.16524942885;4262.936055959163;4266.360045993126;4303.031817840976;4320.71915325506;4325.113351762881;4333.58830911063;4339.652827773771;4341;4343.06624075822;4346.022145017378;4256.5105012923605;4273.4444522212225;4292.506361768405;4307.5261721210645;4343.04453020335;4531.116432295704;4615.469221039556;4623.768811559408;4657.417822772153;4678.578927896506;5054.898902021939;5097.974510127463;5098.286239926413;5104.770285337132;5105.5149760772665;4897.41231052276;4912.042151780404;4957.851264462072;4979.47715489872;5008.799648014112;4692.389989301437;4730.455997560324;4732.645051621143;4734.384530011145;4742.739149346819;4960;5140.948590514122;5161.019406312788;5164.664296820694;5199.870003249874;4901.264810278487;4927.433345165352;4933.777979990909;4941.72820494869;4959.20652695567;5023.321851550067;5023.974880125649;5026.44709082008;5032.47159048302;5077.238414237894;4746.738929358849;4998.825041123543;5000.549950504472;5006.799728010838;5059.797608095709;5004.674696144739;5031.723255220924;5061.34202553673;5113.1563292057135;5115.64190506661;4356.041670832412;4363.127374525107;4365.541618130051;4367.213901497697;4408.9559104408545;3702.333579955634;3773.1887644156636;3823.120682243044;3849.8075096245075;3874.9612503875164;4272.081502476983;4297.828086876552;4308.870733877989;4309.59058889405;4311.137772445523;5032.194848824244;5059.519345662156;5059.544640982329;5063.367079115111;5067.265246539231;4201.768902710381;4225.809838557272;4311.461067366579;4312.741235525878;4349.891252718708;4510.233260345683;4538.52345503724;4542.136993971135;4560.201964656172;4588.7246765194195;4709.952900470951;4714.481407045291;4721.811127554928;4723.787429565747;4766.308885211555;4889.755512224446;4968.925466117938;5000.949990500048;5002.774875130555;5011.123053465702;4719.504452032487;4745.762711864462;4747.074320507468;4777.856664300077;4794.688345257687;4958.25626156065;4960.47914968923;4960.603151747924;4977.054359671651;5000.149974504416;4896.216605343128;4989.501049895127;5022.899542009212;5063.392392912874;5081.517255860687;4931.3096166536;4948.480409556944;4955;4955.752212389294;4992.975035124801;4943.209086546135;4948.727819969792;4948.8762780930765;4952.801887924443;4981.750912454435;4706.34111224422;4727.57451829337;4773.641976851681;4773.952260477351;4917.409910810726;4964.429090654477;4968.155413579628;4969.4782047884455;4975;5000.974995125147;4859.708417494961;4860.975695121501;4869.391326084239;4881.389826271716;4916.803327866988 05:30:28 INFO - PROCESS | 997 | |1;ext.html;575.7006356694517;592.2537602620698;606.0817860940675;621.0094898636676;624.9000159974405;27423.725762742368;42819.78590107049;43902.34146487797;43961.340579891286;43988.34017489732;43512.347314790306;44178.779106104426;44180.337294940604;44187.337189942176;44236.77881610596;7323;7897.960510197456;8067.394945379091;10051.095401413872;10332.638357657483;10151.340162889426;10256.384616922971;10256.435896025716;10261.58953641857;10265.076143147115;10214.846777298346;10255.33340332876;10256.282060255786;10256.435896025716;10261.743456413613;7498.625068746541;9978.550965206583;10254.92323306057;10266.538005789758;10597.73505662357;10054.497275136287;10109.646162384355;10111.696649100539;10118.139958103497;10127.544260508295;38757.22485550302;39020.21959560793;39170;39307.803460982796;39353.60646393557;3234.87060517579;3246.6915643013876;3263.086335825949;3284.1953721338423;3327.317899830553;30025.849870750724;30274.54588181179;30742;30882;32076.83961580177;3172.476541370671;3174.3809957058384;3186.9043928682177;3238.805671659708;3242.1732458223237;233397;234723;235013;235458.99999999828;236211;50959.235611465854;51143;51340.22989655158;51398.8601139883;51399.22901156486;33786.83106584451;37072.814635927185;37095.4435683465;38314.80842595825;38547.229055419295;12862.807057894139;14855.628609284855;15012.249387530579;15016.24918754058;15116.09303441797;9587.568559414703;9803.656872009446;9806.215502759762;10994.560217591366;11280.041196498225;19239.422817315502;19260.711089333392;19307.90346048261;19353.225870965285;19506.512337191685;7063.2583578724525;7063.540869843444;7191.89212161818;7268.781936541912;7321.231270716498;859.3082568532267;920.2270093121809;946.9195118414874;998.6554638649654;1013.8681971343678;28880.277993050342;29664.851675741484;29705.702942970725;30273.24316892051;30406;1010.540204207084;1021.8160731068331;1025.9127974122134;1045.6340280901775;1103.7406209540752;15452.613684657748;15752.369905203663;15759.921200394154;15832.129232892072;15843.524694259191;368443;370816;372860;373530;375743;52231.73884130555;53461.73269133629;53468;53485.73257133689;53587.73206133944;1135.8012347839094;1247.5571172233908;1251.8810712982252;1262.6338361875137;1280.9615711528857;29061.85469072641;30607.54088688627;30624.693753063075;30810.537841932837;30966.435993059382;43881.12237755291;44150.33774493449;44650;44688;44764;289443;290707;291239;292614;293081;22781.886090569442;24980.625290620294;26979.460410791282;27058.458830823667;28596.285092872844;43757.34363984479;44577.777111114236;44653.330200047676;45163.0967380644;45631.31553026773;37246;38009.23981520409;38044.80977595094;38099.42850857295;38524.6147538521;37409.25181496409;37535.249295014495;37921;38084.619153808104;38291.234175316895;37004.074898127765;37355;37722;38491.6150838488;39874.800625996686;32999.67000330062;33987;34568;35097.29805403826;35289;26347.604785927844;26475.735242647326;26494.735052649226;26701.732982669924;26898.327541810828 05:30:28 INFO - PROCESS | 997 | |2;jquery.html;377.92441511697666;381.11581131774284;386.25452875949406;394.74933417280016;397.83092185821016;14277;14868.405263789435;16085.590303755802;17948.91025544872;18362.540936476595;16528.586785330343;16984.32062717493;17438.215280312386;17535;17962.19170137344;4646.279826626878;5002.724305302143;5073.695578265307;5315.123004704238;5320.600954928396;5252.894942101156;5261.815836445725;5281.498257665535;5290.761915713783;5305.4164041955355;5180.300659410969;5209.947900520984;5216.76524556394;5256.26412302278;5259.132243179871;5068.645194836345;5211.374635043781;5217.791288348461;5221.973890130563;5222.955408918231;4485.842995495142;4654.697444666086;4670.112678591091;4675.088357770236;4678.0410015946645;20618.690719639217;21333.786662133334;21418.143274269012;21576.244831430824;21760.673589896163;2024.98987505063;2046.815786579215;2153.6123497770395;2337.672725818387;2396.844205126661;9132.543372831398;9334.15992560666;9809.950950245204;9856.556454959473;13500.122492037986;1804.5127815489875;1823.4165067178508;1834.97247541287;1851.1577232359243;1859.7675290588677;69963.65018174927;70231.29768702299;71489.2851071493;71938;73385.63307183483;10219.540120694586;10358.119559837498;10403.68788936318;10540.9986051325;10567.788644227072;12595.118341715992;13323.267220302976;14572.417103315749;14591.489297874523;14595.051321664057;6627.204735431779;6753.15585551806;6992.440604751608;7075.398591119812;7238.891416628755;6461.676916154173;6466.838329041718;6529.934700653028;6785.9321406786285;6790.111119993597;4467.106578684211;4484.932726009112;4558.316252562142;4584.106099310669;4643.605293550018;1839.9172037258088;1890.4706682129026;1903.4670292318174;1943.378119001934;1956.364181640944;780.7969927818808;864.2006144316482;905.3391024552113;918.0589895357313;1028.8816786069697;16287.429939952044;16556.42052528156;17051.232694528775;17646.117694115244;17922.641547168983;909.068205089775;923.4090182283344;947.2523194705894;953.8140062687849;982.5382070426888;9446.244300455946;9702.805943881083;10501.107405870587;10513.684589462327;10890.074343680875;403409;405185;417659;423477;423969;82158.58920705477;85731;85820.98879617675;86145.56927215324;86151;965.0928127560211;977.6822532676766;993.3791380387258;996.5714742660725;1008.6318493749875;16022.599435014217;16210.756838647194;16363.34546618122;16465.094419807025;16557.58606034859;35853.462198066525;36072.098197545274;36593.45109823302;37288.75881362063;37378;50912.745436272584;52028.47971520236;52164.21753673622;52662;53675;7842.215778422112;8054.31538319226;8144.267015968591;8153.143919888326;8160.632771525177;11323.377214253294;11785.764284714087;11808.645740627795;11913.583024594098;12047.81928271059;10035.19718422539;10233.437160956219;10241.897581024094;10483.213758967955;10702.89297107019;10048.949755251177;10270.948645256725;10329.380237185793;10411.739706507398;10517.526711298164;10333.689989300334;10493.580256789643;10502.894971050191;10513.474326283807;10527.263091583516;7757.844843103219;7853.233022570104;7966.84066318682;7983.1617680142745;8012.83974320522;10694.518746656264;10710.785784284115;10730;10748;10861.782764344827 05:30:28 INFO - PROCESS | 997 | |3;mootools.html;1249.044480972056;1463.72189284036;1503.3535579700729;1612.9919350403247;1763.0655752451198;6427;6987.441004719623;7168.354848063674;7176.282371762821;7307.378872795805;7073.681684324205;7217.350438460538;7218.278172182779;7236.529625574334;7239.601821899793;1825.2151574822822;2033.8677985930867;2110.1137522240697;2130.1053557505847;2172.2940044485526;2235.94410139747;2255.6278214094655;2256.8645881247176;2259.1754009786473;2261.9321420357414;2167.6206663833846;2226.7216597925258;2228.665700144983;2230.185982116532;2231.230225572175;1834.596388794463;2081.792560315021;2146.5599552091785;2146.8282537397126;2155.277981876073;2066.917323307066;2087.2485905074163;2088.3212955789277;2098.3600001999384;2110.926117585877;7164.7134114635355;7170.498065135443;7220.133583969957;7223.674934627954;7223.89164162538;4250.829966801324;4356.520782713899;4363.607275345203;4373.169097871394;4376.256036473807;2895.3051267695814;2905.7094290570985;2958.3935293265044;2967.3323502212047;2988.8804447822276;940.6096469964956;940.8400571902793;948.2698322291866;949.5110018340561;964.599691128181;9922.255830812717;9937.10566049059;9988.250881183867;9992.050755178247;9999.200063994864;4109.219248342805;4174.248635245685;4257.340112282601;4266.637335826427;4278.336857787048;8360.540170290571;8369.163083691583;8383.664653413794;8409;8421.705240316682;3893.649571538575;4407.030453300269;4461.683803278041;4467.106578684276;4474.709143905636;3886.1839013806853;4027.577104404054;4042.413849991735;4050.797460126982;4066.430699702044;3566.518519999767;3611.8735844245325;3680.245549662313;3691.187938653492;3711.851525938986;1192.43359404284;1203.374245392391;1204.374094971781;1218.2933898338943;1219.1405059433077;794.1661255681511;878.3149143667949;887.5340446265633;898.0480690467995;906.9002409734924;5202.375714914158;5214.661047031931;5250.081235783722;5430.817217716781;5501.807436739695;830.4767996162379;867.4144952157269;884.0408157149436;910.235402262103;911.6672414568635;3540.150363912642;3611.6207798180812;3637.636236376394;3677.2645470905927;3684.631536846294;8798.912010879809;9202.355835091614;9300.209482193954;9333.346665733334;9333.533323333806;9166.633334666672;9246.306527010367;9249.075092490697;9251.49116798569;9261.768455788524;6805.183377994672;6942.132233470817;7045.7533986311255;7099.148102227766;7113.359797618239;5111.642185047011;5119.820806271762;5151.330327057459;5158.742062896765;5158.813472901179;8255.669773209005;8479.321654267767;8486.19381158789;8541.743747687578;8582.927134108237;8414.705485307984;8524.659013639384;8569.742907712778;8574.871376929226;8605.440646357967;5915.733791979285;6111.327753946974;6111.908321375094;6595.868082638416;6735.6968936397;6094.9085763714465;7115.750948716977;7130.607816570138;7338.77983660491;7340.816479588053;6544.28012918569;6671.232808227116;6681.33186681328;6780.050792888901;6784.966075169593;6544.345565443417;6585.539012269287;6617.933820661732;6705.463562914858;6710;6261.812145635638;6266.686665666607;6320.4311611955145;6327.810165695037;6332.335104814112;4423.314386270134;4423.933640995323;4453.933191002202;4506.504284528633;4565.634749220121;4390.463337831733;4411.558844115562;4417.602415782595;4437.378766972691;4439.511653718024 05:30:28 INFO - PROCESS | 997 | |4;prototype.html;302.2745411013569;309.6732946741188;315.8847020837395;318.9122991177426;322.9386416580849;4934.703917764937;4937.777799998999;4960.925586116211;4963.875903102428;4977.203647416414;4603.838865639704;4612.723236605798;4663.883402914928;4822.469528351879;4892.4618291987945;3848.076461649212;3854.5952674969003;3859.614038596132;3859.787711675857;3866.8979340887854;3844.596317386676;3850.4224366344993;3852.4221366795064;3859.749116307445;3878.7866667333287;3650.543682039745;3667.4865518827387;3803.790791506466;3814.5613254475675;3841.9039524011982;3776.9433458498142;3799.772013679188;3807.8667246646373;3821.636944490269;3824.694024478035;3367.579052618423;3379.8986030418882;3395.7962522248745;3408.84660190292;3410.471376936554;4363.978180109111;4622.098690755304;4651.953480465219;4668.11305851887;4669.906601867943;4255.5744425557505;4268.637165840907;4270.338097594878;4275.807588658487;4303.634191093761;5052.8484145475695;5059.569936555397;5086.694798312076;5092.8217512387255;5128.512791284859;3617.137174355209;3620.529331186955;3628.96574476273;3632.128289210597;3637.4907512948207;5172.741362931838;5256.132738098209;5318.494742999409;5353.08997470427;5360.9463905360835;3677.5770786359913;3681.116532032293;3702.148505843671;3707.016746040855;3717.219383929351;3741.120836603396;3751.911945535764;3758.981205094012;3778.112143646241;3778.376567866271;4191.350340697197;4299.677524185636;4330.39374487572;4337.869863904088;4354.869353919387;5053.9494605054215;5123.001014802077;5124.027249508966;5140.56305214061;5149.665271757399;1242.5278394210143;1248.2697621891114;1260.4202067049077;1267.4663656975163;1273.9936300318438;806.1454857850697;831.4886344897965;866.6533386645266;866.6749968761715;868.778461492328;4270.359446083113;4290.806913688892;4305.117450922553;4306.82772689089;4315.8273669053515;5047.87380315495;5056.418511871108;5085.7202853842655;5107.642465027412;5135.457948315608;4202.70581059329;4317.892052698708;4326.983158957642;4333.696641235147;4485.529019452911;2699.217227004186;2720.265528307346;2740.328619488238;2752.3394385347774;2757.896841263511;4861.666400127959;4864.854054378375;4866.245731911559;4868;4880.853574392774;4958.206686930074;5276.3932147802725;5281.603879709037;5298.3906850712665;5330.466953304716;4815.085133824562;4830.541098595628;4852.490488498657;4870.7808148632685;4902.3872015998;5056;5124.487551244845;5130.640855140105;5153.247895715474;5159.355080614923;4973.6269779765935;4980.980621199938;4997.625178111583;5099.821506247264;5111.821086261963;4843.4430040545785;4850.345203397496;4856.271559266138;4858.805647774049;4889.217725163957;3584.820758961989;3597.0647631615443;3603.0992251937014;3628.4920111184983;3660.5424321959754;5033.030511997938;5133;5137.948620513747;5226.510444523445;5230.581553475637;4897.212517431183;4965.684093715096;4984.8753781155765;4990.950090499048;4992.101421743976;4888.5111488850835;4930.211166213388;4938.2839488273285;4956.231784073474;4979.676321039121;4684.789184486638;4798.2082956311815;4867.95132048675;4871.269309603588;4874.366332376769;4995.8001679932395;5025.949740502694;5027.109412087991;5027.597792176544;5031.195008798574;4898.436679781871;4979.253112033224;4998.1503144464805;5012.245714000071;5044.293798868235 05:30:28 INFO - PROCESS | 997 | |5;yui.html;715.4169351978135;718.540134314039;725.960072196029;751.5866273549547;801.5671537369818;12138.453769580368;12609.621711348675;12647.683807904807;12651.683707907307;12660.43028063737;13051.869481305184;13094.148880322773;13108;13139.27733974631;13144.474221031147;668.6222284409293;850.6682393866397;864.5893200729666;872.5768002518773;873.3624454148444;851.4252879306474;853.7524118005771;854.1927878155146;856.9357298202659;857.9227869491745;898.2589363774879;905.2893478619285;905.3210092430677;905.6830109461702;905.8777065096226;691.4606606846668;878.9033206347297;894.0701670262919;894.4990805149105;905.7328088213993;672.2437258084655;672.4687496877461;672.7241830849329;673.0241150331989;673.0946876451214;11755.529778808837;11781.882181178164;11806.23259488139;11835.644930652008;11866.821997670042;10493.475326233658;10786.892131078746;10879.292845964987;10981.725456863642;11117.666470005914;10209.591616335338;10357.48212589375;10381.07950029247;10448;10520.421376824272;3979.5423526294558;3999.4000899864964;4004.3192657248337;4029.959700402988;4085.0400155963325;42943.141137177394;43185.13629727388;43219;43341.133177336276;43593.782031089955;8783.25342345895;8815.779605509786;9011.819763604692;9064.229540489132;9080.273578113734;15506.844931550766;15567.688646227238;15592.844071559366;15596.454124105601;15787.210639467981;6427.325130861286;6462.903056454157;6480.092787009822;6495.058216558573;6693.531452798355;3522.894313170609;3551.698105660996;3560.038789526865;3561.245791412761;3618.5295911531857;2767.9861600691866;2780.694123646397;2851.144656603052;2864.856757162175;2866.2977570495364;558.4387690371151;558.4889825809339;558.9245451863947;565.2651552981108;570.54356514788;453.95687409696023;575.1774961804659;591.6272748168626;595.7756809755906;599.8080614203413;7998.5600791957;8012.879806802903;8083.595820208966;8150.83698326042;8208.58957052145;464.20211557644774;474.962003039756;518.9195674670357;552.0670067585767;597.9730912108965;3502.5446691929887;3676.7058635309113;3680.9263814723554;3708.2212735325343;3738.8691395801015;48624.27063593978;50629.746851266245;50703.74648126736;50806.49193508018;51016.74491627518;43071.35392969046;45168.09663806706;45241.54758452439;45738;46948.5305146951;41845.79077104595;42171.36742948858;42317.78841105836;42378.15243695109;43110.56889431066;7333.559986400833;7358.889616655862;7503.287187717158;7539.359154471931;7631.347226298779;28231;28289.57565636558;28651;29348.11955641334;29359.266018349714;35665.28669426649;36354;36490;36930.26139477142;37117.81441092777;9387.483688397204;9395.953020235129;9425.293103017164;9428.95285523568;9527.857082143912;9299.349045566745;9333.85999210026;9455.723670520993;10033.397996120257;10059.094681478702;9117.635294588143;10444.425556594157;10473.581056757948;10559.577616895238;11062.446877656246;10371.27401081917;10456.26806123564;10698.89301106979;10900.727481813017;11787.528498859949;10109.292349535463;10313.9484302578;10459.633912813015;10863.728406789893;10880.782384352427;8182.427230093836;8394.958025209835;8401.369897257853;8455.830883382421;9002.324825638234;8039.15588863161;8060.556669383006;8101.473404228706;8119.4722343047515;8332.250097491255 05:30:28 INFO - PROCESS | 997 | __end_tp_report 05:30:28 INFO - PROCESS | 997 | __start_cc_report 05:30:28 INFO - PROCESS | 997 | _x_x_mozilla_cycle_collect,900 05:30:28 INFO - PROCESS | 997 | __end_cc_report 05:30:28 INFO - PROCESS | 997 | __startTimestamp1462797028179__endTimestamp 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | ------- Summary: start ------- 05:30:28 INFO - PROCESS | 997 | Number of tests: 6 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#0] dojo.html Cycles:165 Average:4657.26 Median:4747.07 stddev:473.90 (10.0%) stddev-sans-first:448.46 05:30:28 INFO - PROCESS | 997 | Values: 2651.2 2658.1 2684.8 2696.9 2703.8 4536.2 4632.9 4647.7 4738.2 4780.9 4652.2 4679.5 4681.6 4708.0 4760.7 4302.2 4319.0 4371.7 4428.2 4495.2 4405.3 4453.2 4480.1 4509.6 4512.2 4262.9 4266.4 4303.0 4320.7 4325.1 4333.6 4339.7 4341.0 4343.1 4346.0 4256.5 4273.4 4292.5 4307.5 4343.0 4531.1 4615.5 4623.8 4657.4 4678.6 5054.9 5098.0 5098.3 5104.8 5105.5 4897.4 4912.0 4957.9 4979.5 5008.8 4692.4 4730.5 4732.6 4734.4 4742.7 4960.0 5140.9 5161.0 5164.7 5199.9 4901.3 4927.4 4933.8 4941.7 4959.2 5023.3 5024.0 5026.4 5032.5 5077.2 4746.7 4998.8 5000.5 5006.8 5059.8 5004.7 5031.7 5061.3 5113.2 5115.6 4356.0 4363.1 4365.5 4367.2 4409.0 3702.3 3773.2 3823.1 3849.8 3875.0 4272.1 4297.8 4308.9 4309.6 4311.1 5032.2 5059.5 5059.5 5063.4 5067.3 4201.8 4225.8 4311.5 4312.7 4349.9 4510.2 4538.5 4542.1 4560.2 4588.7 4710.0 4714.5 4721.8 4723.8 4766.3 4889.8 4968.9 5000.9 5002.8 5011.1 4719.5 4745.8 4747.1 4777.9 4794.7 4958.3 4960.5 4960.6 4977.1 5000.1 4896.2 4989.5 5022.9 5063.4 5081.5 4931.3 4948.5 4955.0 4955.8 4993.0 4943.2 4948.7 4948.9 4952.8 4981.8 4706.3 4727.6 4773.6 4774.0 4917.4 4964.4 4968.2 4969.5 4975.0 5001.0 4859.7 4861.0 4869.4 4881.4 4916.8 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#1] ext.html Cycles:180 Average:46425.85 Median:3254.89 stddev:79849.74 (2453.2%) stddev-sans-first:79999.53 05:30:28 INFO - PROCESS | 997 | Values: 575.7 592.3 606.1 621.0 624.9 27423.7 42819.8 43902.3 43961.3 43988.3 43512.3 44178.8 44180.3 44187.3 44236.8 7323.0 7898.0 8067.4 10051.1 10332.6 10151.3 10256.4 10256.4 10261.6 10265.1 10214.8 10255.3 10256.3 10256.4 10261.7 7498.6 9978.6 10254.9 10266.5 10597.7 10054.5 10109.6 10111.7 10118.1 10127.5 38757.2 39020.2 39170.0 39307.8 39353.6 3234.9 3246.7 3263.1 3284.2 3327.3 30025.8 30274.5 30742.0 30882.0 32076.8 3172.5 3174.4 3186.9 3238.8 3242.2 233397.0 234723.0 235013.0 235459.0 236211.0 50959.2 51143.0 51340.2 51398.9 51399.2 33786.8 37072.8 37095.4 38314.8 38547.2 12862.8 14855.6 15012.2 15016.2 15116.1 9587.6 9803.7 9806.2 10994.6 11280.0 19239.4 19260.7 19307.9 19353.2 19506.5 7063.3 7063.5 7191.9 7268.8 7321.2 859.3 920.2 946.9 998.7 1013.9 28880.3 29664.9 29705.7 30273.2 30406.0 1010.5 1021.8 1025.9 1045.6 1103.7 15452.6 15752.4 15759.9 15832.1 15843.5 368443.0 370816.0 372860.0 373530.0 375743.0 52231.7 53461.7 53468.0 53485.7 53587.7 1135.8 1247.6 1251.9 1262.6 1281.0 29061.9 30607.5 30624.7 30810.5 30966.4 43881.1 44150.3 44650.0 44688.0 44764.0 289443.0 290707.0 291239.0 292614.0 293081.0 22781.9 24980.6 26979.5 27058.5 28596.3 43757.3 44577.8 44653.3 45163.1 45631.3 37246.0 38009.2 38044.8 38099.4 38524.6 37409.3 37535.2 37921.0 38084.6 38291.2 37004.1 37355.0 37722.0 38491.6 39874.8 32999.7 33987.0 34568.0 35097.3 35289.0 26347.6 26475.7 26494.7 26701.7 26898.3 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#2] jquery.html Cycles:180 Average:25438.76 Median:201903.42 stddev:68562.79 (34.0%) stddev-sans-first:68729.30 05:30:28 INFO - PROCESS | 997 | Values: 377.9 381.1 386.3 394.7 397.8 14277.0 14868.4 16085.6 17948.9 18362.5 16528.6 16984.3 17438.2 17535.0 17962.2 4646.3 5002.7 5073.7 5315.1 5320.6 5252.9 5261.8 5281.5 5290.8 5305.4 5180.3 5209.9 5216.8 5256.3 5259.1 5068.6 5211.4 5217.8 5222.0 5223.0 4485.8 4654.7 4670.1 4675.1 4678.0 20618.7 21333.8 21418.1 21576.2 21760.7 2025.0 2046.8 2153.6 2337.7 2396.8 9132.5 9334.2 9810.0 9856.6 13500.1 1804.5 1823.4 1835.0 1851.2 1859.8 69963.7 70231.3 71489.3 71938.0 73385.6 10219.5 10358.1 10403.7 10541.0 10567.8 12595.1 13323.3 14572.4 14591.5 14595.1 6627.2 6753.2 6992.4 7075.4 7238.9 6461.7 6466.8 6529.9 6785.9 6790.1 4467.1 4484.9 4558.3 4584.1 4643.6 1839.9 1890.5 1903.5 1943.4 1956.4 780.8 864.2 905.3 918.1 1028.9 16287.4 16556.4 17051.2 17646.1 17922.6 909.1 923.4 947.3 953.8 982.5 9446.2 9702.8 10501.1 10513.7 10890.1 403409.0 405185.0 417659.0 423477.0 423969.0 82158.6 85731.0 85821.0 86145.6 86151.0 965.1 977.7 993.4 996.6 1008.6 16022.6 16210.8 16363.3 16465.1 16557.6 35853.5 36072.1 36593.5 37288.8 37378.0 50912.7 52028.5 52164.2 52662.0 53675.0 7842.2 8054.3 8144.3 8153.1 8160.6 11323.4 11785.8 11808.6 11913.6 12047.8 10035.2 10233.4 10241.9 10483.2 10702.9 10048.9 10270.9 10329.4 10411.7 10517.5 10333.7 10493.6 10502.9 10513.5 10527.3 7757.8 7853.2 7966.8 7983.2 8012.8 10694.5 10710.8 10730.0 10748.0 10861.8 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#3] mootools.html Cycles:180 Average:4937.31 Median:6005.32 stddev:2676.26 (44.6%) stddev-sans-first:2669.41 05:30:28 INFO - PROCESS | 997 | Values: 1249.0 1463.7 1503.4 1613.0 1763.1 6427.0 6987.4 7168.4 7176.3 7307.4 7073.7 7217.4 7218.3 7236.5 7239.6 1825.2 2033.9 2110.1 2130.1 2172.3 2235.9 2255.6 2256.9 2259.2 2261.9 2167.6 2226.7 2228.7 2230.2 2231.2 1834.6 2081.8 2146.6 2146.8 2155.3 2066.9 2087.2 2088.3 2098.4 2110.9 7164.7 7170.5 7220.1 7223.7 7223.9 4250.8 4356.5 4363.6 4373.2 4376.3 2895.3 2905.7 2958.4 2967.3 2988.9 940.6 940.8 948.3 949.5 964.6 9922.3 9937.1 9988.3 9992.1 9999.2 4109.2 4174.2 4257.3 4266.6 4278.3 8360.5 8369.2 8383.7 8409.0 8421.7 3893.6 4407.0 4461.7 4467.1 4474.7 3886.2 4027.6 4042.4 4050.8 4066.4 3566.5 3611.9 3680.2 3691.2 3711.9 1192.4 1203.4 1204.4 1218.3 1219.1 794.2 878.3 887.5 898.0 906.9 5202.4 5214.7 5250.1 5430.8 5501.8 830.5 867.4 884.0 910.2 911.7 3540.2 3611.6 3637.6 3677.3 3684.6 8798.9 9202.4 9300.2 9333.3 9333.5 9166.6 9246.3 9249.1 9251.5 9261.8 6805.2 6942.1 7045.8 7099.1 7113.4 5111.6 5119.8 5151.3 5158.7 5158.8 8255.7 8479.3 8486.2 8541.7 8582.9 8414.7 8524.7 8569.7 8574.9 8605.4 5915.7 6111.3 6111.9 6595.9 6735.7 6094.9 7115.8 7130.6 7338.8 7340.8 6544.3 6671.2 6681.3 6780.1 6785.0 6544.3 6585.5 6617.9 6705.5 6710.0 6261.8 6266.7 6320.4 6327.8 6332.3 4423.3 4423.9 4453.9 4506.5 4565.6 4390.5 4411.6 4417.6 4437.4 4439.5 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#4] prototype.html Cycles:180 Average:4178.80 Median:4818.78 stddev:1203.48 (25.0%) stddev-sans-first:1171.16 05:30:28 INFO - PROCESS | 997 | Values: 302.3 309.7 315.9 318.9 322.9 4934.7 4937.8 4960.9 4963.9 4977.2 4603.8 4612.7 4663.9 4822.5 4892.5 3848.1 3854.6 3859.6 3859.8 3866.9 3844.6 3850.4 3852.4 3859.7 3878.8 3650.5 3667.5 3803.8 3814.6 3841.9 3776.9 3799.8 3807.9 3821.6 3824.7 3367.6 3379.9 3395.8 3408.8 3410.5 4364.0 4622.1 4652.0 4668.1 4669.9 4255.6 4268.6 4270.3 4275.8 4303.6 5052.8 5059.6 5086.7 5092.8 5128.5 3617.1 3620.5 3629.0 3632.1 3637.5 5172.7 5256.1 5318.5 5353.1 5360.9 3677.6 3681.1 3702.1 3707.0 3717.2 3741.1 3751.9 3759.0 3778.1 3778.4 4191.4 4299.7 4330.4 4337.9 4354.9 5053.9 5123.0 5124.0 5140.6 5149.7 1242.5 1248.3 1260.4 1267.5 1274.0 806.1 831.5 866.7 866.7 868.8 4270.4 4290.8 4305.1 4306.8 4315.8 5047.9 5056.4 5085.7 5107.6 5135.5 4202.7 4317.9 4327.0 4333.7 4485.5 2699.2 2720.3 2740.3 2752.3 2757.9 4861.7 4864.9 4866.2 4868.0 4880.9 4958.2 5276.4 5281.6 5298.4 5330.5 4815.1 4830.5 4852.5 4870.8 4902.4 5056.0 5124.5 5130.6 5153.2 5159.4 4973.6 4981.0 4997.6 5099.8 5111.8 4843.4 4850.3 4856.3 4858.8 4889.2 3584.8 3597.1 3603.1 3628.5 3660.5 5033.0 5133.0 5137.9 5226.5 5230.6 4897.2 4965.7 4984.9 4991.0 4992.1 4888.5 4930.2 4938.3 4956.2 4979.7 4684.8 4798.2 4868.0 4871.3 4874.4 4995.8 5025.9 5027.1 5027.6 5031.2 4898.4 4979.3 4998.2 5012.2 5044.3 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - PROCESS | 997 | [#5] yui.html Cycles:180 Average:12216.30 Median:23101.10 stddev:13915.48 (60.2%) stddev-sans-first:13927.71 05:30:28 INFO - PROCESS | 997 | Values: 715.4 718.5 726.0 751.6 801.6 12138.5 12609.6 12647.7 12651.7 12660.4 13051.9 13094.1 13108.0 13139.3 13144.5 668.6 850.7 864.6 872.6 873.4 851.4 853.8 854.2 856.9 857.9 898.3 905.3 905.3 905.7 905.9 691.5 878.9 894.1 894.5 905.7 672.2 672.5 672.7 673.0 673.1 11755.5 11781.9 11806.2 11835.6 11866.8 10493.5 10786.9 10879.3 10981.7 11117.7 10209.6 10357.5 10381.1 10448.0 10520.4 3979.5 3999.4 4004.3 4030.0 4085.0 42943.1 43185.1 43219.0 43341.1 43593.8 8783.3 8815.8 9011.8 9064.2 9080.3 15506.8 15567.7 15592.8 15596.5 15787.2 6427.3 6462.9 6480.1 6495.1 6693.5 3522.9 3551.7 3560.0 3561.2 3618.5 2768.0 2780.7 2851.1 2864.9 2866.3 558.4 558.5 558.9 565.3 570.5 454.0 575.2 591.6 595.8 599.8 7998.6 8012.9 8083.6 8150.8 8208.6 464.2 475.0 518.9 552.1 598.0 3502.5 3676.7 3680.9 3708.2 3738.9 48624.3 50629.7 50703.7 50806.5 51016.7 43071.4 45168.1 45241.5 45738.0 46948.5 41845.8 42171.4 42317.8 42378.2 43110.6 7333.6 7358.9 7503.3 7539.4 7631.3 28231.0 28289.6 28651.0 29348.1 29359.3 35665.3 36354.0 36490.0 36930.3 37117.8 9387.5 9396.0 9425.3 9429.0 9527.9 9299.3 9333.9 9455.7 10033.4 10059.1 9117.6 10444.4 10473.6 10559.6 11062.4 10371.3 10456.3 10698.9 10900.7 11787.5 10109.3 10313.9 10459.6 10863.7 10880.8 8182.4 8395.0 8401.4 8455.8 9002.3 8039.2 8060.6 8101.5 8119.5 8332.3 05:30:28 INFO - PROCESS | 997 | -------- Summary: end -------- 05:30:28 INFO - PROCESS | 997 | 05:30:28 INFO - TEST-INFO | 997: exit 0 05:30:28 INFO - TEST-OK | dromaeo_css | took 1119549ms 05:30:28 INFO - TEST-START | kraken 05:30:28 INFO - operating with platform_type : linux_ 05:30:28 INFO - Initialising browser for kraken test... 05:30:28 INFO - TEST-INFO | started process 1254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXIlwFq/profile http://localhost:36456/getInfo.html) 05:30:33 INFO - PROCESS | 1254 | __metrics Screen width/height:1600/1200 05:30:33 INFO - PROCESS | 1254 | colorDepth:24 05:30:33 INFO - PROCESS | 1254 | Browser inner width/height: 1024/697 05:30:33 INFO - PROCESS | 1254 | __metrics 05:30:34 ERROR - PROCESS | 1254 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:30:35 INFO - TEST-INFO | 1254: exit 0 05:30:35 INFO - Browser initialized. 05:30:35 INFO - Running cycle 1/1 for kraken test... 05:30:35 INFO - TEST-INFO | started process 1334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXIlwFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:47 INFO - PROCESS | 1334 | RSS: Main: 154603520 05:30:47 INFO - PROCESS | 1334 | 05:30:50 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:51 INFO - PROCESS | 1334 | RSS: Main: 209326080 05:30:51 INFO - PROCESS | 1334 | 05:30:53 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-dft) 05:30:54 INFO - PROCESS | 1334 | RSS: Main: 199335936 05:30:54 INFO - PROCESS | 1334 | 05:30:57 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-fft) 05:30:58 INFO - PROCESS | 1334 | RSS: Main: 266764288 05:30:58 INFO - PROCESS | 1334 | 05:31:00 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-oscillator) 05:31:01 INFO - PROCESS | 1334 | RSS: Main: 175427584 05:31:01 INFO - PROCESS | 1334 | 05:31:03 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:04 INFO - PROCESS | 1334 | RSS: Main: 179834880 05:31:04 INFO - PROCESS | 1334 | 05:31:07 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:08 INFO - PROCESS | 1334 | RSS: Main: 215769088 05:31:08 INFO - PROCESS | 1334 | 05:31:11 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:12 INFO - PROCESS | 1334 | RSS: Main: 214753280 05:31:12 INFO - PROCESS | 1334 | 05:31:15 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36456/tests/kraken/driver.html?testName=json-parse-financial) 05:31:16 INFO - PROCESS | 1334 | RSS: Main: 215097344 05:31:16 INFO - PROCESS | 1334 | 05:31:17 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:18 INFO - PROCESS | 1334 | RSS: Main: 208936960 05:31:18 INFO - PROCESS | 1334 | 05:31:20 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:21 INFO - PROCESS | 1334 | RSS: Main: 211357696 05:31:21 INFO - PROCESS | 1334 | 05:31:23 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:24 INFO - PROCESS | 1334 | RSS: Main: 212656128 05:31:24 INFO - PROCESS | 1334 | 05:31:27 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:27 INFO - PROCESS | 1334 | RSS: Main: 218312704 05:31:27 INFO - PROCESS | 1334 | 05:31:30 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:31 INFO - PROCESS | 1334 | RSS: Main: 217587712 05:31:31 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36456/tests/kraken/driver.html?testName=ai-astar) 05:31:33 INFO - PROCESS | 1334 | RSS: Main: 264200192 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | __start_tp_report 05:31:33 INFO - PROCESS | 1334 | _x_x_mozilla_page_load 05:31:33 INFO - PROCESS | 1334 | _x_x_mozilla_page_load_details 05:31:33 INFO - PROCESS | 1334 | |i|pagename|runs| 05:31:33 INFO - PROCESS | 1334 | |0;ai-astar;112;108;114;115;116;114;115;114;113;114 05:31:33 INFO - PROCESS | 1334 | |1;audio-beat-detection;158;137;159;208;134;162;158;133;191;130 05:31:33 INFO - PROCESS | 1334 | |2;audio-dft;161;161;161;161;163;161;162;161;162;162 05:31:33 INFO - PROCESS | 1334 | |3;audio-fft;75;76;77;151;77;75;77;76;123;77 05:31:33 INFO - PROCESS | 1334 | |4;audio-oscillator;94;92;148;94;93;93;133;92;93;128 05:31:33 INFO - PROCESS | 1334 | |5;imaging-gaussian-blur;117;117;117;117;117;123;116;117;117;117 05:31:33 INFO - PROCESS | 1334 | |6;imaging-darkroom;147;147;146;146;145;145;145;147;146;146 05:31:33 INFO - PROCESS | 1334 | |7;imaging-desaturate;95;95;94;95;95;94;94;95;95;94 05:31:33 INFO - PROCESS | 1334 | |8;json-parse-financial;64;64;65;64;64;66;65;65;65;65 05:31:33 INFO - PROCESS | 1334 | |9;json-stringify-tinderbox;65;65;65;65;65;64;64;64;64;65 05:31:33 INFO - PROCESS | 1334 | |10;stanford-crypto-aes;84;87;82;82;82;87;84;82;162;90 05:31:33 INFO - PROCESS | 1334 | |11;stanford-crypto-ccm;132;132;141;142;129;129;130;129;148;132 05:31:33 INFO - PROCESS | 1334 | |12;stanford-crypto-pbkdf2;172;173;171;174;177;169;176;171;170;171 05:31:33 INFO - PROCESS | 1334 | |13;stanford-crypto-sha256-iterative;68;69;67;68;70;66;70;67;66;67 05:31:33 INFO - PROCESS | 1334 | __end_tp_report 05:31:33 INFO - PROCESS | 1334 | __start_cc_report 05:31:33 INFO - PROCESS | 1334 | _x_x_mozilla_cycle_collect,2097 05:31:33 INFO - PROCESS | 1334 | __end_cc_report 05:31:33 INFO - PROCESS | 1334 | __startTimestamp1462797093346__endTimestamp 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | ------- Summary: start ------- 05:31:33 INFO - PROCESS | 1334 | Number of tests: 14 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.22 (2.0%) stddev-sans-first:2.29 05:31:33 INFO - PROCESS | 1334 | Values: 112.0 108.0 114.0 115.0 116.0 114.0 115.0 114.0 113.0 114.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:158.50 stddev:25.87 (16.3%) stddev-sans-first:27.43 05:31:33 INFO - PROCESS | 1334 | Values: 158.0 137.0 159.0 208.0 134.0 162.0 158.0 133.0 191.0 130.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 05:31:33 INFO - PROCESS | 1334 | Values: 161.0 161.0 161.0 161.0 163.0 161.0 162.0 161.0 162.0 162.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#3] audio-fft Cycles:10 Average:88.40 Median:76.50 stddev:26.46 (34.6%) stddev-sans-first:27.62 05:31:33 INFO - PROCESS | 1334 | Values: 75.0 76.0 77.0 151.0 77.0 75.0 77.0 76.0 123.0 77.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:21.51 (23.1%) stddev-sans-first:22.37 05:31:33 INFO - PROCESS | 1334 | Values: 94.0 92.0 148.0 94.0 93.0 93.0 133.0 92.0 93.0 128.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 05:31:33 INFO - PROCESS | 1334 | Values: 117.0 117.0 117.0 117.0 117.0 123.0 116.0 117.0 117.0 117.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 05:31:33 INFO - PROCESS | 1334 | Values: 147.0 147.0 146.0 146.0 145.0 145.0 145.0 147.0 146.0 146.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:31:33 INFO - PROCESS | 1334 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:31:33 INFO - PROCESS | 1334 | Values: 64.0 64.0 65.0 64.0 64.0 66.0 65.0 65.0 65.0 65.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:31:33 INFO - PROCESS | 1334 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 64.0 64.0 64.0 65.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.00 stddev:24.68 (29.4%) stddev-sans-first:26.00 05:31:33 INFO - PROCESS | 1334 | Values: 84.0 87.0 82.0 82.0 82.0 87.0 84.0 82.0 162.0 90.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:132.00 stddev:6.75 (5.1%) stddev-sans-first:7.11 05:31:33 INFO - PROCESS | 1334 | Values: 132.0 132.0 141.0 142.0 129.0 129.0 130.0 129.0 148.0 132.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.50 stddev:2.59 (1.5%) stddev-sans-first:2.74 05:31:33 INFO - PROCESS | 1334 | Values: 172.0 173.0 171.0 174.0 177.0 169.0 176.0 171.0 170.0 171.0 05:31:33 INFO - PROCESS | 1334 | 05:31:33 INFO - PROCESS | 1334 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 05:31:33 INFO - PROCESS | 1334 | Values: 68.0 69.0 67.0 68.0 70.0 66.0 70.0 67.0 66.0 67.0 05:31:33 INFO - PROCESS | 1334 | -------- Summary: end -------- 05:31:33 INFO - PROCESS | 1334 | 05:31:34 INFO - TEST-INFO | 1334: exit 0 05:31:34 INFO - TEST-OK | kraken | took 65509ms 05:31:34 INFO - SUITE-END | took 1185s 05:31:34 INFO - Completed test suite (00:19:45) 05:31:34 INFO - javascript benchmark 05:31:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.2311429685387, 2658.0962472759256, 2684.798640101993, 2696.90560830371, 2703.783697304216, 4536.228841097013, 4632.884177895546, 4647.744374059425, 4738.17082010648, 4780.856574302772, 4652.232381657022, 4679.461861885884, 4681.64887633428, 4708.0, 4760.66675332726, 4302.247106756313, 4318.956810431902, 4371.672124590653, 4428.158649856517, 4495.168393847149, 4405.339199120125, 4453.198424283628, 4480.103979204172, 4509.594136527712, 4512.16524942885, 4262.936055959163, 4266.360045993126, 4303.031817840976, 4320.71915325506, 4325.113351762881, 4333.58830911063, 4339.652827773771, 4341.0, 4343.06624075822, 4346.022145017378, 4256.5105012923605, 4273.4444522212225, 4292.506361768405, 4307.5261721210645, 4343.04453020335, 4531.116432295704, 4615.469221039556, 4623.768811559408, 4657.417822772153, 4678.578927896506, 5054.898902021939, 5097.974510127463, 5098.286239926413, 5104.770285337132, 5105.5149760772665, 4897.41231052276, 4912.042151780404, 4957.851264462072, 4979.47715489872, 5008.799648014112, 4692.389989301437, 4730.455997560324, 4732.645051621143, 4734.384530011145, 4742.739149346819, 4960.0, 5140.948590514122, 5161.019406312788, 5164.664296820694, 5199.870003249874, 4901.264810278487, 4927.433345165352, 4933.777979990909, 4941.72820494869, 4959.20652695567, 5023.321851550067, 5023.974880125649, 5026.44709082008, 5032.47159048302, 5077.238414237894, 4746.738929358849, 4998.825041123543, 5000.549950504472, 5006.799728010838, 5059.797608095709, 5004.674696144739, 5031.723255220924, 5061.34202553673, 5113.1563292057135, 5115.64190506661, 4356.041670832412, 4363.127374525107, 4365.541618130051, 4367.213901497697, 4408.9559104408545, 3702.333579955634, 3773.1887644156636, 3823.120682243044, 3849.8075096245075, 3874.9612503875164, 4272.081502476983, 4297.828086876552, 4308.870733877989, 4309.59058889405, 4311.137772445523, 5032.194848824244, 5059.519345662156, 5059.544640982329, 5063.367079115111, 5067.265246539231, 4201.768902710381, 4225.809838557272, 4311.461067366579, 4312.741235525878, 4349.891252718708, 4510.233260345683, 4538.52345503724, 4542.136993971135, 4560.201964656172, 4588.7246765194195, 4709.952900470951, 4714.481407045291, 4721.811127554928, 4723.787429565747, 4766.308885211555, 4889.755512224446, 4968.925466117938, 5000.949990500048, 5002.774875130555, 5011.123053465702, 4719.504452032487, 4745.762711864462, 4747.074320507468, 4777.856664300077, 4794.688345257687, 4958.25626156065, 4960.47914968923, 4960.603151747924, 4977.054359671651, 5000.149974504416, 4896.216605343128, 4989.501049895127, 5022.899542009212, 5063.392392912874, 5081.517255860687, 4931.3096166536, 4948.480409556944, 4955.0, 4955.752212389294, 4992.975035124801, 4943.209086546135, 4948.727819969792, 4948.8762780930765, 4952.801887924443, 4981.750912454435, 4706.34111224422, 4727.57451829337, 4773.641976851681, 4773.952260477351, 4917.409910810726, 4964.429090654477, 4968.155413579628, 4969.4782047884455, 4975.0, 5000.974995125147, 4859.708417494961, 4860.975695121501, 4869.391326084239, 4881.389826271716, 4916.803327866988], "value": 4628.069384994107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7006356694517, 592.2537602620698, 606.0817860940675, 621.0094898636676, 624.9000159974405, 27423.725762742368, 42819.78590107049, 43902.34146487797, 43961.340579891286, 43988.34017489732, 43512.347314790306, 44178.779106104426, 44180.337294940604, 44187.337189942176, 44236.77881610596, 7323.0, 7897.960510197456, 8067.394945379091, 10051.095401413872, 10332.638357657483, 10151.340162889426, 10256.384616922971, 10256.435896025716, 10261.58953641857, 10265.076143147115, 10214.846777298346, 10255.33340332876, 10256.282060255786, 10256.435896025716, 10261.743456413613, 7498.625068746541, 9978.550965206583, 10254.92323306057, 10266.538005789758, 10597.73505662357, 10054.497275136287, 10109.646162384355, 10111.696649100539, 10118.139958103497, 10127.544260508295, 38757.22485550302, 39020.21959560793, 39170.0, 39307.803460982796, 39353.60646393557, 3234.87060517579, 3246.6915643013876, 3263.086335825949, 3284.1953721338423, 3327.317899830553, 30025.849870750724, 30274.54588181179, 30742.0, 30882.0, 32076.83961580177, 3172.476541370671, 3174.3809957058384, 3186.9043928682177, 3238.805671659708, 3242.1732458223237, 233397.0, 234723.0, 235013.0, 235458.99999999828, 236211.0, 50959.235611465854, 51143.0, 51340.22989655158, 51398.8601139883, 51399.22901156486, 33786.83106584451, 37072.814635927185, 37095.4435683465, 38314.80842595825, 38547.229055419295, 12862.807057894139, 14855.628609284855, 15012.249387530579, 15016.24918754058, 15116.09303441797, 9587.568559414703, 9803.656872009446, 9806.215502759762, 10994.560217591366, 11280.041196498225, 19239.422817315502, 19260.711089333392, 19307.90346048261, 19353.225870965285, 19506.512337191685, 7063.2583578724525, 7063.540869843444, 7191.89212161818, 7268.781936541912, 7321.231270716498, 859.3082568532267, 920.2270093121809, 946.9195118414874, 998.6554638649654, 1013.8681971343678, 28880.277993050342, 29664.851675741484, 29705.702942970725, 30273.24316892051, 30406.0, 1010.540204207084, 1021.8160731068331, 1025.9127974122134, 1045.6340280901775, 1103.7406209540752, 15452.613684657748, 15752.369905203663, 15759.921200394154, 15832.129232892072, 15843.524694259191, 368443.0, 370816.0, 372860.0, 373530.0, 375743.0, 52231.73884130555, 53461.73269133629, 53468.0, 53485.73257133689, 53587.73206133944, 1135.8012347839094, 1247.5571172233908, 1251.8810712982252, 1262.6338361875137, 1280.9615711528857, 29061.85469072641, 30607.54088688627, 30624.693753063075, 30810.537841932837, 30966.435993059382, 43881.12237755291, 44150.33774493449, 44650.0, 44688.0, 44764.0, 289443.0, 290707.0, 291239.0, 292614.0, 293081.0, 22781.886090569442, 24980.625290620294, 26979.460410791282, 27058.458830823667, 28596.285092872844, 43757.34363984479, 44577.777111114236, 44653.330200047676, 45163.0967380644, 45631.31553026773, 37246.0, 38009.23981520409, 38044.80977595094, 38099.42850857295, 38524.6147538521, 37409.25181496409, 37535.249295014495, 37921.0, 38084.619153808104, 38291.234175316895, 37004.074898127765, 37355.0, 37722.0, 38491.6150838488, 39874.800625996686, 32999.67000330062, 33987.0, 34568.0, 35097.29805403826, 35289.0, 26347.604785927844, 26475.735242647326, 26494.735052649226, 26701.732982669924, 26898.327541810828], "value": 18328.19031848257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.92441511697666, 381.11581131774284, 386.25452875949406, 394.74933417280016, 397.83092185821016, 14277.0, 14868.405263789435, 16085.590303755802, 17948.91025544872, 18362.540936476595, 16528.586785330343, 16984.32062717493, 17438.215280312386, 17535.0, 17962.19170137344, 4646.279826626878, 5002.724305302143, 5073.695578265307, 5315.123004704238, 5320.600954928396, 5252.894942101156, 5261.815836445725, 5281.498257665535, 5290.761915713783, 5305.4164041955355, 5180.300659410969, 5209.947900520984, 5216.76524556394, 5256.26412302278, 5259.132243179871, 5068.645194836345, 5211.374635043781, 5217.791288348461, 5221.973890130563, 5222.955408918231, 4485.842995495142, 4654.697444666086, 4670.112678591091, 4675.088357770236, 4678.0410015946645, 20618.690719639217, 21333.786662133334, 21418.143274269012, 21576.244831430824, 21760.673589896163, 2024.98987505063, 2046.815786579215, 2153.6123497770395, 2337.672725818387, 2396.844205126661, 9132.543372831398, 9334.15992560666, 9809.950950245204, 9856.556454959473, 13500.122492037986, 1804.5127815489875, 1823.4165067178508, 1834.97247541287, 1851.1577232359243, 1859.7675290588677, 69963.65018174927, 70231.29768702299, 71489.2851071493, 71938.0, 73385.63307183483, 10219.540120694586, 10358.119559837498, 10403.68788936318, 10540.9986051325, 10567.788644227072, 12595.118341715992, 13323.267220302976, 14572.417103315749, 14591.489297874523, 14595.051321664057, 6627.204735431779, 6753.15585551806, 6992.440604751608, 7075.398591119812, 7238.891416628755, 6461.676916154173, 6466.838329041718, 6529.934700653028, 6785.9321406786285, 6790.111119993597, 4467.106578684211, 4484.932726009112, 4558.316252562142, 4584.106099310669, 4643.605293550018, 1839.9172037258088, 1890.4706682129026, 1903.4670292318174, 1943.378119001934, 1956.364181640944, 780.7969927818808, 864.2006144316482, 905.3391024552113, 918.0589895357313, 1028.8816786069697, 16287.429939952044, 16556.42052528156, 17051.232694528775, 17646.117694115244, 17922.641547168983, 909.068205089775, 923.4090182283344, 947.2523194705894, 953.8140062687849, 982.5382070426888, 9446.244300455946, 9702.805943881083, 10501.107405870587, 10513.684589462327, 10890.074343680875, 403409.0, 405185.0, 417659.0, 423477.0, 423969.0, 82158.58920705477, 85731.0, 85820.98879617675, 86145.56927215324, 86151.0, 965.0928127560211, 977.6822532676766, 993.3791380387258, 996.5714742660725, 1008.6318493749875, 16022.599435014217, 16210.756838647194, 16363.34546618122, 16465.094419807025, 16557.58606034859, 35853.462198066525, 36072.098197545274, 36593.45109823302, 37288.75881362063, 37378.0, 50912.745436272584, 52028.47971520236, 52164.21753673622, 52662.0, 53675.0, 7842.215778422112, 8054.31538319226, 8144.267015968591, 8153.143919888326, 8160.632771525177, 11323.377214253294, 11785.764284714087, 11808.645740627795, 11913.583024594098, 12047.81928271059, 10035.19718422539, 10233.437160956219, 10241.897581024094, 10483.213758967955, 10702.89297107019, 10048.949755251177, 10270.948645256725, 10329.380237185793, 10411.739706507398, 10517.526711298164, 10333.689989300334, 10493.580256789643, 10502.894971050191, 10513.474326283807, 10527.263091583516, 7757.844843103219, 7853.233022570104, 7966.84066318682, 7983.1617680142745, 8012.83974320522, 10694.518746656264, 10710.785784284115, 10730.0, 10748.0, 10861.782764344827], "value": 8411.131279270961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.044480972056, 1463.72189284036, 1503.3535579700729, 1612.9919350403247, 1763.0655752451198, 6427.0, 6987.441004719623, 7168.354848063674, 7176.282371762821, 7307.378872795805, 7073.681684324205, 7217.350438460538, 7218.278172182779, 7236.529625574334, 7239.601821899793, 1825.2151574822822, 2033.8677985930867, 2110.1137522240697, 2130.1053557505847, 2172.2940044485526, 2235.94410139747, 2255.6278214094655, 2256.8645881247176, 2259.1754009786473, 2261.9321420357414, 2167.6206663833846, 2226.7216597925258, 2228.665700144983, 2230.185982116532, 2231.230225572175, 1834.596388794463, 2081.792560315021, 2146.5599552091785, 2146.8282537397126, 2155.277981876073, 2066.917323307066, 2087.2485905074163, 2088.3212955789277, 2098.3600001999384, 2110.926117585877, 7164.7134114635355, 7170.498065135443, 7220.133583969957, 7223.674934627954, 7223.89164162538, 4250.829966801324, 4356.520782713899, 4363.607275345203, 4373.169097871394, 4376.256036473807, 2895.3051267695814, 2905.7094290570985, 2958.3935293265044, 2967.3323502212047, 2988.8804447822276, 940.6096469964956, 940.8400571902793, 948.2698322291866, 949.5110018340561, 964.599691128181, 9922.255830812717, 9937.10566049059, 9988.250881183867, 9992.050755178247, 9999.200063994864, 4109.219248342805, 4174.248635245685, 4257.340112282601, 4266.637335826427, 4278.336857787048, 8360.540170290571, 8369.163083691583, 8383.664653413794, 8409.0, 8421.705240316682, 3893.649571538575, 4407.030453300269, 4461.683803278041, 4467.106578684276, 4474.709143905636, 3886.1839013806853, 4027.577104404054, 4042.413849991735, 4050.797460126982, 4066.430699702044, 3566.518519999767, 3611.8735844245325, 3680.245549662313, 3691.187938653492, 3711.851525938986, 1192.43359404284, 1203.374245392391, 1204.374094971781, 1218.2933898338943, 1219.1405059433077, 794.1661255681511, 878.3149143667949, 887.5340446265633, 898.0480690467995, 906.9002409734924, 5202.375714914158, 5214.661047031931, 5250.081235783722, 5430.817217716781, 5501.807436739695, 830.4767996162379, 867.4144952157269, 884.0408157149436, 910.235402262103, 911.6672414568635, 3540.150363912642, 3611.6207798180812, 3637.636236376394, 3677.2645470905927, 3684.631536846294, 8798.912010879809, 9202.355835091614, 9300.209482193954, 9333.346665733334, 9333.533323333806, 9166.633334666672, 9246.306527010367, 9249.075092490697, 9251.49116798569, 9261.768455788524, 6805.183377994672, 6942.132233470817, 7045.7533986311255, 7099.148102227766, 7113.359797618239, 5111.642185047011, 5119.820806271762, 5151.330327057459, 5158.742062896765, 5158.813472901179, 8255.669773209005, 8479.321654267767, 8486.19381158789, 8541.743747687578, 8582.927134108237, 8414.705485307984, 8524.659013639384, 8569.742907712778, 8574.871376929226, 8605.440646357967, 5915.733791979285, 6111.327753946974, 6111.908321375094, 6595.868082638416, 6735.6968936397, 6094.9085763714465, 7115.750948716977, 7130.607816570138, 7338.77983660491, 7340.816479588053, 6544.28012918569, 6671.232808227116, 6681.33186681328, 6780.050792888901, 6784.966075169593, 6544.345565443417, 6585.539012269287, 6617.933820661732, 6705.463562914858, 6710.0, 6261.812145635638, 6266.686665666607, 6320.4311611955145, 6327.810165695037, 6332.335104814112, 4423.314386270134, 4423.933640995323, 4453.933191002202, 4506.504284528633, 4565.634749220121, 4390.463337831733, 4411.558844115562, 4417.602415782595, 4437.378766972691, 4439.511653718024], "value": 4035.2298677136923, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.2745411013569, 309.6732946741188, 315.8847020837395, 318.9122991177426, 322.9386416580849, 4934.703917764937, 4937.777799998999, 4960.925586116211, 4963.875903102428, 4977.203647416414, 4603.838865639704, 4612.723236605798, 4663.883402914928, 4822.469528351879, 4892.4618291987945, 3848.076461649212, 3854.5952674969003, 3859.614038596132, 3859.787711675857, 3866.8979340887854, 3844.596317386676, 3850.4224366344993, 3852.4221366795064, 3859.749116307445, 3878.7866667333287, 3650.543682039745, 3667.4865518827387, 3803.790791506466, 3814.5613254475675, 3841.9039524011982, 3776.9433458498142, 3799.772013679188, 3807.8667246646373, 3821.636944490269, 3824.694024478035, 3367.579052618423, 3379.8986030418882, 3395.7962522248745, 3408.84660190292, 3410.471376936554, 4363.978180109111, 4622.098690755304, 4651.953480465219, 4668.11305851887, 4669.906601867943, 4255.5744425557505, 4268.637165840907, 4270.338097594878, 4275.807588658487, 4303.634191093761, 5052.8484145475695, 5059.569936555397, 5086.694798312076, 5092.8217512387255, 5128.512791284859, 3617.137174355209, 3620.529331186955, 3628.96574476273, 3632.128289210597, 3637.4907512948207, 5172.741362931838, 5256.132738098209, 5318.494742999409, 5353.08997470427, 5360.9463905360835, 3677.5770786359913, 3681.116532032293, 3702.148505843671, 3707.016746040855, 3717.219383929351, 3741.120836603396, 3751.911945535764, 3758.981205094012, 3778.112143646241, 3778.376567866271, 4191.350340697197, 4299.677524185636, 4330.39374487572, 4337.869863904088, 4354.869353919387, 5053.9494605054215, 5123.001014802077, 5124.027249508966, 5140.56305214061, 5149.665271757399, 1242.5278394210143, 1248.2697621891114, 1260.4202067049077, 1267.4663656975163, 1273.9936300318438, 806.1454857850697, 831.4886344897965, 866.6533386645266, 866.6749968761715, 868.778461492328, 4270.359446083113, 4290.806913688892, 4305.117450922553, 4306.82772689089, 4315.8273669053515, 5047.87380315495, 5056.418511871108, 5085.7202853842655, 5107.642465027412, 5135.457948315608, 4202.70581059329, 4317.892052698708, 4326.983158957642, 4333.696641235147, 4485.529019452911, 2699.217227004186, 2720.265528307346, 2740.328619488238, 2752.3394385347774, 2757.896841263511, 4861.666400127959, 4864.854054378375, 4866.245731911559, 4868.0, 4880.853574392774, 4958.206686930074, 5276.3932147802725, 5281.603879709037, 5298.3906850712665, 5330.466953304716, 4815.085133824562, 4830.541098595628, 4852.490488498657, 4870.7808148632685, 4902.3872015998, 5056.0, 5124.487551244845, 5130.640855140105, 5153.247895715474, 5159.355080614923, 4973.6269779765935, 4980.980621199938, 4997.625178111583, 5099.821506247264, 5111.821086261963, 4843.4430040545785, 4850.345203397496, 4856.271559266138, 4858.805647774049, 4889.217725163957, 3584.820758961989, 3597.0647631615443, 3603.0992251937014, 3628.4920111184983, 3660.5424321959754, 5033.030511997938, 5133.0, 5137.948620513747, 5226.510444523445, 5230.581553475637, 4897.212517431183, 4965.684093715096, 4984.8753781155765, 4990.950090499048, 4992.101421743976, 4888.5111488850835, 4930.211166213388, 4938.2839488273285, 4956.231784073474, 4979.676321039121, 4684.789184486638, 4798.2082956311815, 4867.95132048675, 4871.269309603588, 4874.366332376769, 4995.8001679932395, 5025.949740502694, 5027.109412087991, 5027.597792176544, 5031.195008798574, 4898.436679781871, 4979.253112033224, 4998.1503144464805, 5012.245714000071, 5044.293798868235], "value": 3798.74887749668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.4169351978135, 718.540134314039, 725.960072196029, 751.5866273549547, 801.5671537369818, 12138.453769580368, 12609.621711348675, 12647.683807904807, 12651.683707907307, 12660.43028063737, 13051.869481305184, 13094.148880322773, 13108.0, 13139.27733974631, 13144.474221031147, 668.6222284409293, 850.6682393866397, 864.5893200729666, 872.5768002518773, 873.3624454148444, 851.4252879306474, 853.7524118005771, 854.1927878155146, 856.9357298202659, 857.9227869491745, 898.2589363774879, 905.2893478619285, 905.3210092430677, 905.6830109461702, 905.8777065096226, 691.4606606846668, 878.9033206347297, 894.0701670262919, 894.4990805149105, 905.7328088213993, 672.2437258084655, 672.4687496877461, 672.7241830849329, 673.0241150331989, 673.0946876451214, 11755.529778808837, 11781.882181178164, 11806.23259488139, 11835.644930652008, 11866.821997670042, 10493.475326233658, 10786.892131078746, 10879.292845964987, 10981.725456863642, 11117.666470005914, 10209.591616335338, 10357.48212589375, 10381.07950029247, 10448.0, 10520.421376824272, 3979.5423526294558, 3999.4000899864964, 4004.3192657248337, 4029.959700402988, 4085.0400155963325, 42943.141137177394, 43185.13629727388, 43219.0, 43341.133177336276, 43593.782031089955, 8783.25342345895, 8815.779605509786, 9011.819763604692, 9064.229540489132, 9080.273578113734, 15506.844931550766, 15567.688646227238, 15592.844071559366, 15596.454124105601, 15787.210639467981, 6427.325130861286, 6462.903056454157, 6480.092787009822, 6495.058216558573, 6693.531452798355, 3522.894313170609, 3551.698105660996, 3560.038789526865, 3561.245791412761, 3618.5295911531857, 2767.9861600691866, 2780.694123646397, 2851.144656603052, 2864.856757162175, 2866.2977570495364, 558.4387690371151, 558.4889825809339, 558.9245451863947, 565.2651552981108, 570.54356514788, 453.95687409696023, 575.1774961804659, 591.6272748168626, 595.7756809755906, 599.8080614203413, 7998.5600791957, 8012.879806802903, 8083.595820208966, 8150.83698326042, 8208.58957052145, 464.20211557644774, 474.962003039756, 518.9195674670357, 552.0670067585767, 597.9730912108965, 3502.5446691929887, 3676.7058635309113, 3680.9263814723554, 3708.2212735325343, 3738.8691395801015, 48624.27063593978, 50629.746851266245, 50703.74648126736, 50806.49193508018, 51016.74491627518, 43071.35392969046, 45168.09663806706, 45241.54758452439, 45738.0, 46948.5305146951, 41845.79077104595, 42171.36742948858, 42317.78841105836, 42378.15243695109, 43110.56889431066, 7333.559986400833, 7358.889616655862, 7503.287187717158, 7539.359154471931, 7631.347226298779, 28231.0, 28289.57565636558, 28651.0, 29348.11955641334, 29359.266018349714, 35665.28669426649, 36354.0, 36490.0, 36930.26139477142, 37117.81441092777, 9387.483688397204, 9395.953020235129, 9425.293103017164, 9428.95285523568, 9527.857082143912, 9299.349045566745, 9333.85999210026, 9455.723670520993, 10033.397996120257, 10059.094681478702, 9117.635294588143, 10444.425556594157, 10473.581056757948, 10559.577616895238, 11062.446877656246, 10371.27401081917, 10456.26806123564, 10698.89301106979, 10900.727481813017, 11787.528498859949, 10109.292349535463, 10313.9484302578, 10459.633912813015, 10863.728406789893, 10880.782384352427, 8182.427230093836, 8394.958025209835, 8401.369897257853, 8455.830883382421, 9002.324825638234, 8039.15588863161, 8060.556669383006, 8101.473404228706, 8119.4722343047515, 8332.250097491255], "value": 5776.225269948235, "unit": "score"}], "name": "dromaeo_css", "value": 6310.978589085791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 114.0, 115.0, 116.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 137.0, 159.0, 208.0, 134.0, 162.0, 158.0, 133.0, 191.0, 130.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 151.0, 77.0, 75.0, 77.0, 76.0, 123.0, 77.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 148.0, 94.0, 93.0, 93.0, 133.0, 92.0, 93.0, 128.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 123.0, 116.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 82.0, 82.0, 82.0, 87.0, 84.0, 82.0, 162.0, 90.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 141.0, 142.0, 129.0, 129.0, 130.0, 129.0, 148.0, 132.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 171.0, 174.0, 177.0, 169.0, 176.0, 171.0, 170.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 70.0, 66.0, 70.0, 67.0, 66.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1580.6000000000001, "alertThreshold": 2.0}]} 05:31:34 INFO - Return code: 0 05:31:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:34 ERROR - # TBPL SUCCESS # 05:31:34 INFO - Running post-action listener: _resource_record_post_action 05:31:34 INFO - ##### 05:31:34 INFO - ##### Finished run-tests step (success) 05:31:34 INFO - ##### 05:31:34 INFO - Running post-run listener: _resource_record_post_run 05:31:35 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545603584; Read time: 12; Write time: 636688 05:31:35 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251789312; Read time: 0; Write time: 448504 05:31:35 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293814272; Read time: 12; Write time: 188184 05:31:35 INFO - Running post-run listener: _upload_blobber_files 05:31:35 INFO - Blob upload gear active. 05:31:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:35 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:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:37 INFO - (blobuploader) - INFO - Done attempting. 05:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:37 INFO - (blobuploader) - INFO - Done attempting. 05:31:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:37 INFO - Return code: 0 05:31:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992d78b2ebf082035102f20a5eb689e23f22c2747abc71457bb52f3f848b857d0ad6f3ca6bbdd8eb5237fb398a12c4a298cd6d5124b8be115e01633aeddef6ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78258432828a0615b306976fcf3a31f5fe20c694f56cf2062335823a03c98e2b9e62f7e6af1b66e356704fed3e14fb184724d2e77926544df9efe13dc6d9243"} 05:31:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:37 INFO - Contents: 05:31:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992d78b2ebf082035102f20a5eb689e23f22c2747abc71457bb52f3f848b857d0ad6f3ca6bbdd8eb5237fb398a12c4a298cd6d5124b8be115e01633aeddef6ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78258432828a0615b306976fcf3a31f5fe20c694f56cf2062335823a03c98e2b9e62f7e6af1b66e356704fed3e14fb184724d2e77926544df9efe13dc6d9243"} 05:31:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:37 INFO - Copying logs to upload dir... 05:31:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.821696 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 05:31:37.780355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:31:37.783851) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992d78b2ebf082035102f20a5eb689e23f22c2747abc71457bb52f3f848b857d0ad6f3ca6bbdd8eb5237fb398a12c4a298cd6d5124b8be115e01633aeddef6ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78258432828a0615b306976fcf3a31f5fe20c694f56cf2062335823a03c98e2b9e62f7e6af1b66e356704fed3e14fb184724d2e77926544df9efe13dc6d9243"} build_url:https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/ec9URdT1StCIucoQLQHEBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992d78b2ebf082035102f20a5eb689e23f22c2747abc71457bb52f3f848b857d0ad6f3ca6bbdd8eb5237fb398a12c4a298cd6d5124b8be115e01633aeddef6ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78258432828a0615b306976fcf3a31f5fe20c694f56cf2062335823a03c98e2b9e62f7e6af1b66e356704fed3e14fb184724d2e77926544df9efe13dc6d9243"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:31:37.808330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:31:37.808629) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462795856.569270-1351830263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:31:37.892365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:31:37.892756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:31:37.893040) ========= ========= Total master_lag: 0.16 =========