builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1462573469.1 results: success (0) buildid: 20160506135800 builduid: 25f8d0b308a64bd4bfe3f1d116779698 revision: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.098415) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.098952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.099226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.137103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.137577) ========= 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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 15:24:29-- 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% 67.0M=0s 2016-05-06 15:24:29 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.305872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.456940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.457223) ========= 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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014409 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.508266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 15:24:29.508587) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 --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 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 --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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 15:24:29,891 truncating revision to first 12 chars 2016-05-06 15:24:29,891 Setting DEBUG logging. 2016-05-06 15:24:29,891 attempt 1/10 2016-05-06 15:24:29,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0a55f3f89efd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 15:24:31,207 unpacking tar archive at: fx-team-0a55f3f89efd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 15:24:31.115797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:31.116107) ========= script_repo_revision: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:31.116522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:31.116812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:31.127411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 15:24:31.127697) ========= /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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:31 INFO - MultiFileLogger online at 20160506 15:24:31 in /builds/slave/test 15:24:31 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 15:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:31 INFO - {'append_to_log': False, 15:24:31 INFO - 'base_work_dir': '/builds/slave/test', 15:24:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:31 INFO - 'branch': 'Fx-Team-Non-PGO', 15:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:31 INFO - 'config_files': ('talos/linux_config.py',), 15:24:31 INFO - 'default_actions': ('clobber', 15:24:31 INFO - 'read-buildbot-config', 15:24:31 INFO - 'download-and-extract', 15:24:31 INFO - 'populate-webroot', 15:24:31 INFO - 'create-virtualenv', 15:24:31 INFO - 'install', 15:24:31 INFO - 'run-tests'), 15:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:31 INFO - 'download_minidump_stackwalk': True, 15:24:31 INFO - 'download_symbols': 'ondemand', 15:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:31 INFO - 'installer_path': 'installer.exe', 15:24:31 INFO - 'log_level': 'info', 15:24:31 INFO - 'log_name': 'talos', 15:24:31 INFO - 'log_to_console': True, 15:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:31 INFO - 'opt_config_files': (), 15:24:31 INFO - 'pip_index': False, 15:24:31 INFO - 'sps_profile': False, 15:24:31 INFO - 'sps_profile_interval': 0, 15:24:31 INFO - 'suite': 'dromaeojs', 15:24:31 INFO - 'system_bits': '32', 15:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:31 INFO - 'title': 'talos-linux64-ix-009', 15:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:31 INFO - 'use_talos_json': True, 15:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:31 INFO - 'work_dir': 'build'} 15:24:31 INFO - ##### 15:24:31 INFO - ##### Running clobber step. 15:24:31 INFO - ##### 15:24:31 INFO - Running pre-action listener: _resource_record_pre_action 15:24:31 INFO - Running main action method: clobber 15:24:31 INFO - rmtree: /builds/slave/test/build 15:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:32 INFO - Running post-action listener: _resource_record_post_action 15:24:32 INFO - ##### 15:24:32 INFO - ##### Finished clobber step (success) 15:24:32 INFO - ##### 15:24:32 INFO - ##### 15:24:32 INFO - ##### Running read-buildbot-config step. 15:24:32 INFO - ##### 15:24:32 INFO - Running pre-action listener: _resource_record_pre_action 15:24:32 INFO - Running main action method: read_buildbot_config 15:24:32 INFO - Using buildbot properties: 15:24:32 INFO - { 15:24:32 INFO - "project": "", 15:24:32 INFO - "product": "firefox", 15:24:32 INFO - "script_repo_revision": "production", 15:24:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:24:32 INFO - "repository": "", 15:24:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:24:32 INFO - "buildid": "20160506135800", 15:24:32 INFO - "pgo_build": "False", 15:24:32 INFO - "basedir": "/builds/slave/test", 15:24:32 INFO - "buildnumber": 2934, 15:24:32 INFO - "slavename": "talos-linux64-ix-009", 15:24:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:32 INFO - "platform": "ubuntu64_hw", 15:24:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:24:32 INFO - "branch": "fx-team", 15:24:32 INFO - "repo_path": "integration/fx-team", 15:24:32 INFO - "revision": "0a55f3f89efd80dadf3d951e1a0d073a66fec9a0", 15:24:32 INFO - "stage_platform": "linux64", 15:24:32 INFO - "builduid": "25f8d0b308a64bd4bfe3f1d116779698", 15:24:32 INFO - "slavebuilddir": "test" 15:24:32 INFO - } 15:24:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:24:32 INFO - Running post-action listener: _resource_record_post_action 15:24:32 INFO - ##### 15:24:32 INFO - ##### Finished read-buildbot-config step (success) 15:24:32 INFO - ##### 15:24:32 INFO - ##### 15:24:32 INFO - ##### Running download-and-extract step. 15:24:32 INFO - ##### 15:24:32 INFO - Running pre-action listener: _resource_record_pre_action 15:24:32 INFO - Running main action method: download_and_extract 15:24:32 INFO - mkdir: /builds/slave/test/build/tests 15:24:32 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')]} 15:24:32 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:34 INFO - Downloaded 1361 bytes. 15:24:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:34 INFO - Using the following test package requirements: 15:24:34 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:34 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:34 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:24:34 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'jsshell-linux-x86_64.zip'], 15:24:34 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:34 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:34 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:24:34 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:24:34 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:34 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:34 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')]} 15:24:34 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:36 INFO - Downloaded 22321395 bytes. 15:24:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:24:37 INFO - Return code: 0 15:24:37 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 15:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:37 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:43 INFO - Downloaded 22321395 bytes. 15:24:43 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'] 15:24:43 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 15:24:44 INFO - Return code: 0 15:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:44 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:45 INFO - Downloaded 10840152 bytes. 15:24:45 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'] 15:24:45 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 15:24:45 INFO - Return code: 0 15:24:45 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')]} 15:24:45 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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 15:24:47 INFO - Downloaded 54839275 bytes. 15:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:47 INFO - mkdir: /builds/slave/test/properties 15:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:47 INFO - Contents: 15:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:48 INFO - Running post-action listener: _resource_record_post_action 15:24:48 INFO - Running post-action listener: set_extra_try_arguments 15:24:48 INFO - ##### 15:24:48 INFO - ##### Finished download-and-extract step (success) 15:24:48 INFO - ##### 15:24:48 INFO - ##### 15:24:48 INFO - ##### Running populate-webroot step. 15:24:48 INFO - ##### 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: populate_webroot 15:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:48 INFO - '--tppagecycles', 15:24:48 INFO - '7'], 15:24:48 INFO - 'tests': ['tsvgm']}}, 15:24:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['damp', 'tps']}, 15:24:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'tests': ['damp', 'tps']}, 15:24:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['dromaeo_dom']}, 15:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['tsvgx', 15:24:48 INFO - 'tsvgr_opacity', 15:24:48 INFO - 'tart', 15:24:48 INFO - 'tscrollx', 15:24:48 INFO - 'cart']}, 15:24:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:48 INFO - 'tsvgr_opacity', 15:24:48 INFO - 'tart', 15:24:48 INFO - 'tscrollx', 15:24:48 INFO - 'cart']}, 15:24:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-e10s'], 15:24:48 INFO - 'tests': ['tp5o']}, 15:24:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'tests': ['tp5o']}, 15:24:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-e10s', 15:24:48 INFO - '--xperf_path', 15:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:48 INFO - 'tests': ['tp5n']}, 15:24:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:48 INFO - 'talos_options': ['--xperf_path', 15:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:48 INFO - 'tests': ['tp5n']}}, 15:24:48 INFO - 'talos.zip': {'path': '', 15:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:48 INFO - Running post-action listener: _resource_record_post_action 15:24:48 INFO - ##### 15:24:48 INFO - ##### Finished populate-webroot step (success) 15:24:48 INFO - ##### 15:24:48 INFO - ##### 15:24:48 INFO - ##### Running create-virtualenv step. 15:24:48 INFO - ##### 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: create_virtualenv 15:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:48 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 15:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:48 INFO - Using real prefix '/usr' 15:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:50 INFO - Installing pip.................done. 15:24:50 INFO - Return code: 0 15:24:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:50 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')]} 15:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:50 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')]} 15:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:50 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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:24:50 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 15:24:50 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 15:24:50 INFO - Using env: {'DISPLAY': ':0', 15:24:50 INFO - 'HOME': '/home/cltbld', 15:24:50 INFO - 'LANG': 'en_US.UTF-8', 15:24:50 INFO - 'LANGUAGE': 'en_US:en', 15:24:50 INFO - 'LOGNAME': 'cltbld', 15:24:50 INFO - 'MAIL': '/var/mail/cltbld', 15:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:50 INFO - 'MOZ_NO_REMOTE': '1', 15:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:50 INFO - 'NO_EM_RESTART': '1', 15:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:50 INFO - 'PWD': '/builds/slave/test', 15:24:50 INFO - 'SHELL': '/bin/bash', 15:24:50 INFO - 'SHLVL': '1', 15:24:50 INFO - 'TERM': 'linux', 15:24:50 INFO - 'TMOUT': '86400', 15:24:50 INFO - 'USER': 'cltbld', 15:24:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:50 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:51 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 15:24:51 INFO - Cleaning up... 15:24:51 INFO - Return code: 0 15:24:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:24:51 INFO - Using env: {'DISPLAY': ':0', 15:24:51 INFO - 'HOME': '/home/cltbld', 15:24:51 INFO - 'LANG': 'en_US.UTF-8', 15:24:51 INFO - 'LANGUAGE': 'en_US:en', 15:24:51 INFO - 'LOGNAME': 'cltbld', 15:24:51 INFO - 'MAIL': '/var/mail/cltbld', 15:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:51 INFO - 'MOZ_NO_REMOTE': '1', 15:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:51 INFO - 'NO_EM_RESTART': '1', 15:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:51 INFO - 'PWD': '/builds/slave/test', 15:24:51 INFO - 'SHELL': '/bin/bash', 15:24:51 INFO - 'SHLVL': '1', 15:24:51 INFO - 'TERM': 'linux', 15:24:51 INFO - 'TMOUT': '86400', 15:24:51 INFO - 'USER': 'cltbld', 15:24:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:51 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:51 INFO - Downloading/unpacking psutil>=0.7.1 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:53 INFO - Installing collected packages: psutil 15:24:53 INFO - Running setup.py install for psutil 15:24:53 INFO - building 'psutil._psutil_linux' extension 15:24:53 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 15:24:53 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 15:24:53 INFO - building 'psutil._psutil_posix' extension 15:24:53 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 15:24:53 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 15:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:53 INFO - Successfully installed psutil 15:24:53 INFO - Cleaning up... 15:24:53 INFO - Return code: 0 15:24:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:24:53 INFO - Using env: {'DISPLAY': ':0', 15:24:53 INFO - 'HOME': '/home/cltbld', 15:24:53 INFO - 'LANG': 'en_US.UTF-8', 15:24:53 INFO - 'LANGUAGE': 'en_US:en', 15:24:53 INFO - 'LOGNAME': 'cltbld', 15:24:53 INFO - 'MAIL': '/var/mail/cltbld', 15:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:53 INFO - 'MOZ_NO_REMOTE': '1', 15:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:53 INFO - 'NO_EM_RESTART': '1', 15:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:53 INFO - 'PWD': '/builds/slave/test', 15:24:53 INFO - 'SHELL': '/bin/bash', 15:24:53 INFO - 'SHLVL': '1', 15:24:53 INFO - 'TERM': 'linux', 15:24:53 INFO - 'TMOUT': '86400', 15:24:53 INFO - 'USER': 'cltbld', 15:24:53 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:53 INFO - '_': '/tools/buildbot/bin/python'} 15:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:24:55 INFO - Installing collected packages: mozsystemmonitor 15:24:55 INFO - Running setup.py install for mozsystemmonitor 15:24:56 INFO - Successfully installed mozsystemmonitor 15:24:56 INFO - Cleaning up... 15:24:56 INFO - Return code: 0 15:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:56 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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:24:56 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 15:24:56 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 15:24:56 INFO - Using env: {'DISPLAY': ':0', 15:24:56 INFO - 'HOME': '/home/cltbld', 15:24:56 INFO - 'LANG': 'en_US.UTF-8', 15:24:56 INFO - 'LANGUAGE': 'en_US:en', 15:24:56 INFO - 'LOGNAME': 'cltbld', 15:24:56 INFO - 'MAIL': '/var/mail/cltbld', 15:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:56 INFO - 'MOZ_NO_REMOTE': '1', 15:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:56 INFO - 'NO_EM_RESTART': '1', 15:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:56 INFO - 'PWD': '/builds/slave/test', 15:24:56 INFO - 'SHELL': '/bin/bash', 15:24:56 INFO - 'SHLVL': '1', 15:24:56 INFO - 'TERM': 'linux', 15:24:56 INFO - 'TMOUT': '86400', 15:24:56 INFO - 'USER': 'cltbld', 15:24:56 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:56 INFO - '_': '/tools/buildbot/bin/python'} 15:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:56 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 15:24:56 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 15:24:56 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 15:24:56 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 15:24:56 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 15:24:56 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 15:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 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 15:24:58 INFO - Downloading docopt-0.6.1.tar.gz 15:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:58 INFO - Running setup.py install for blobuploader 15:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:59 INFO - Running setup.py install for requests 15:24:59 INFO - Running setup.py install for docopt 15:24:59 INFO - Successfully installed blobuploader requests docopt 15:24:59 INFO - Cleaning up... 15:24:59 INFO - Return code: 0 15:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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')]} 15:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:59 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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:24:59 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 15:24:59 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 15:24:59 INFO - Using env: {'DISPLAY': ':0', 15:24:59 INFO - 'HOME': '/home/cltbld', 15:24:59 INFO - 'LANG': 'en_US.UTF-8', 15:24:59 INFO - 'LANGUAGE': 'en_US:en', 15:24:59 INFO - 'LOGNAME': 'cltbld', 15:24:59 INFO - 'MAIL': '/var/mail/cltbld', 15:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:59 INFO - 'MOZ_NO_REMOTE': '1', 15:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:59 INFO - 'NO_EM_RESTART': '1', 15:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:59 INFO - 'PWD': '/builds/slave/test', 15:24:59 INFO - 'SHELL': '/bin/bash', 15:24:59 INFO - 'SHLVL': '1', 15:24:59 INFO - 'TERM': 'linux', 15:24:59 INFO - 'TMOUT': '86400', 15:24:59 INFO - 'USER': 'cltbld', 15:24:59 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:59 INFO - '_': '/tools/buildbot/bin/python'} 15:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:59 INFO - Running setup.py (path:/tmp/pip-vv91ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:59 INFO - Running setup.py (path:/tmp/pip-Q2GSQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:59 INFO - Running setup.py (path:/tmp/pip-5gGxCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:59 INFO - Running setup.py (path:/tmp/pip-8VFjz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:00 INFO - Running setup.py (path:/tmp/pip-glXJcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:00 INFO - Running setup.py (path:/tmp/pip-BNoT9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:00 INFO - Running setup.py (path:/tmp/pip-4iYZWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:00 INFO - Running setup.py (path:/tmp/pip-L_EXgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:00 INFO - Running setup.py (path:/tmp/pip-N74_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:00 INFO - Running setup.py (path:/tmp/pip-i_DCQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:00 INFO - Running setup.py (path:/tmp/pip-Z4oRQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:00 INFO - Running setup.py (path:/tmp/pip-v7OYhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:00 INFO - Running setup.py (path:/tmp/pip-gEaeOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:00 INFO - Running setup.py (path:/tmp/pip-CQU3ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:00 INFO - Running setup.py (path:/tmp/pip-ssjw9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:00 INFO - Running setup.py (path:/tmp/pip-cM9K3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:00 INFO - Running setup.py (path:/tmp/pip-4PLsvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:00 INFO - Running setup.py install for manifestparser 15:25:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozcrash 15:25:01 INFO - Running setup.py install for mozdebug 15:25:01 INFO - Running setup.py install for mozdevice 15:25:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozfile 15:25:01 INFO - Running setup.py install for mozhttpd 15:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozinfo 15:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozInstall 15:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozleak 15:25:01 INFO - Running setup.py install for mozlog 15:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for moznetwork 15:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozprocess 15:25:02 INFO - Running setup.py install for mozprofile 15:25:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozrunner 15:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozscreenshot 15:25:02 INFO - Running setup.py install for moztest 15:25:02 INFO - Running setup.py install for mozversion 15:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:02 INFO - Cleaning up... 15:25:02 INFO - Return code: 0 15:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:02 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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:25:02 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 15:25:02 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 15:25:02 INFO - Using env: {'DISPLAY': ':0', 15:25:02 INFO - 'HOME': '/home/cltbld', 15:25:02 INFO - 'LANG': 'en_US.UTF-8', 15:25:02 INFO - 'LANGUAGE': 'en_US:en', 15:25:02 INFO - 'LOGNAME': 'cltbld', 15:25:02 INFO - 'MAIL': '/var/mail/cltbld', 15:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:02 INFO - 'MOZ_NO_REMOTE': '1', 15:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:02 INFO - 'NO_EM_RESTART': '1', 15:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:02 INFO - 'PWD': '/builds/slave/test', 15:25:02 INFO - 'SHELL': '/bin/bash', 15:25:02 INFO - 'SHLVL': '1', 15:25:02 INFO - 'TERM': 'linux', 15:25:02 INFO - 'TMOUT': '86400', 15:25:02 INFO - 'USER': 'cltbld', 15:25:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:02 INFO - '_': '/tools/buildbot/bin/python'} 15:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:02 INFO - Running setup.py (path:/tmp/pip-NyVk5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:03 INFO - Running setup.py (path:/tmp/pip-LQbQBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:03 INFO - Running setup.py (path:/tmp/pip-M0LB3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:03 INFO - Running setup.py (path:/tmp/pip-fYuw2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:03 INFO - Running setup.py (path:/tmp/pip-KUWALA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:03 INFO - Running setup.py (path:/tmp/pip-Jw0iZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:03 INFO - Running setup.py (path:/tmp/pip-EnyYtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:03 INFO - Running setup.py (path:/tmp/pip-usLjFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:03 INFO - Running setup.py (path:/tmp/pip-KTUeY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:03 INFO - Running setup.py (path:/tmp/pip-1eMxXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:03 INFO - Running setup.py (path:/tmp/pip-gY3SDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:03 INFO - Running setup.py (path:/tmp/pip-5RLqJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:03 INFO - Running setup.py (path:/tmp/pip-WDmzwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:03 INFO - Running setup.py (path:/tmp/pip-M9rBDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:03 INFO - Running setup.py (path:/tmp/pip-SDJhfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:04 INFO - Running setup.py (path:/tmp/pip-TgqOMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:04 INFO - Running setup.py (path:/tmp/pip-kHM6yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:04 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)) 15:25:04 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)) 15:25:04 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)) 15:25:04 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)) 15:25:04 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)) 15:25:04 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)) 15:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:06 INFO - Downloading blessings-1.6.tar.gz 15:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:06 INFO - Installing collected packages: blessings 15:25:06 INFO - Running setup.py install for blessings 15:25:06 INFO - Successfully installed blessings 15:25:06 INFO - Cleaning up... 15:25:06 INFO - Return code: 0 15:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:06 INFO - Reading from file tmpfile_stdout 15:25:06 INFO - Current package versions: 15:25:06 INFO - argparse == 1.2.1 15:25:06 INFO - blessings == 1.6 15:25:06 INFO - blobuploader == 1.2.4 15:25:06 INFO - docopt == 0.6.1 15:25:06 INFO - manifestparser == 1.1 15:25:06 INFO - mozInstall == 1.12 15:25:06 INFO - mozcrash == 0.17 15:25:06 INFO - mozdebug == 0.1 15:25:06 INFO - mozdevice == 0.48 15:25:06 INFO - mozfile == 1.2 15:25:06 INFO - mozhttpd == 0.7 15:25:06 INFO - mozinfo == 0.9 15:25:06 INFO - mozleak == 0.1 15:25:06 INFO - mozlog == 3.1 15:25:06 INFO - moznetwork == 0.27 15:25:06 INFO - mozprocess == 0.22 15:25:06 INFO - mozprofile == 0.28 15:25:06 INFO - mozrunner == 6.11 15:25:06 INFO - mozscreenshot == 0.1 15:25:06 INFO - mozsystemmonitor == 0.0 15:25:06 INFO - moztest == 0.7 15:25:06 INFO - mozversion == 1.4 15:25:06 INFO - psutil == 3.1.1 15:25:06 INFO - requests == 1.2.3 15:25:06 INFO - wsgiref == 0.1.2 15:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:06 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 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:25:06 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 15:25:06 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 15:25:06 INFO - Using env: {'DISPLAY': ':0', 15:25:06 INFO - 'HOME': '/home/cltbld', 15:25:06 INFO - 'LANG': 'en_US.UTF-8', 15:25:06 INFO - 'LANGUAGE': 'en_US:en', 15:25:06 INFO - 'LOGNAME': 'cltbld', 15:25:06 INFO - 'MAIL': '/var/mail/cltbld', 15:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:06 INFO - 'MOZ_NO_REMOTE': '1', 15:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:06 INFO - 'NO_EM_RESTART': '1', 15:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:06 INFO - 'PWD': '/builds/slave/test', 15:25:06 INFO - 'SHELL': '/bin/bash', 15:25:06 INFO - 'SHLVL': '1', 15:25:06 INFO - 'TERM': 'linux', 15:25:06 INFO - 'TMOUT': '86400', 15:25:06 INFO - 'USER': 'cltbld', 15:25:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:06 INFO - '_': '/tools/buildbot/bin/python'} 15:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 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)) 15:25:06 INFO - Cleaning up... 15:25:06 INFO - Return code: 0 15:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:25:06 INFO - Using env: {'DISPLAY': ':0', 15:25:06 INFO - 'HOME': '/home/cltbld', 15:25:06 INFO - 'LANG': 'en_US.UTF-8', 15:25:06 INFO - 'LANGUAGE': 'en_US:en', 15:25:06 INFO - 'LOGNAME': 'cltbld', 15:25:06 INFO - 'MAIL': '/var/mail/cltbld', 15:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:06 INFO - 'MOZ_NO_REMOTE': '1', 15:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:06 INFO - 'NO_EM_RESTART': '1', 15:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:06 INFO - 'PWD': '/builds/slave/test', 15:25:06 INFO - 'SHELL': '/bin/bash', 15:25:06 INFO - 'SHLVL': '1', 15:25:06 INFO - 'TERM': 'linux', 15:25:06 INFO - 'TMOUT': '86400', 15:25:06 INFO - 'USER': 'cltbld', 15:25:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:06 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:07 INFO - Downloading/unpacking jsonschema 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:09 INFO - warning: no files found matching '*.txt' 15:25:09 INFO - no previously-included directories found matching 'build' 15:25:09 INFO - no previously-included directories found matching 'dist' 15:25:09 INFO - no previously-included directories found matching '.git*' 15:25:09 INFO - Installing collected packages: jsonschema, functools32 15:25:09 INFO - Running setup.py install for functools32 15:25:09 INFO - warning: no files found matching '*.txt' 15:25:09 INFO - no previously-included directories found matching 'build' 15:25:09 INFO - no previously-included directories found matching 'dist' 15:25:09 INFO - no previously-included directories found matching '.git*' 15:25:09 INFO - Successfully installed jsonschema functools32 15:25:09 INFO - Cleaning up... 15:25:09 INFO - Return code: 0 15:25:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1655a93f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', '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 15:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:25:09 INFO - Using env: {'DISPLAY': ':0', 15:25:09 INFO - 'HOME': '/home/cltbld', 15:25:09 INFO - 'LANG': 'en_US.UTF-8', 15:25:09 INFO - 'LANGUAGE': 'en_US:en', 15:25:09 INFO - 'LOGNAME': 'cltbld', 15:25:09 INFO - 'MAIL': '/var/mail/cltbld', 15:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:09 INFO - 'MOZ_NO_REMOTE': '1', 15:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:09 INFO - 'NO_EM_RESTART': '1', 15:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:09 INFO - 'PWD': '/builds/slave/test', 15:25:09 INFO - 'SHELL': '/bin/bash', 15:25:09 INFO - 'SHLVL': '1', 15:25:09 INFO - 'TERM': 'linux', 15:25:09 INFO - 'TMOUT': '86400', 15:25:09 INFO - 'USER': 'cltbld', 15:25:09 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:09 INFO - '_': '/tools/buildbot/bin/python'} 15:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:09 INFO - Downloading/unpacking flake8 15:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:25:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:25:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:12 INFO - no previously-included directories found matching 'docs/_build' 15:25:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:25:12 INFO - Running setup.py install for pep8 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:12 INFO - no previously-included directories found matching 'docs/_build' 15:25:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:25:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:25:12 INFO - Cleaning up... 15:25:12 INFO - Return code: 0 15:25:12 INFO - Running post-action listener: _resource_record_post_action 15:25:12 INFO - Running post-action listener: _start_resource_monitoring 15:25:12 INFO - Starting resource monitoring. 15:25:12 INFO - ##### 15:25:12 INFO - ##### Finished create-virtualenv step (success) 15:25:12 INFO - ##### 15:25:12 INFO - ##### 15:25:12 INFO - ##### Running install step. 15:25:12 INFO - ##### 15:25:12 INFO - Running pre-action listener: _resource_record_pre_action 15:25:12 INFO - Running main action method: install 15:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:12 INFO - Reading from file tmpfile_stdout 15:25:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:12 INFO - Reading from file tmpfile_stdout 15:25:12 INFO - Output received: 15:25:12 INFO - Usage: mozinstall [options] installer 15:25:12 INFO - Options: 15:25:12 INFO - -h, --help show this help message and exit 15:25:12 INFO - -d DEST, --destination=DEST 15:25:12 INFO - Directory to install application into. [default: 15:25:12 INFO - "/builds/slave/test"] 15:25:12 INFO - --app=APP Application being installed. [default: firefox] 15:25:12 INFO - mkdir: /builds/slave/test/build/application 15:25:12 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'] 15:25:12 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 15:25:28 INFO - Reading from file tmpfile_stdout 15:25:28 INFO - Output received: 15:25:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:28 INFO - Running post-action listener: _resource_record_post_action 15:25:28 INFO - ##### 15:25:28 INFO - ##### Finished install step (success) 15:25:28 INFO - ##### 15:25:28 INFO - ##### 15:25:28 INFO - ##### Running run-tests step. 15:25:28 INFO - ##### 15:25:28 INFO - Running pre-action listener: _resource_record_pre_action 15:25:28 INFO - Running main action method: run_tests 15:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:28 INFO - Python 2.7.3 15:25:28 INFO - Return code: 0 15:25:28 INFO - grabbing minidump binary from tooltool 15:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:28 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 0x2897410>, '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 0x2898310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:28 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 15:25:28 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 15:25:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:28 INFO - Return code: 0 15:25:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:25:29 INFO - Return code: 0 15:25:29 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/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 15:25:29 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/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 15:25:29 INFO - Using env: {'DISPLAY': ':0', 15:25:29 INFO - 'HOME': '/home/cltbld', 15:25:29 INFO - 'LANG': 'en_US.UTF-8', 15:25:29 INFO - 'LANGUAGE': 'en_US:en', 15:25:29 INFO - 'LOGNAME': 'cltbld', 15:25:29 INFO - 'MAIL': '/var/mail/cltbld', 15:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:29 INFO - 'MOZ_NO_REMOTE': '1', 15:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:29 INFO - 'NO_EM_RESTART': '1', 15:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:29 INFO - 'PWD': '/builds/slave/test', 15:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:29 INFO - 'SHELL': '/bin/bash', 15:25:29 INFO - 'SHLVL': '1', 15:25:29 INFO - 'TERM': 'linux', 15:25:29 INFO - 'TMOUT': '86400', 15:25:29 INFO - 'USER': 'cltbld', 15:25:29 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117', 15:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:29 INFO - '_': '/tools/buildbot/bin/python'} 15:25:29 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/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 15:25:29 INFO - mozversion application_buildid: 20160506135800 15:25:29 INFO - mozversion application_changeset: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 15:25:29 INFO - mozversion application_display_name: Nightly 15:25:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:29 INFO - mozversion application_name: Firefox 15:25:29 INFO - mozversion application_remotingname: firefox 15:25:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:25:29 INFO - mozversion application_vendor: Mozilla 15:25:29 INFO - mozversion application_version: 49.0a1 15:25:29 INFO - mozversion platform_buildid: 20160506135800 15:25:29 INFO - mozversion platform_changeset: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 15:25:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:25:29 INFO - mozversion platform_version: 49.0a1 15:25:29 INFO - using testdate: 1462573529 15:25:29 INFO - actual date: 1462573529 15:25:29 INFO - starting webserver on 'localhost:59269' 15:25:29 INFO - SUITE-START | Running 2 tests 15:25:29 INFO - TEST-START | dromaeo_css 15:25:29 INFO - operating with platform_type : linux_ 15:25:29 INFO - Initialising browser for dromaeo_css test... 15:25:29 INFO - TEST-INFO | started process 20437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn67SW9/profile http://localhost:59269/getInfo.html) 15:25:34 INFO - PROCESS | 20437 | __metrics Screen width/height:1600/1200 15:25:34 INFO - PROCESS | 20437 | colorDepth:24 15:25:34 INFO - PROCESS | 20437 | Browser inner width/height: 1024/697 15:25:34 INFO - PROCESS | 20437 | __metrics 15:25:35 ERROR - PROCESS | 20437 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:25:35 INFO - TEST-INFO | 20437: exit 0 15:25:35 INFO - Browser initialized. 15:25:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:35 INFO - TEST-INFO | started process 20518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn67SW9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:47 INFO - PROCESS | 20518 | RSS: Main: 154501120 15:25:47 INFO - PROCESS | 20518 | 15:26:39 INFO - PROCESS | 20518 | 1462573599439 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] 15:28:51 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59269/tests/dromaeo/cssquery-ext.html) 15:28:52 INFO - PROCESS | 20518 | RSS: Main: 264056832 15:28:52 INFO - PROCESS | 20518 | 15:31:55 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-ext.html (next: http://localhost:59269/tests/dromaeo/cssquery-jquery.html) 15:31:55 INFO - PROCESS | 20518 | RSS: Main: 237916160 15:31:55 INFO - PROCESS | 20518 | 15:34:57 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59269/tests/dromaeo/cssquery-mootools.html) 15:34:58 INFO - PROCESS | 20518 | RSS: Main: 231661568 15:34:58 INFO - PROCESS | 20518 | 15:38:00 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59269/tests/dromaeo/cssquery-prototype.html) 15:38:01 INFO - PROCESS | 20518 | RSS: Main: 231714816 15:38:01 INFO - PROCESS | 20518 | 15:41:04 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59269/tests/dromaeo/cssquery-yui.html) 15:41:05 INFO - PROCESS | 20518 | RSS: Main: 194789376 15:41:05 INFO - PROCESS | 20518 | 15:44:07 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:59269/tests/dromaeo/cssquery-yui.html (next: http://localhost:59269/tests/dromaeo/cssquery-dojo.html) 15:44:08 INFO - PROCESS | 20518 | RSS: Main: 268079104 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | __start_tp_report 15:44:08 INFO - PROCESS | 20518 | _x_x_mozilla_page_load 15:44:08 INFO - PROCESS | 20518 | _x_x_mozilla_page_load_details 15:44:08 INFO - PROCESS | 20518 | |i|pagename|runs| 15:44:08 INFO - PROCESS | 20518 | |0;dojo.html;2615.7907367410608;2642.6036094585797;2663.3741070848355;2678.1563807400667;2681.3296675831043;4555.362249285103;4619.237825758746;4668.276417155342;4727.8108875644975;4785.899243174068;4698.3422320875015;4738.407699037621;4761.857144285668;4766.285057241415;4780.450248221456;4335.631471324933;4375.562443755615;4414.271645178542;4437.068215674696;4517.435320584927;4432.423784907957;4473.507914129443;4484.148011877749;4486.416765820455;4518.367428560005;4304.97847510762;4338.392625032498;4353.36876152956;4367.497737760166;4381.38660587518;4353.25994580922;4382.035952090535;4383.254846676073;4423.668224883115;4430.512643609232;4395.142947125312;4408.14041261954;4413.117376524708;4419.558044195587;4454.109178164348;4503.617192538605;4572.359869618256;4624.653151013654;4641.0949864776385;4677.111348843709;5054.91319366338;5081.466446023152;5107.719075450848;5112.36095488064;5121.129408000612;5110.923336149961;5111.08000559899;5138.2549530318265;5148.124818780779;5151.6908985461;4614.5385461453925;4648.790804413809;4668.743219122981;4674.813007479731;4706.458757242961;5114.744262786846;5143.202803565453;5158.458361872024;5166.225066240094;5168.8966220675375;4948.05986862495;4953.90092198154;4954.752262386866;4957.281194226817;4960.082384758831;4987.376577927759;4988.077205716954;5015.3730783652045;5029.471905449948;5031.622628302892;4983.352164218701;4983.626228032912;4986.4514903360605;4988.426330971912;5033.546980771748;4878.853634390974;4969.751512424436;4977.377827771528;4980.701157930535;5032.47159048302;4296.205202037633;4308.224519586504;4341.761203133858;4381.474223093249;4396.120775844844;3728.8135593220773;3731.160488889978;3735.6451137141926;3769.4157405602177;3776.773393596338;4325.3728209409455;4328.372386004012;4328.696991210585;4366.410534577855;4373.169097871394;5002.74986250686;5019.623528235397;5033.697978121324;5075.441701412841;5093.541581257705;4404.977975110104;4407.735535867858;4430.158269928703;4443.400140980991;4454.732716037048;4633.443986721615;4636.327732478839;4641.512641172696;4642.46611639659;4688.71867687933;4563.2242518772555;4717.669763116549;4721.811127554859;4756.762161891961;4760.952390476051;5125.5899528036925;5132.563732082665;5133.358330208724;5136.383633963799;5170.0952333340765;4776.9761151194025;4779.641526885428;4782.450018247946;4784.378030856105;4816.060868130681;4854.854354369375;4907;4943;4951.10880041596;5088.135017047185;5041.143005689115;5057.064443078042;5057.69653820772;5060.772265247999;5101.846944591668;4907.509249075064;4911.361523001987;4911.656184067081;4913.77887995034;4949.1586430306215;4802;4878.390201224847;4894.510548945077;4928.556429921325;4957.033378491304;4848.369711937426;4882.2432522959;4882.975585122052;4910.43529994041;4924.03981223658;4962.181240095344;4965.4786247444945;4973.403191617029;5009.323741294878;5020.899582008266;4740.786664600032;4758.714477131383;4826.7827947743135;4829.372181616508;4844.757762111951 15:44:08 INFO - PROCESS | 20518 | |1;ext.html;584.5265335078586;608.3794529579832;608.4371955940757;610.0513701194643;628.3841835001698;28260.717392826067;43026.35460468096;44342.33486497705;44394.33408498875;48244.51755482453;44089.11821763563;44337.77831110848;44493.55506444935;44511;44672.776636116774;7560.546367217957;7938.126806051344;8084.4639518491595;9688;9985.500724963758;10114.2414318926;10217.693469195936;10224.795504089914;10225;10232.43721595312;10219.284650074498;10262.538185781657;10265.897341026568;10269.64056258031;10277.691669249934;7647.655855486517;9976.102150806462;10241.948790256076;10246.692599222035;10650.840237396445;10145.492725363776;10205.285630005903;10210.744731381701;10211.132053775364;10213.438260895648;39765.40351894724;39790.80104599459;40018;40020.39969400461;40308;3379.4761811918947;3384.272381438003;3404.931901361959;3461.6365281645317;3702.7037836972977;29996.400071998654;30692;30742.538861917088;30977.380452390826;31655;3384.4415671414185;3401.183715908189;3426.8286585670617;3441.7590768646205;3515.771474854152;256140;256991;257073;257613;257617;33793.32413351719;57403.1389529149;57909;57989.42010579925;57995;33992.49011264833;36518.634813652054;36652.083697907765;36679.81660091736;36706.26587468289;11794.52821887115;13372.46510139603;13391.665208369868;13417.463301467831;13436.529721459701;11135.665930022113;11391.715207119723;11428.428578571038;11782.88217117835;11788.115891308185;8466.365022623204;8478.321734261244;8481.151884811592;8544.74365769028;8560;3256.169676732418;3285.967140328614;3335.71646410053;3343.7993720376853;3351.815650139217;942.0673533202081;958.2477754962321;1018.6383833738915;1061.0768631290825;1096.13405409727;29572;29910.25224369408;29920.401591968475;30085.69914300873;30480.237994050327;1045.513836066233;1050.2070936442938;1065.5258410007473;1075.8655168103987;1096.31480324797;15354.616134596725;15771.763423548657;15868.20658967047;15868.285927133307;16109.516714498584;389044;393241;393250;394070;394623;52037.2194417084;52439.21341179885;52473.73763131236;52493;52509;1146.134668325409;1269.6889262130653;1299.6094179228323;1341.463414634154;1341.6981179234594;29145.417091658474;30683.232919176306;30772.230694232825;30911;31061.223469413446;44519.332210016226;44735;45227.09545809131;45303.54696453125;45315.32027019531;281051;282036;282395;283128;283186;22743.203987860346;23286.507023946542;23443.179488717815;23661.763382365956;24622.876885615457;43691.78154109209;43863.78068109639;44252.336214957446;44771.77614111909;45136.322955156356;37739;37788.81105594454;38596.22807543777;38864;39808.60191398165;38983.610163897996;39266;40076.39885401663;40237;40389;38742.418863716506;38808.41787373135;39243.41134882922;39458;39497.60502395054;34194.316113678084;35409.29181416409;35481.82259088688;35670.108247292985;35798;24917.50164996726;25184.74815251824;25459;25484.362890927874;25684.229473115836 15:44:08 INFO - PROCESS | 20518 | |2;jquery.html;377.27374803503255;380.6326894546762;381.85298660015894;390.6679322575809;399.3510545363784;16009.83990160098;17312.394066207686;17994.820051799477;18142.546436339097;18149.183286752093;16657.83342166578;16848.32606695734;17465.388711395102;17476.388326408578;17573.472795816146;5173.6119791015635;5275.6043296752705;5285.392179899303;5313.282706834586;5372.382176049746;3711.498947642074;3913.021744563859;5763.308402991647;6062.999605065159;6092.786752463642;5909.084091965752;6097.664628445434;6108.236470441195;6133.386661333853;6148.723307451175;6126.571140020223;6140.600860944024;6168.96915515424;6184.752609895599;6196.4113409226275;3381.425157723193;4990.30135780991;5301.257823904656;5318.25544423781;5384.515393614554;20476.795232047785;20493.4876628084;20805.791942080687;21110.788892111188;21128.89435552828;2148.022649694385;2168.7963180434854;2252.9098836046537;2414.9637755433682;2500.8999640014376;12940.417681204368;13179.341032948314;13308.06843520954;13312.267825269606;13643.727125457535;1797.2002458905793;1844.631073785235;1860.6185731924922;1886.1795119123226;1931.5364312565023;67185;67317.66341168263;67792;68685.9999999995;69569;9511.66709165176;9753.512324383895;9878.209743220525;9921.702348929544;10105.595776169019;13516.797248041286;13574.86425135736;13722.794158087636;13723.45106195741;13741.24423156736;7069.575825450489;7590.127135379502;7677.30904218623;7713.151553329241;7726.497777644435;7321.816954576178;7368.226336234726;7471.215522370181;7477.401807855358;7589.620518974029;6082.635041897501;6228.532860035515;6231.40801623845;6237.812865614039;6302.243730752248;1665.4087798831483;1712.1524845201704;1813.238439855264;1814.7187185986193;1848.4731851422548;864.1444969480295;913.118840319082;964.286428043243;986.330849240823;1009.485162567096;16555.50333489997;16846.747298790528;16881.83118168827;17132.229049692793;17527.82472175262;931.380631879806;950.5912457643142;953.5184731710442;954.8949615542285;1028.7685270814156;9989.771735062992;10110.342827716175;10222.795544089076;10240.385576865412;10325.9483702581;335931;341045;343556;345068;346130;66077;68170.3182968164;69763;69837.30162698308;70440.64779676069;1000.1198944928417;1003.4430890855646;1004.2969921055291;1005.969820905374;1036.6268143468346;15256.923715381352;15298.388064477296;15439.150846703538;15476.613084672974;15770.526884193492;32931.34137317288;32937.17657058593;33346.66653333532;33758.83120584382;33890.66109338875;44819.77590112029;45343.546564533935;45474.54525454703;45575.31637025514;46082.76958615185;7622.8094297643;7636.923630763621;7639.121501027231;7642.426817988562;7751.224877512203;9109.908900910907;9128.497932613504;11961.102917281065;11985.161038727205;12275.263484190977;9991.600335986479;10195.949020254851;10568.524416401435;10628.41543715103;10720.303180293256;10900.890991089987;10948.56205751761;11095.611653592408;11102.056325212447;11178.27341222818;10994.835077473685;11063.668089957315;11116.499757511094;11148.163887708291;11338.629741239954;6536.509761767791;7008.824779380557;7120.323569260912;7819.882701759364;7999.800004999689;8566.357523185661;10614.89385106139;10776.515056822618;10861.239713220315;10895.509702063584 15:44:08 INFO - PROCESS | 20518 | |3;mootools.html;1294.2040645003315;1506.1640789361902;1518.8405217452168;1711.7346811244254;1880.5768702042042;6613.636250006254;7474.215207403219;7700.268474494928;7700.4609677322605;7922.564258965755;7676.1939996300425;7806.063272407319;7826.1391246962785;7827.178146294643;7829.882551761728;1840.0707642640448;1895.8578106641987;1895.924163033477;2190.277208521188;2223.2329846203033;1956.5402130499322;2131.56302957894;2207.87856667884;2208.4920468292303;2233.4081468410805;2182.476205710634;2218.7004754358118;2219.411855858199;2223.1996481266733;2227.187076716995;1817.3820900893759;2194.36363454598;2199.538096999632;2202.2402271216406;2206.2388475975763;2131.914723411062;2207.9779202207933;2209.1053123484853;2234.0728597631964;2237.686723858661;7699.345555627779;7740.496867703638;7752.728654497122;7753.147153813076;7756.4182686298755;4425.734455932622;4559.6580256480565;4573.474050484204;4578.679492435531;4583.541645835423;2619.410632607667;2707.82399144055;2852.700466451034;2857.3713782967716;2870.052882548754;880.7930136417937;898.5956319656116;907.9182873541347;908.8000639859221;909.5543183839937;10605.628802991936;10612.893871061267;10614.416207108607;10620.415877126832;10653.147748180205;4050.2709512287483;4159.459270294903;4198.811053502539;4252.617264446215;4279;9001.63993440255;9078.954605226932;9080.954595226982;9082.954585227031;9083.545822708838;4393.714408563433;4397.31841564558;4423.181711383404;4423.889402764957;4429.579189976947;3677.1358730698266;3822.980885095557;4016.638502534786;4082.510098788105;4104.507459104867;3627.782333060025;3698.556173259226;3759.2293579816073;3760.6803421708914;3764;1189.821526770974;1205.457544105156;1209.4436559182875;1216.4525963316544;1228.238492134882;774.7559518751575;882.5102068352127;882.9249513791272;936.0171819589403;943.4947083766164;5299.708516031656;5304.92042619361;5326.334208223972;5405.837824865261;5483.7806487740045;392.31736778006064;406.14709110866943;407.0231444533144;407.83278855669624;415.14065883620617;3662.1393972416463;3694.427363758568;4000.8399664013114;4009.578994205625;4062.1875624875142;9162.587683554257;9607.375520591138;9713.611455541699;9743.366681165702;9767.902320976842;9341.299402544837;9571.473568953636;9573.712788616353;9575.281853860988;9647.662331818352;6872.209695884937;7020.719171233196;7107.609081500567;7166.426685865118;7194.424446044409;5063.772130254074;5296.841094767163;5363.812266570651;5365.436629154039;5427.864303392446;8600.78498037554;8857.778555536162;8910.55447227623;8917.464952102895;8997.505137217517;8857.557122143739;8887.688930887389;8954.194122529003;9034.412763170372;9075.591598378222;6563.835904102436;7203.675834587351;7344.339009489172;7427.368673662799;7454.440916931143;7566.470347075652;7621.237876212334;7691.884621730566;7696.153423123564;7705.499142555716;6593.934060659332;6839.589624622538;6918.377346038881;6970.163580370388;7030.543014704028;6660.666966651551;6670;6670.199576050905;6757.493188011017;6760.121184246016;6351.460125889166;6403.103565500741;6496.252930913006;6507.577007494498;6575.4410875076155;4626.514216007271;4635.65232607549;4638.165130276582;4683.812647494062;4765.070811191923;4644.117617652635;4720.740359280273;4731.313959475926;4819.373481447389;4827.61379089679 15:44:08 INFO - PROCESS | 20518 | |4;prototype.html;301.61995885184666;306.99612267884004;310.82438422291403;317.41912300490105;323.40977715668896;4780.569748722614;4787.688800227983;4794.784234709442;4812.614990800736;4838.709677419353;4778.80884764609;4791.496892826247;4811.951880481194;4814.66297359185;4816.83141090062;3834.2714884172055;3836.386178211487;3840.4431357453154;3850.8652197173105;3879.1465877506903;3865.3042452358563;3870.845166193363;3871.922561548767;3878.747881387715;3906.5312162540395;3546.982265088671;3751.6177227460485;3756.455313979471;3819.4461803038544;3821.9617803822025;3718.442233664945;3720.3861362875364;3745.5318085239346;3760.64273893981;3764.3036038333;3313.5361049453095;3317.9834100829585;3324.900252992414;3328.400887840188;3328.567286252796;4578.260261100793;4589.334546490773;4603.378543896598;4620.653450991155;4621.7920193591035;4139.730917490354;4267.359896015591;4278.165757677254;4288.635465985395;4294.871153865358;4967.981563779453;4970.502949705036;4991.650584459089;5010.298558201855;5021.472745361721;3630;3634.872779452733;3638.181409182913;3642.4354225095153;3647.689946354563;5057.241413787924;5209.765560549784;5229.869253268661;5267;5281.234221037967;3658.2866341063236;3680.2639472105684;3696.537932758405;3700.6114357992024;3706.683322923173;3743.887683369503;3747.4004159334922;3750.868719594801;3768.3217020936495;3778.5843557208686;4211.36829475575;4223.809928553223;4247.384129301234;4249.766262855511;4283.378910058024;4752.334673145762;5032.446430892599;5037.924431133536;5045.873853153627;5057.974710126426;1254.2725219372924;1263.993680031594;1265.2029221590524;1273.2996851731511;1278.2905487454552;832.9666813327399;861.646724842824;862.1206369503071;872.4895935877582;874.8687696845524;4298.247806633889;4362.716423432466;4372.846950356722;4390.297552391602;4396.318570621559;5028.924566131511;5089.338386009869;5096.464871188546;5109.492699653611;5118.539331460112;4273.615374616299;4281.250781113293;4319.956800432018;4378.759168245713;4386.758728269976;2565.679290088739;2659.9069032584152;2682.731726827302;2737.1925282041843;2740.986295068512;4692.3722715279555;4743.905121897543;4756.286557016475;4763.285507173951;4765.880852978703;5080.491950804964;5099.311592934981;5152.170979302368;5166.405863325691;5172.948270517322;4492.505824359318;4844.103840789465;4848.739327774804;4872.731999740048;4884.8290309838985;5174.456682048331;5179.948200517946;5204.81397812927;5210.97394513025;5211.332373640399;4890.951090489192;4941.654084214214;5086.338775959101;5114.232865070269;5141.974290128525;4859.829905953275;4862.541237628768;4864.781084851261;4870.488598697086;4874.757611498609;3661.6338366164237;3665.633436656313;3686.336459437327;3692.1138926657945;3692.538432695913;5186.196139598368;5186.714730689849;5192.818251361336;5195.298634684269;5197.974010129925;5002.349694539686;5005.274235235943;5033.421156567042;5038.649298216645;5043.319151914445;4777.7372244525495;4855.223164293838;4863.854084377333;4920.360353154067;4934.667639737323;4709.576138147583;4877.29279254499;4956.900861982812;4967.528084831935;4969.1800852860315;4934.432540257772;4993.2510123480315;5010.799568017239;5050.116229659869;5075.28945947575;4694.882627934329;4934.5312195341385;4945.777440015136;4960.181570040902;4973.179425394914 15:44:08 INFO - PROCESS | 20518 | |5;yui.html;706.1702499563015;758.3932853717022;760.6843160088557;760.6881178716726;802.0896282719114;11583.247088939213;12281.263124212554;12283.14018018739;12294.877051229485;12329.568465103723;12685.302308373035;12739.554115605932;12760.23438593685;12761.680957976056;12765.042621803355;672.9192496900355;829.5354601423193;859.6389516403094;861.4486728493769;865.2688478235881;825.2696363718122;828.6395417993162;829.2246749289403;830.730012745857;831.3141658132065;714.1715609892526;917.8531434970406;919.2691810011057;920.2775820980531;920.7191806499015;726.12501935168;728.7813655903234;859.6647307550061;892.1702816380763;894.0790985285166;665.8701553197128;665.8901281288581;665.8967859981663;668.6289109544201;668.6456178225549;11789.646310610695;11805.881941180563;11826.408679565988;11838.230515016583;11856.525738970431;12148.939255303667;12573.308468034254;12648.557300494438;12860.549880754223;12862.935685321607;11018.669439916815;11151.888481115247;11436.885631143665;11458.541658333657;11813.763724725542;4151.584841515854;4206.537280899099;4209.684273679486;4254.553271906467;4307.569243075699;43562.56437435617;43930.780346098385;44203.33694994578;44265;44627.77686111549;9803.264755143393;10426.478676066166;10524.05283524471;10586.735331616617;10608;16768.245428955724;17469.65060698804;17535.64928701419;17571;17654.764166508223;6636.767713130017;6734.46124310054;6762.966185169141;6938.5836849789175;7014;3723.404255319136;3757.530308711411;3818.8090595470117;3865.613438656112;3901.8244179012013;2796.9300767480977;2873.8563071846324;2882.567614857788;2888.0180738548993;2889.5954566360724;493.81728760358897;502.6581924291444;518.3960685801075;524.2686452398882;527.8759491519489;510.5864249957546;526.7866514061811;625.7841044839523;658.0984051848902;659.6009414304373;7958.403119766041;8194.672213111528;8300.176227728174;8362.289205417608;8415.789605259795;521.9634625576173;588.3381196154327;659.986800263992;682.5802131689074;684.5037347922716;3891.9805400973382;4064.0731353910633;4065.89835254121;4178.603032711888;4187.539370669224;51821.222681659805;53857;54312;54316.45683543114;54599.18101228485;47071.764641176575;47993.04013919702;48587.51412485901;49032.264516032286;49560.50439495631;43456.56543434588;43716;43759.99999999936;44054.33918491161;44538.77730611391;7315.963420183078;7399.852002959803;7427.5914824683;7581.734639287599;7584.962075189589;26646.733532664424;27220;28582.999595014906;29542.704572954855;29628.407431851672;37368.62631373652;37812.81093594625;38328.42507362336;38469.23061538697;38998.22003559856;10362.274640775073;10965.396903170402;11036.668899933014;11048.392338421463;11179.217454778087;11404.030657393883;11510.769784604094;11706.35615041181;11951.370698446328;12035.157538972187;11824.940875295568;11951.880481195076;12042.518299267931;12668;12854.164479308814;10968.287061340987;11580.942095289469;11876;12017.278963261882;12138.150329477205;10540.894591054299;10723.624673136403;10953.616623418142;11131.165162612675;11564.710882228012;9845.360051596623;9874.210063194783;9978.451185184884;9985.850212246676;10305.269103687378;8728.476291422536;9286.59531293539;9318.347715659838;9629.085236902483;9807.901920980985 15:44:08 INFO - PROCESS | 20518 | __end_tp_report 15:44:08 INFO - PROCESS | 20518 | __start_cc_report 15:44:08 INFO - PROCESS | 20518 | _x_x_mozilla_cycle_collect,1024 15:44:08 INFO - PROCESS | 20518 | __end_cc_report 15:44:08 INFO - PROCESS | 20518 | __startTimestamp1462574648145__endTimestamp 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | ------- Summary: start ------- 15:44:08 INFO - PROCESS | 20518 | Number of tests: 6 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#0] dojo.html Cycles:165 Average:4678.66 Median:4780.45 stddev:477.38 (10.0%) stddev-sans-first:450.58 15:44:08 INFO - PROCESS | 20518 | Values: 2615.8 2642.6 2663.4 2678.2 2681.3 4555.4 4619.2 4668.3 4727.8 4785.9 4698.3 4738.4 4761.9 4766.3 4780.5 4335.6 4375.6 4414.3 4437.1 4517.4 4432.4 4473.5 4484.1 4486.4 4518.4 4305.0 4338.4 4353.4 4367.5 4381.4 4353.3 4382.0 4383.3 4423.7 4430.5 4395.1 4408.1 4413.1 4419.6 4454.1 4503.6 4572.4 4624.7 4641.1 4677.1 5054.9 5081.5 5107.7 5112.4 5121.1 5110.9 5111.1 5138.3 5148.1 5151.7 4614.5 4648.8 4668.7 4674.8 4706.5 5114.7 5143.2 5158.5 5166.2 5168.9 4948.1 4953.9 4954.8 4957.3 4960.1 4987.4 4988.1 5015.4 5029.5 5031.6 4983.4 4983.6 4986.5 4988.4 5033.5 4878.9 4969.8 4977.4 4980.7 5032.5 4296.2 4308.2 4341.8 4381.5 4396.1 3728.8 3731.2 3735.6 3769.4 3776.8 4325.4 4328.4 4328.7 4366.4 4373.2 5002.7 5019.6 5033.7 5075.4 5093.5 4405.0 4407.7 4430.2 4443.4 4454.7 4633.4 4636.3 4641.5 4642.5 4688.7 4563.2 4717.7 4721.8 4756.8 4761.0 5125.6 5132.6 5133.4 5136.4 5170.1 4777.0 4779.6 4782.5 4784.4 4816.1 4854.9 4907.0 4943.0 4951.1 5088.1 5041.1 5057.1 5057.7 5060.8 5101.8 4907.5 4911.4 4911.7 4913.8 4949.2 4802.0 4878.4 4894.5 4928.6 4957.0 4848.4 4882.2 4883.0 4910.4 4924.0 4962.2 4965.5 4973.4 5009.3 5020.9 4740.8 4758.7 4826.8 4829.4 4844.8 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#1] ext.html Cycles:180 Average:47066.48 Median:18688.47 stddev:83177.96 (445.1%) stddev-sans-first:83338.08 15:44:08 INFO - PROCESS | 20518 | Values: 584.5 608.4 608.4 610.1 628.4 28260.7 43026.4 44342.3 44394.3 48244.5 44089.1 44337.8 44493.6 44511.0 44672.8 7560.5 7938.1 8084.5 9688.0 9985.5 10114.2 10217.7 10224.8 10225.0 10232.4 10219.3 10262.5 10265.9 10269.6 10277.7 7647.7 9976.1 10241.9 10246.7 10650.8 10145.5 10205.3 10210.7 10211.1 10213.4 39765.4 39790.8 40018.0 40020.4 40308.0 3379.5 3384.3 3404.9 3461.6 3702.7 29996.4 30692.0 30742.5 30977.4 31655.0 3384.4 3401.2 3426.8 3441.8 3515.8 256140.0 256991.0 257073.0 257613.0 257617.0 33793.3 57403.1 57909.0 57989.4 57995.0 33992.5 36518.6 36652.1 36679.8 36706.3 11794.5 13372.5 13391.7 13417.5 13436.5 11135.7 11391.7 11428.4 11782.9 11788.1 8466.4 8478.3 8481.2 8544.7 8560.0 3256.2 3286.0 3335.7 3343.8 3351.8 942.1 958.2 1018.6 1061.1 1096.1 29572.0 29910.3 29920.4 30085.7 30480.2 1045.5 1050.2 1065.5 1075.9 1096.3 15354.6 15771.8 15868.2 15868.3 16109.5 389044.0 393241.0 393250.0 394070.0 394623.0 52037.2 52439.2 52473.7 52493.0 52509.0 1146.1 1269.7 1299.6 1341.5 1341.7 29145.4 30683.2 30772.2 30911.0 31061.2 44519.3 44735.0 45227.1 45303.5 45315.3 281051.0 282036.0 282395.0 283128.0 283186.0 22743.2 23286.5 23443.2 23661.8 24622.9 43691.8 43863.8 44252.3 44771.8 45136.3 37739.0 37788.8 38596.2 38864.0 39808.6 38983.6 39266.0 40076.4 40237.0 40389.0 38742.4 38808.4 39243.4 39458.0 39497.6 34194.3 35409.3 35481.8 35670.1 35798.0 24917.5 25184.7 25459.0 25484.4 25684.2 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#2] jquery.html Cycles:180 Average:22772.59 Median:342300.50 stddev:56492.49 (16.5%) stddev-sans-first:56625.94 15:44:08 INFO - PROCESS | 20518 | Values: 377.3 380.6 381.9 390.7 399.4 16009.8 17312.4 17994.8 18142.5 18149.2 16657.8 16848.3 17465.4 17476.4 17573.5 5173.6 5275.6 5285.4 5313.3 5372.4 3711.5 3913.0 5763.3 6063.0 6092.8 5909.1 6097.7 6108.2 6133.4 6148.7 6126.6 6140.6 6169.0 6184.8 6196.4 3381.4 4990.3 5301.3 5318.3 5384.5 20476.8 20493.5 20805.8 21110.8 21128.9 2148.0 2168.8 2252.9 2415.0 2500.9 12940.4 13179.3 13308.1 13312.3 13643.7 1797.2 1844.6 1860.6 1886.2 1931.5 67185.0 67317.7 67792.0 68686.0 69569.0 9511.7 9753.5 9878.2 9921.7 10105.6 13516.8 13574.9 13722.8 13723.5 13741.2 7069.6 7590.1 7677.3 7713.2 7726.5 7321.8 7368.2 7471.2 7477.4 7589.6 6082.6 6228.5 6231.4 6237.8 6302.2 1665.4 1712.2 1813.2 1814.7 1848.5 864.1 913.1 964.3 986.3 1009.5 16555.5 16846.7 16881.8 17132.2 17527.8 931.4 950.6 953.5 954.9 1028.8 9989.8 10110.3 10222.8 10240.4 10325.9 335931.0 341045.0 343556.0 345068.0 346130.0 66077.0 68170.3 69763.0 69837.3 70440.6 1000.1 1003.4 1004.3 1006.0 1036.6 15256.9 15298.4 15439.2 15476.6 15770.5 32931.3 32937.2 33346.7 33758.8 33890.7 44819.8 45343.5 45474.5 45575.3 46082.8 7622.8 7636.9 7639.1 7642.4 7751.2 9109.9 9128.5 11961.1 11985.2 12275.3 9991.6 10195.9 10568.5 10628.4 10720.3 10900.9 10948.6 11095.6 11102.1 11178.3 10994.8 11063.7 11116.5 11148.2 11338.6 6536.5 7008.8 7120.3 7819.9 7999.8 8566.4 10614.9 10776.5 10861.2 10895.5 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#3] mootools.html Cycles:180 Average:5135.40 Median:5180.31 stddev:2890.23 (55.8%) stddev-sans-first:2883.92 15:44:08 INFO - PROCESS | 20518 | Values: 1294.2 1506.2 1518.8 1711.7 1880.6 6613.6 7474.2 7700.3 7700.5 7922.6 7676.2 7806.1 7826.1 7827.2 7829.9 1840.1 1895.9 1895.9 2190.3 2223.2 1956.5 2131.6 2207.9 2208.5 2233.4 2182.5 2218.7 2219.4 2223.2 2227.2 1817.4 2194.4 2199.5 2202.2 2206.2 2131.9 2208.0 2209.1 2234.1 2237.7 7699.3 7740.5 7752.7 7753.1 7756.4 4425.7 4559.7 4573.5 4578.7 4583.5 2619.4 2707.8 2852.7 2857.4 2870.1 880.8 898.6 907.9 908.8 909.6 10605.6 10612.9 10614.4 10620.4 10653.1 4050.3 4159.5 4198.8 4252.6 4279.0 9001.6 9079.0 9081.0 9083.0 9083.5 4393.7 4397.3 4423.2 4423.9 4429.6 3677.1 3823.0 4016.6 4082.5 4104.5 3627.8 3698.6 3759.2 3760.7 3764.0 1189.8 1205.5 1209.4 1216.5 1228.2 774.8 882.5 882.9 936.0 943.5 5299.7 5304.9 5326.3 5405.8 5483.8 392.3 406.1 407.0 407.8 415.1 3662.1 3694.4 4000.8 4009.6 4062.2 9162.6 9607.4 9713.6 9743.4 9767.9 9341.3 9571.5 9573.7 9575.3 9647.7 6872.2 7020.7 7107.6 7166.4 7194.4 5063.8 5296.8 5363.8 5365.4 5427.9 8600.8 8857.8 8910.6 8917.5 8997.5 8857.6 8887.7 8954.2 9034.4 9075.6 6563.8 7203.7 7344.3 7427.4 7454.4 7566.5 7621.2 7691.9 7696.2 7705.5 6593.9 6839.6 6918.4 6970.2 7030.5 6660.7 6670.0 6670.2 6757.5 6760.1 6351.5 6403.1 6496.3 6507.6 6575.4 4626.5 4635.7 4638.2 4683.8 4765.1 4644.1 4720.7 4731.3 4819.4 4827.6 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#4] prototype.html Cycles:180 Average:4159.65 Median:4754.31 stddev:1194.58 (25.1%) stddev-sans-first:1162.30 15:44:08 INFO - PROCESS | 20518 | Values: 301.6 307.0 310.8 317.4 323.4 4780.6 4787.7 4794.8 4812.6 4838.7 4778.8 4791.5 4812.0 4814.7 4816.8 3834.3 3836.4 3840.4 3850.9 3879.1 3865.3 3870.8 3871.9 3878.7 3906.5 3547.0 3751.6 3756.5 3819.4 3822.0 3718.4 3720.4 3745.5 3760.6 3764.3 3313.5 3318.0 3324.9 3328.4 3328.6 4578.3 4589.3 4603.4 4620.7 4621.8 4139.7 4267.4 4278.2 4288.6 4294.9 4968.0 4970.5 4991.7 5010.3 5021.5 3630.0 3634.9 3638.2 3642.4 3647.7 5057.2 5209.8 5229.9 5267.0 5281.2 3658.3 3680.3 3696.5 3700.6 3706.7 3743.9 3747.4 3750.9 3768.3 3778.6 4211.4 4223.8 4247.4 4249.8 4283.4 4752.3 5032.4 5037.9 5045.9 5058.0 1254.3 1264.0 1265.2 1273.3 1278.3 833.0 861.6 862.1 872.5 874.9 4298.2 4362.7 4372.8 4390.3 4396.3 5028.9 5089.3 5096.5 5109.5 5118.5 4273.6 4281.3 4320.0 4378.8 4386.8 2565.7 2659.9 2682.7 2737.2 2741.0 4692.4 4743.9 4756.3 4763.3 4765.9 5080.5 5099.3 5152.2 5166.4 5172.9 4492.5 4844.1 4848.7 4872.7 4884.8 5174.5 5179.9 5204.8 5211.0 5211.3 4891.0 4941.7 5086.3 5114.2 5142.0 4859.8 4862.5 4864.8 4870.5 4874.8 3661.6 3665.6 3686.3 3692.1 3692.5 5186.2 5186.7 5192.8 5195.3 5198.0 5002.3 5005.3 5033.4 5038.6 5043.3 4777.7 4855.2 4863.9 4920.4 4934.7 4709.6 4877.3 4956.9 4967.5 4969.2 4934.4 4993.3 5010.8 5050.1 5075.3 4694.9 4934.5 4945.8 4960.2 4973.2 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - PROCESS | 20518 | [#5] yui.html Cycles:180 Average:12951.45 Median:43509.56 stddev:14546.50 (33.4%) stddev-sans-first:14558.23 15:44:08 INFO - PROCESS | 20518 | Values: 706.2 758.4 760.7 760.7 802.1 11583.2 12281.3 12283.1 12294.9 12329.6 12685.3 12739.6 12760.2 12761.7 12765.0 672.9 829.5 859.6 861.4 865.3 825.3 828.6 829.2 830.7 831.3 714.2 917.9 919.3 920.3 920.7 726.1 728.8 859.7 892.2 894.1 665.9 665.9 665.9 668.6 668.6 11789.6 11805.9 11826.4 11838.2 11856.5 12148.9 12573.3 12648.6 12860.5 12862.9 11018.7 11151.9 11436.9 11458.5 11813.8 4151.6 4206.5 4209.7 4254.6 4307.6 43562.6 43930.8 44203.3 44265.0 44627.8 9803.3 10426.5 10524.1 10586.7 10608.0 16768.2 17469.7 17535.6 17571.0 17654.8 6636.8 6734.5 6763.0 6938.6 7014.0 3723.4 3757.5 3818.8 3865.6 3901.8 2796.9 2873.9 2882.6 2888.0 2889.6 493.8 502.7 518.4 524.3 527.9 510.6 526.8 625.8 658.1 659.6 7958.4 8194.7 8300.2 8362.3 8415.8 522.0 588.3 660.0 682.6 684.5 3892.0 4064.1 4065.9 4178.6 4187.5 51821.2 53857.0 54312.0 54316.5 54599.2 47071.8 47993.0 48587.5 49032.3 49560.5 43456.6 43716.0 43760.0 44054.3 44538.8 7316.0 7399.9 7427.6 7581.7 7585.0 26646.7 27220.0 28583.0 29542.7 29628.4 37368.6 37812.8 38328.4 38469.2 38998.2 10362.3 10965.4 11036.7 11048.4 11179.2 11404.0 11510.8 11706.4 11951.4 12035.2 11824.9 11951.9 12042.5 12668.0 12854.2 10968.3 11580.9 11876.0 12017.3 12138.2 10540.9 10723.6 10953.6 11131.2 11564.7 9845.4 9874.2 9978.5 9985.9 10305.3 8728.5 9286.6 9318.3 9629.1 9807.9 15:44:08 INFO - PROCESS | 20518 | -------- Summary: end -------- 15:44:08 INFO - PROCESS | 20518 | 15:44:08 INFO - TEST-INFO | 20518: exit 0 15:44:08 INFO - TEST-OK | dromaeo_css | took 1119226ms 15:44:08 INFO - TEST-START | kraken 15:44:08 INFO - operating with platform_type : linux_ 15:44:08 INFO - Initialising browser for kraken test... 15:44:08 INFO - TEST-INFO | started process 20691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuD3jP/profile http://localhost:59269/getInfo.html) 15:44:13 INFO - PROCESS | 20691 | __metrics Screen width/height:1600/1200 15:44:13 INFO - PROCESS | 20691 | colorDepth:24 15:44:13 INFO - PROCESS | 20691 | Browser inner width/height: 1024/697 15:44:13 INFO - PROCESS | 20691 | __metrics 15:44:14 ERROR - PROCESS | 20691 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:44:15 INFO - TEST-INFO | 20691: exit 0 15:44:15 INFO - Browser initialized. 15:44:15 INFO - Running cycle 1/1 for kraken test... 15:44:15 INFO - TEST-INFO | started process 20775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuD3jP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:27 INFO - PROCESS | 20775 | RSS: Main: 154173440 15:44:27 INFO - PROCESS | 20775 | 15:44:30 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59269/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:30 INFO - PROCESS | 20775 | RSS: Main: 209895424 15:44:30 INFO - PROCESS | 20775 | 15:44:33 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59269/tests/kraken/driver.html?testName=audio-dft) 15:44:34 INFO - PROCESS | 20775 | RSS: Main: 198119424 15:44:34 INFO - PROCESS | 20775 | 15:44:37 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59269/tests/kraken/driver.html?testName=audio-fft) 15:44:38 INFO - PROCESS | 20775 | RSS: Main: 266629120 15:44:38 INFO - PROCESS | 20775 | 15:44:40 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59269/tests/kraken/driver.html?testName=audio-oscillator) 15:44:40 INFO - PROCESS | 20775 | RSS: Main: 176693248 15:44:40 INFO - PROCESS | 20775 | 15:44:43 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:43 INFO - PROCESS | 20775 | RSS: Main: 180535296 15:44:43 INFO - PROCESS | 20775 | 15:44:46 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59269/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:47 INFO - PROCESS | 20775 | RSS: Main: 215646208 15:44:47 INFO - PROCESS | 20775 | 15:44:50 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59269/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:51 INFO - PROCESS | 20775 | RSS: Main: 216719360 15:44:51 INFO - PROCESS | 20775 | 15:44:54 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59269/tests/kraken/driver.html?testName=json-parse-financial) 15:44:55 INFO - PROCESS | 20775 | RSS: Main: 216911872 15:44:55 INFO - PROCESS | 20775 | 15:44:56 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:57 INFO - PROCESS | 20775 | RSS: Main: 203497472 15:44:57 INFO - PROCESS | 20775 | 15:44:59 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:59 INFO - PROCESS | 20775 | RSS: Main: 207355904 15:44:59 INFO - PROCESS | 20775 | 15:45:01 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:02 INFO - PROCESS | 20775 | RSS: Main: 217415680 15:45:02 INFO - PROCESS | 20775 | 15:45:05 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:06 INFO - PROCESS | 20775 | RSS: Main: 225030144 15:45:06 INFO - PROCESS | 20775 | 15:45:08 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:09 INFO - PROCESS | 20775 | RSS: Main: 221552640 15:45:09 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | Cycle 1(1): loaded http://localhost:59269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59269/tests/kraken/driver.html?testName=ai-astar) 15:45:11 INFO - PROCESS | 20775 | RSS: Main: 267210752 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | __start_tp_report 15:45:11 INFO - PROCESS | 20775 | _x_x_mozilla_page_load 15:45:11 INFO - PROCESS | 20775 | _x_x_mozilla_page_load_details 15:45:11 INFO - PROCESS | 20775 | |i|pagename|runs| 15:45:11 INFO - PROCESS | 20775 | |0;ai-astar;113;110;113;112;111;113;113;111;112;112 15:45:11 INFO - PROCESS | 20775 | |1;audio-beat-detection;156;130;159;194;134;159;161;130;201;130 15:45:11 INFO - PROCESS | 20775 | |2;audio-dft;160;159;160;160;162;163;161;161;161;162 15:45:11 INFO - PROCESS | 20775 | |3;audio-fft;75;75;78;118;75;75;75;75;127;75 15:45:11 INFO - PROCESS | 20775 | |4;audio-oscillator;94;94;119;93;93;93;126;93;94;121 15:45:11 INFO - PROCESS | 20775 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 15:45:11 INFO - PROCESS | 20775 | |6;imaging-darkroom;148;146;147;145;146;146;147;145;146;145 15:45:11 INFO - PROCESS | 20775 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 15:45:11 INFO - PROCESS | 20775 | |8;json-parse-financial;66;66;67;66;66;65;66;79;65;64 15:45:11 INFO - PROCESS | 20775 | |9;json-stringify-tinderbox;63;63;64;64;64;64;63;68;64;63 15:45:11 INFO - PROCESS | 20775 | |10;stanford-crypto-aes;82;81;93;82;84;89;84;83;83;82 15:45:11 INFO - PROCESS | 20775 | |11;stanford-crypto-ccm;137;135;130;140;138;145;130;132;167;149 15:45:11 INFO - PROCESS | 20775 | |12;stanford-crypto-pbkdf2;174;174;172;176;175;171;175;174;172;173 15:45:11 INFO - PROCESS | 20775 | |13;stanford-crypto-sha256-iterative;67;69;71;67;71;68;68;70;67;67 15:45:11 INFO - PROCESS | 20775 | __end_tp_report 15:45:11 INFO - PROCESS | 20775 | __start_cc_report 15:45:11 INFO - PROCESS | 20775 | _x_x_mozilla_cycle_collect,1857 15:45:11 INFO - PROCESS | 20775 | __end_cc_report 15:45:11 INFO - PROCESS | 20775 | __startTimestamp1462574711633__endTimestamp 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | ------- Summary: start ------- 15:45:11 INFO - PROCESS | 20775 | Number of tests: 14 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:1.05 (0.9%) stddev-sans-first:1.05 15:45:11 INFO - PROCESS | 20775 | Values: 113.0 110.0 113.0 112.0 111.0 113.0 113.0 111.0 112.0 112.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:159.00 stddev:25.86 (16.3%) stddev-sans-first:27.43 15:45:11 INFO - PROCESS | 20775 | Values: 156.0 130.0 159.0 194.0 134.0 159.0 161.0 130.0 201.0 130.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 15:45:11 INFO - PROCESS | 20775 | Values: 160.0 159.0 160.0 160.0 162.0 163.0 161.0 161.0 161.0 162.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.00 stddev:20.00 (26.7%) stddev-sans-first:20.90 15:45:11 INFO - PROCESS | 20775 | Values: 75.0 75.0 78.0 118.0 75.0 75.0 75.0 75.0 127.0 75.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:93.00 stddev:13.91 (15.0%) stddev-sans-first:14.45 15:45:11 INFO - PROCESS | 20775 | Values: 94.0 94.0 119.0 93.0 93.0 93.0 126.0 93.0 94.0 121.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:45:11 INFO - PROCESS | 20775 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.78 15:45:11 INFO - PROCESS | 20775 | Values: 148.0 146.0 147.0 145.0 146.0 146.0 147.0 145.0 146.0 145.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:45:11 INFO - PROCESS | 20775 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:4.29 (6.5%) stddev-sans-first:4.54 15:45:11 INFO - PROCESS | 20775 | Values: 66.0 66.0 67.0 66.0 66.0 65.0 66.0 79.0 65.0 64.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.54 15:45:11 INFO - PROCESS | 20775 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 63.0 68.0 64.0 63.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.77 (4.5%) stddev-sans-first:3.91 15:45:11 INFO - PROCESS | 20775 | Values: 82.0 81.0 93.0 82.0 84.0 89.0 84.0 83.0 83.0 82.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:139.00 stddev:11.24 (8.1%) stddev-sans-first:11.85 15:45:11 INFO - PROCESS | 20775 | Values: 137.0 135.0 130.0 140.0 138.0 145.0 130.0 132.0 167.0 149.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:1.58 (0.9%) stddev-sans-first:1.67 15:45:11 INFO - PROCESS | 20775 | Values: 174.0 174.0 172.0 176.0 175.0 171.0 175.0 174.0 172.0 173.0 15:45:11 INFO - PROCESS | 20775 | 15:45:11 INFO - PROCESS | 20775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.65 (2.4%) stddev-sans-first:1.66 15:45:11 INFO - PROCESS | 20775 | Values: 67.0 69.0 71.0 67.0 71.0 68.0 68.0 70.0 67.0 67.0 15:45:11 INFO - PROCESS | 20775 | -------- Summary: end -------- 15:45:11 INFO - PROCESS | 20775 | 15:45:12 INFO - TEST-INFO | 20775: exit 0 15:45:12 INFO - TEST-OK | kraken | took 63779ms 15:45:12 INFO - SUITE-END | took 1183s 15:45:12 INFO - Completed test suite (00:19:43) 15:45:12 INFO - javascript benchmark 15:45:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.7907367410608, 2642.6036094585797, 2663.3741070848355, 2678.1563807400667, 2681.3296675831043, 4555.362249285103, 4619.237825758746, 4668.276417155342, 4727.8108875644975, 4785.899243174068, 4698.3422320875015, 4738.407699037621, 4761.857144285668, 4766.285057241415, 4780.450248221456, 4335.631471324933, 4375.562443755615, 4414.271645178542, 4437.068215674696, 4517.435320584927, 4432.423784907957, 4473.507914129443, 4484.148011877749, 4486.416765820455, 4518.367428560005, 4304.97847510762, 4338.392625032498, 4353.36876152956, 4367.497737760166, 4381.38660587518, 4353.25994580922, 4382.035952090535, 4383.254846676073, 4423.668224883115, 4430.512643609232, 4395.142947125312, 4408.14041261954, 4413.117376524708, 4419.558044195587, 4454.109178164348, 4503.617192538605, 4572.359869618256, 4624.653151013654, 4641.0949864776385, 4677.111348843709, 5054.91319366338, 5081.466446023152, 5107.719075450848, 5112.36095488064, 5121.129408000612, 5110.923336149961, 5111.08000559899, 5138.2549530318265, 5148.124818780779, 5151.6908985461, 4614.5385461453925, 4648.790804413809, 4668.743219122981, 4674.813007479731, 4706.458757242961, 5114.744262786846, 5143.202803565453, 5158.458361872024, 5166.225066240094, 5168.8966220675375, 4948.05986862495, 4953.90092198154, 4954.752262386866, 4957.281194226817, 4960.082384758831, 4987.376577927759, 4988.077205716954, 5015.3730783652045, 5029.471905449948, 5031.622628302892, 4983.352164218701, 4983.626228032912, 4986.4514903360605, 4988.426330971912, 5033.546980771748, 4878.853634390974, 4969.751512424436, 4977.377827771528, 4980.701157930535, 5032.47159048302, 4296.205202037633, 4308.224519586504, 4341.761203133858, 4381.474223093249, 4396.120775844844, 3728.8135593220773, 3731.160488889978, 3735.6451137141926, 3769.4157405602177, 3776.773393596338, 4325.3728209409455, 4328.372386004012, 4328.696991210585, 4366.410534577855, 4373.169097871394, 5002.74986250686, 5019.623528235397, 5033.697978121324, 5075.441701412841, 5093.541581257705, 4404.977975110104, 4407.735535867858, 4430.158269928703, 4443.400140980991, 4454.732716037048, 4633.443986721615, 4636.327732478839, 4641.512641172696, 4642.46611639659, 4688.71867687933, 4563.2242518772555, 4717.669763116549, 4721.811127554859, 4756.762161891961, 4760.952390476051, 5125.5899528036925, 5132.563732082665, 5133.358330208724, 5136.383633963799, 5170.0952333340765, 4776.9761151194025, 4779.641526885428, 4782.450018247946, 4784.378030856105, 4816.060868130681, 4854.854354369375, 4907.0, 4943.0, 4951.10880041596, 5088.135017047185, 5041.143005689115, 5057.064443078042, 5057.69653820772, 5060.772265247999, 5101.846944591668, 4907.509249075064, 4911.361523001987, 4911.656184067081, 4913.77887995034, 4949.1586430306215, 4802.0, 4878.390201224847, 4894.510548945077, 4928.556429921325, 4957.033378491304, 4848.369711937426, 4882.2432522959, 4882.975585122052, 4910.43529994041, 4924.03981223658, 4962.181240095344, 4965.4786247444945, 4973.403191617029, 5009.323741294878, 5020.899582008266, 4740.786664600032, 4758.714477131383, 4826.7827947743135, 4829.372181616508, 4844.757762111951], "value": 4648.738324853619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5265335078586, 608.3794529579832, 608.4371955940757, 610.0513701194643, 628.3841835001698, 28260.717392826067, 43026.35460468096, 44342.33486497705, 44394.33408498875, 48244.51755482453, 44089.11821763563, 44337.77831110848, 44493.55506444935, 44511.0, 44672.776636116774, 7560.546367217957, 7938.126806051344, 8084.4639518491595, 9688.0, 9985.500724963758, 10114.2414318926, 10217.693469195936, 10224.795504089914, 10225.0, 10232.43721595312, 10219.284650074498, 10262.538185781657, 10265.897341026568, 10269.64056258031, 10277.691669249934, 7647.655855486517, 9976.102150806462, 10241.948790256076, 10246.692599222035, 10650.840237396445, 10145.492725363776, 10205.285630005903, 10210.744731381701, 10211.132053775364, 10213.438260895648, 39765.40351894724, 39790.80104599459, 40018.0, 40020.39969400461, 40308.0, 3379.4761811918947, 3384.272381438003, 3404.931901361959, 3461.6365281645317, 3702.7037836972977, 29996.400071998654, 30692.0, 30742.538861917088, 30977.380452390826, 31655.0, 3384.4415671414185, 3401.183715908189, 3426.8286585670617, 3441.7590768646205, 3515.771474854152, 256140.0, 256991.0, 257073.0, 257613.0, 257617.0, 33793.32413351719, 57403.1389529149, 57909.0, 57989.42010579925, 57995.0, 33992.49011264833, 36518.634813652054, 36652.083697907765, 36679.81660091736, 36706.26587468289, 11794.52821887115, 13372.46510139603, 13391.665208369868, 13417.463301467831, 13436.529721459701, 11135.665930022113, 11391.715207119723, 11428.428578571038, 11782.88217117835, 11788.115891308185, 8466.365022623204, 8478.321734261244, 8481.151884811592, 8544.74365769028, 8560.0, 3256.169676732418, 3285.967140328614, 3335.71646410053, 3343.7993720376853, 3351.815650139217, 942.0673533202081, 958.2477754962321, 1018.6383833738915, 1061.0768631290825, 1096.13405409727, 29572.0, 29910.25224369408, 29920.401591968475, 30085.69914300873, 30480.237994050327, 1045.513836066233, 1050.2070936442938, 1065.5258410007473, 1075.8655168103987, 1096.31480324797, 15354.616134596725, 15771.763423548657, 15868.20658967047, 15868.285927133307, 16109.516714498584, 389044.0, 393241.0, 393250.0, 394070.0, 394623.0, 52037.2194417084, 52439.21341179885, 52473.73763131236, 52493.0, 52509.0, 1146.134668325409, 1269.6889262130653, 1299.6094179228323, 1341.463414634154, 1341.6981179234594, 29145.417091658474, 30683.232919176306, 30772.230694232825, 30911.0, 31061.223469413446, 44519.332210016226, 44735.0, 45227.09545809131, 45303.54696453125, 45315.32027019531, 281051.0, 282036.0, 282395.0, 283128.0, 283186.0, 22743.203987860346, 23286.507023946542, 23443.179488717815, 23661.763382365956, 24622.876885615457, 43691.78154109209, 43863.78068109639, 44252.336214957446, 44771.77614111909, 45136.322955156356, 37739.0, 37788.81105594454, 38596.22807543777, 38864.0, 39808.60191398165, 38983.610163897996, 39266.0, 40076.39885401663, 40237.0, 40389.0, 38742.418863716506, 38808.41787373135, 39243.41134882922, 39458.0, 39497.60502395054, 34194.316113678084, 35409.29181416409, 35481.82259088688, 35670.108247292985, 35798.0, 24917.50164996726, 25184.74815251824, 25459.0, 25484.362890927874, 25684.229473115836], "value": 17740.20717384693, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.27374803503255, 380.6326894546762, 381.85298660015894, 390.6679322575809, 399.3510545363784, 16009.83990160098, 17312.394066207686, 17994.820051799477, 18142.546436339097, 18149.183286752093, 16657.83342166578, 16848.32606695734, 17465.388711395102, 17476.388326408578, 17573.472795816146, 5173.6119791015635, 5275.6043296752705, 5285.392179899303, 5313.282706834586, 5372.382176049746, 3711.498947642074, 3913.021744563859, 5763.308402991647, 6062.999605065159, 6092.786752463642, 5909.084091965752, 6097.664628445434, 6108.236470441195, 6133.386661333853, 6148.723307451175, 6126.571140020223, 6140.600860944024, 6168.96915515424, 6184.752609895599, 6196.4113409226275, 3381.425157723193, 4990.30135780991, 5301.257823904656, 5318.25544423781, 5384.515393614554, 20476.795232047785, 20493.4876628084, 20805.791942080687, 21110.788892111188, 21128.89435552828, 2148.022649694385, 2168.7963180434854, 2252.9098836046537, 2414.9637755433682, 2500.8999640014376, 12940.417681204368, 13179.341032948314, 13308.06843520954, 13312.267825269606, 13643.727125457535, 1797.2002458905793, 1844.631073785235, 1860.6185731924922, 1886.1795119123226, 1931.5364312565023, 67185.0, 67317.66341168263, 67792.0, 68685.9999999995, 69569.0, 9511.66709165176, 9753.512324383895, 9878.209743220525, 9921.702348929544, 10105.595776169019, 13516.797248041286, 13574.86425135736, 13722.794158087636, 13723.45106195741, 13741.24423156736, 7069.575825450489, 7590.127135379502, 7677.30904218623, 7713.151553329241, 7726.497777644435, 7321.816954576178, 7368.226336234726, 7471.215522370181, 7477.401807855358, 7589.620518974029, 6082.635041897501, 6228.532860035515, 6231.40801623845, 6237.812865614039, 6302.243730752248, 1665.4087798831483, 1712.1524845201704, 1813.238439855264, 1814.7187185986193, 1848.4731851422548, 864.1444969480295, 913.118840319082, 964.286428043243, 986.330849240823, 1009.485162567096, 16555.50333489997, 16846.747298790528, 16881.83118168827, 17132.229049692793, 17527.82472175262, 931.380631879806, 950.5912457643142, 953.5184731710442, 954.8949615542285, 1028.7685270814156, 9989.771735062992, 10110.342827716175, 10222.795544089076, 10240.385576865412, 10325.9483702581, 335931.0, 341045.0, 343556.0, 345068.0, 346130.0, 66077.0, 68170.3182968164, 69763.0, 69837.30162698308, 70440.64779676069, 1000.1198944928417, 1003.4430890855646, 1004.2969921055291, 1005.969820905374, 1036.6268143468346, 15256.923715381352, 15298.388064477296, 15439.150846703538, 15476.613084672974, 15770.526884193492, 32931.34137317288, 32937.17657058593, 33346.66653333532, 33758.83120584382, 33890.66109338875, 44819.77590112029, 45343.546564533935, 45474.54525454703, 45575.31637025514, 46082.76958615185, 7622.8094297643, 7636.923630763621, 7639.121501027231, 7642.426817988562, 7751.224877512203, 9109.908900910907, 9128.497932613504, 11961.102917281065, 11985.161038727205, 12275.263484190977, 9991.600335986479, 10195.949020254851, 10568.524416401435, 10628.41543715103, 10720.303180293256, 10900.890991089987, 10948.56205751761, 11095.611653592408, 11102.056325212447, 11178.27341222818, 10994.835077473685, 11063.668089957315, 11116.499757511094, 11148.163887708291, 11338.629741239954, 6536.509761767791, 7008.824779380557, 7120.323569260912, 7819.882701759364, 7999.800004999689, 8566.357523185661, 10614.89385106139, 10776.515056822618, 10861.239713220315, 10895.509702063584], "value": 8489.074649707678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.2040645003315, 1506.1640789361902, 1518.8405217452168, 1711.7346811244254, 1880.5768702042042, 6613.636250006254, 7474.215207403219, 7700.268474494928, 7700.4609677322605, 7922.564258965755, 7676.1939996300425, 7806.063272407319, 7826.1391246962785, 7827.178146294643, 7829.882551761728, 1840.0707642640448, 1895.8578106641987, 1895.924163033477, 2190.277208521188, 2223.2329846203033, 1956.5402130499322, 2131.56302957894, 2207.87856667884, 2208.4920468292303, 2233.4081468410805, 2182.476205710634, 2218.7004754358118, 2219.411855858199, 2223.1996481266733, 2227.187076716995, 1817.3820900893759, 2194.36363454598, 2199.538096999632, 2202.2402271216406, 2206.2388475975763, 2131.914723411062, 2207.9779202207933, 2209.1053123484853, 2234.0728597631964, 2237.686723858661, 7699.345555627779, 7740.496867703638, 7752.728654497122, 7753.147153813076, 7756.4182686298755, 4425.734455932622, 4559.6580256480565, 4573.474050484204, 4578.679492435531, 4583.541645835423, 2619.410632607667, 2707.82399144055, 2852.700466451034, 2857.3713782967716, 2870.052882548754, 880.7930136417937, 898.5956319656116, 907.9182873541347, 908.8000639859221, 909.5543183839937, 10605.628802991936, 10612.893871061267, 10614.416207108607, 10620.415877126832, 10653.147748180205, 4050.2709512287483, 4159.459270294903, 4198.811053502539, 4252.617264446215, 4279.0, 9001.63993440255, 9078.954605226932, 9080.954595226982, 9082.954585227031, 9083.545822708838, 4393.714408563433, 4397.31841564558, 4423.181711383404, 4423.889402764957, 4429.579189976947, 3677.1358730698266, 3822.980885095557, 4016.638502534786, 4082.510098788105, 4104.507459104867, 3627.782333060025, 3698.556173259226, 3759.2293579816073, 3760.6803421708914, 3764.0, 1189.821526770974, 1205.457544105156, 1209.4436559182875, 1216.4525963316544, 1228.238492134882, 774.7559518751575, 882.5102068352127, 882.9249513791272, 936.0171819589403, 943.4947083766164, 5299.708516031656, 5304.92042619361, 5326.334208223972, 5405.837824865261, 5483.7806487740045, 392.31736778006064, 406.14709110866943, 407.0231444533144, 407.83278855669624, 415.14065883620617, 3662.1393972416463, 3694.427363758568, 4000.8399664013114, 4009.578994205625, 4062.1875624875142, 9162.587683554257, 9607.375520591138, 9713.611455541699, 9743.366681165702, 9767.902320976842, 9341.299402544837, 9571.473568953636, 9573.712788616353, 9575.281853860988, 9647.662331818352, 6872.209695884937, 7020.719171233196, 7107.609081500567, 7166.426685865118, 7194.424446044409, 5063.772130254074, 5296.841094767163, 5363.812266570651, 5365.436629154039, 5427.864303392446, 8600.78498037554, 8857.778555536162, 8910.55447227623, 8917.464952102895, 8997.505137217517, 8857.557122143739, 8887.688930887389, 8954.194122529003, 9034.412763170372, 9075.591598378222, 6563.835904102436, 7203.675834587351, 7344.339009489172, 7427.368673662799, 7454.440916931143, 7566.470347075652, 7621.237876212334, 7691.884621730566, 7696.153423123564, 7705.499142555716, 6593.934060659332, 6839.589624622538, 6918.377346038881, 6970.163580370388, 7030.543014704028, 6660.666966651551, 6670.0, 6670.199576050905, 6757.493188011017, 6760.121184246016, 6351.460125889166, 6403.103565500741, 6496.252930913006, 6507.577007494498, 6575.4410875076155, 4626.514216007271, 4635.65232607549, 4638.165130276582, 4683.812647494062, 4765.070811191923, 4644.117617652635, 4720.740359280273, 4731.313959475926, 4819.373481447389, 4827.61379089679], "value": 4066.655421026428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.61995885184666, 306.99612267884004, 310.82438422291403, 317.41912300490105, 323.40977715668896, 4780.569748722614, 4787.688800227983, 4794.784234709442, 4812.614990800736, 4838.709677419353, 4778.80884764609, 4791.496892826247, 4811.951880481194, 4814.66297359185, 4816.83141090062, 3834.2714884172055, 3836.386178211487, 3840.4431357453154, 3850.8652197173105, 3879.1465877506903, 3865.3042452358563, 3870.845166193363, 3871.922561548767, 3878.747881387715, 3906.5312162540395, 3546.982265088671, 3751.6177227460485, 3756.455313979471, 3819.4461803038544, 3821.9617803822025, 3718.442233664945, 3720.3861362875364, 3745.5318085239346, 3760.64273893981, 3764.3036038333, 3313.5361049453095, 3317.9834100829585, 3324.900252992414, 3328.400887840188, 3328.567286252796, 4578.260261100793, 4589.334546490773, 4603.378543896598, 4620.653450991155, 4621.7920193591035, 4139.730917490354, 4267.359896015591, 4278.165757677254, 4288.635465985395, 4294.871153865358, 4967.981563779453, 4970.502949705036, 4991.650584459089, 5010.298558201855, 5021.472745361721, 3630.0, 3634.872779452733, 3638.181409182913, 3642.4354225095153, 3647.689946354563, 5057.241413787924, 5209.765560549784, 5229.869253268661, 5267.0, 5281.234221037967, 3658.2866341063236, 3680.2639472105684, 3696.537932758405, 3700.6114357992024, 3706.683322923173, 3743.887683369503, 3747.4004159334922, 3750.868719594801, 3768.3217020936495, 3778.5843557208686, 4211.36829475575, 4223.809928553223, 4247.384129301234, 4249.766262855511, 4283.378910058024, 4752.334673145762, 5032.446430892599, 5037.924431133536, 5045.873853153627, 5057.974710126426, 1254.2725219372924, 1263.993680031594, 1265.2029221590524, 1273.2996851731511, 1278.2905487454552, 832.9666813327399, 861.646724842824, 862.1206369503071, 872.4895935877582, 874.8687696845524, 4298.247806633889, 4362.716423432466, 4372.846950356722, 4390.297552391602, 4396.318570621559, 5028.924566131511, 5089.338386009869, 5096.464871188546, 5109.492699653611, 5118.539331460112, 4273.615374616299, 4281.250781113293, 4319.956800432018, 4378.759168245713, 4386.758728269976, 2565.679290088739, 2659.9069032584152, 2682.731726827302, 2737.1925282041843, 2740.986295068512, 4692.3722715279555, 4743.905121897543, 4756.286557016475, 4763.285507173951, 4765.880852978703, 5080.491950804964, 5099.311592934981, 5152.170979302368, 5166.405863325691, 5172.948270517322, 4492.505824359318, 4844.103840789465, 4848.739327774804, 4872.731999740048, 4884.8290309838985, 5174.456682048331, 5179.948200517946, 5204.81397812927, 5210.97394513025, 5211.332373640399, 4890.951090489192, 4941.654084214214, 5086.338775959101, 5114.232865070269, 5141.974290128525, 4859.829905953275, 4862.541237628768, 4864.781084851261, 4870.488598697086, 4874.757611498609, 3661.6338366164237, 3665.633436656313, 3686.336459437327, 3692.1138926657945, 3692.538432695913, 5186.196139598368, 5186.714730689849, 5192.818251361336, 5195.298634684269, 5197.974010129925, 5002.349694539686, 5005.274235235943, 5033.421156567042, 5038.649298216645, 5043.319151914445, 4777.7372244525495, 4855.223164293838, 4863.854084377333, 4920.360353154067, 4934.667639737323, 4709.576138147583, 4877.29279254499, 4956.900861982812, 4967.528084831935, 4969.1800852860315, 4934.432540257772, 4993.2510123480315, 5010.799568017239, 5050.116229659869, 5075.28945947575, 4694.882627934329, 4934.5312195341385, 4945.777440015136, 4960.181570040902, 4973.179425394914], "value": 3783.6711033931533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1702499563015, 758.3932853717022, 760.6843160088557, 760.6881178716726, 802.0896282719114, 11583.247088939213, 12281.263124212554, 12283.14018018739, 12294.877051229485, 12329.568465103723, 12685.302308373035, 12739.554115605932, 12760.23438593685, 12761.680957976056, 12765.042621803355, 672.9192496900355, 829.5354601423193, 859.6389516403094, 861.4486728493769, 865.2688478235881, 825.2696363718122, 828.6395417993162, 829.2246749289403, 830.730012745857, 831.3141658132065, 714.1715609892526, 917.8531434970406, 919.2691810011057, 920.2775820980531, 920.7191806499015, 726.12501935168, 728.7813655903234, 859.6647307550061, 892.1702816380763, 894.0790985285166, 665.8701553197128, 665.8901281288581, 665.8967859981663, 668.6289109544201, 668.6456178225549, 11789.646310610695, 11805.881941180563, 11826.408679565988, 11838.230515016583, 11856.525738970431, 12148.939255303667, 12573.308468034254, 12648.557300494438, 12860.549880754223, 12862.935685321607, 11018.669439916815, 11151.888481115247, 11436.885631143665, 11458.541658333657, 11813.763724725542, 4151.584841515854, 4206.537280899099, 4209.684273679486, 4254.553271906467, 4307.569243075699, 43562.56437435617, 43930.780346098385, 44203.33694994578, 44265.0, 44627.77686111549, 9803.264755143393, 10426.478676066166, 10524.05283524471, 10586.735331616617, 10608.0, 16768.245428955724, 17469.65060698804, 17535.64928701419, 17571.0, 17654.764166508223, 6636.767713130017, 6734.46124310054, 6762.966185169141, 6938.5836849789175, 7014.0, 3723.404255319136, 3757.530308711411, 3818.8090595470117, 3865.613438656112, 3901.8244179012013, 2796.9300767480977, 2873.8563071846324, 2882.567614857788, 2888.0180738548993, 2889.5954566360724, 493.81728760358897, 502.6581924291444, 518.3960685801075, 524.2686452398882, 527.8759491519489, 510.5864249957546, 526.7866514061811, 625.7841044839523, 658.0984051848902, 659.6009414304373, 7958.403119766041, 8194.672213111528, 8300.176227728174, 8362.289205417608, 8415.789605259795, 521.9634625576173, 588.3381196154327, 659.986800263992, 682.5802131689074, 684.5037347922716, 3891.9805400973382, 4064.0731353910633, 4065.89835254121, 4178.603032711888, 4187.539370669224, 51821.222681659805, 53857.0, 54312.0, 54316.45683543114, 54599.18101228485, 47071.764641176575, 47993.04013919702, 48587.51412485901, 49032.264516032286, 49560.50439495631, 43456.56543434588, 43716.0, 43759.99999999936, 44054.33918491161, 44538.77730611391, 7315.963420183078, 7399.852002959803, 7427.5914824683, 7581.734639287599, 7584.962075189589, 26646.733532664424, 27220.0, 28582.999595014906, 29542.704572954855, 29628.407431851672, 37368.62631373652, 37812.81093594625, 38328.42507362336, 38469.23061538697, 38998.22003559856, 10362.274640775073, 10965.396903170402, 11036.668899933014, 11048.392338421463, 11179.217454778087, 11404.030657393883, 11510.769784604094, 11706.35615041181, 11951.370698446328, 12035.157538972187, 11824.940875295568, 11951.880481195076, 12042.518299267931, 12668.0, 12854.164479308814, 10968.287061340987, 11580.942095289469, 11876.0, 12017.278963261882, 12138.150329477205, 10540.894591054299, 10723.624673136403, 10953.616623418142, 11131.165162612675, 11564.710882228012, 9845.360051596623, 9874.210063194783, 9978.451185184884, 9985.850212246676, 10305.269103687378, 8728.476291422536, 9286.59531293539, 9318.347715659838, 9629.085236902483, 9807.901920980985], "value": 6098.551337090924, "unit": "score"}], "name": "dromaeo_css", "value": 6352.293177716194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 112.0, 111.0, 113.0, 113.0, 111.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 159.0, 194.0, 134.0, 159.0, 161.0, 130.0, 201.0, 130.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 118.0, 75.0, 75.0, 75.0, 75.0, 127.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 119.0, 93.0, 93.0, 93.0, 126.0, 93.0, 94.0, 121.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 79.0, 65.0, 64.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 68.0, 64.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 93.0, 82.0, 84.0, 89.0, 84.0, 83.0, 83.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 130.0, 140.0, 138.0, 145.0, 130.0, 132.0, 167.0, 149.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 172.0, 176.0, 175.0, 171.0, 175.0, 174.0, 172.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 67.0, 71.0, 68.0, 68.0, 70.0, 67.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1570.5999999999997, "alertThreshold": 2.0}]} 15:45:12 INFO - Return code: 0 15:45:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:45:12 ERROR - # TBPL SUCCESS # 15:45:12 INFO - Running post-action listener: _resource_record_post_action 15:45:12 INFO - ##### 15:45:12 INFO - ##### Finished run-tests step (success) 15:45:12 INFO - ##### 15:45:12 INFO - Running post-run listener: _resource_record_post_run 15:45:14 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518545408; Read time: 16; Write time: 622976 15:45:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234778624; Read time: 0; Write time: 317512 15:45:14 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283766784; Read time: 16; Write time: 305464 15:45:14 INFO - Running post-run listener: _upload_blobber_files 15:45:14 INFO - Blob upload gear active. 15:45:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:14 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 15:45:14 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'] 15:45:14 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 15:45:14 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:45:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:15 INFO - (blobuploader) - INFO - Done attempting. 15:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:16 INFO - (blobuploader) - INFO - Done attempting. 15:45:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:16 INFO - Return code: 0 15:45:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06b2b832003195e369eef8ee804933ed5468ba2fad5efb60b40daff662828d3708f2b613a5a117607e1d28c09bb425f555eca39886648a0a720567572f1fc3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0104c15afcd20b4a7bf0328641f52658e6dceaa11102c983a4249afdca5ce32bb6db180fc73363767d892e05a9319bd52eb8ec653249b1120df895e3ac82a78b"} 15:45:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:16 INFO - Contents: 15:45:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06b2b832003195e369eef8ee804933ed5468ba2fad5efb60b40daff662828d3708f2b613a5a117607e1d28c09bb425f555eca39886648a0a720567572f1fc3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0104c15afcd20b4a7bf0328641f52658e6dceaa11102c983a4249afdca5ce32bb6db180fc73363767d892e05a9319bd52eb8ec653249b1120df895e3ac82a78b"} 15:45:16 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:16 INFO - Copying logs to upload dir... 15:45:16 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.670917 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 15:45:15.816269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:15.820152) ========= 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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 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/c06b2b832003195e369eef8ee804933ed5468ba2fad5efb60b40daff662828d3708f2b613a5a117607e1d28c09bb425f555eca39886648a0a720567572f1fc3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0104c15afcd20b4a7bf0328641f52658e6dceaa11102c983a4249afdca5ce32bb6db180fc73363767d892e05a9319bd52eb8ec653249b1120df895e3ac82a78b"} build_url:https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/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/c06b2b832003195e369eef8ee804933ed5468ba2fad5efb60b40daff662828d3708f2b613a5a117607e1d28c09bb425f555eca39886648a0a720567572f1fc3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0104c15afcd20b4a7bf0328641f52658e6dceaa11102c983a4249afdca5ce32bb6db180fc73363767d892e05a9319bd52eb8ec653249b1120df895e3ac82a78b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:15.845016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:15.845382) ========= 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=aa52b8aba932b19cc50b5275000001de-1462572320.324423-1684514117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:15.930419) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 15:45:15.930748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 15:45:15.931035) ========= ========= Total master_lag: 0.17 =========