builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1461776795.88 results: success (0) buildid: 20160427094755 builduid: 437cd82d99a6409690c348db3e6aa809 revision: 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:35.878306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:35.878787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:35.879086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:35.901249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:35.901560) ========= 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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 10:06:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-04-27 10:06:36 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.034604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.034945) ========= 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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016472 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.084904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.085324) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 --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 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 --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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 10:06:36,507 truncating revision to first 12 chars 2016-04-27 10:06:36,507 Setting DEBUG logging. 2016-04-27 10:06:36,507 attempt 1/10 2016-04-27 10:06:36,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/93c744e5c550?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 10:06:36,875 unpacking tar archive at: fx-team-93c744e5c550/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.795836) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.796183) ========= script_repo_revision: 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.796589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.796859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 10:06:36.803952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-27 10:06:36.804243) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:37 INFO - MultiFileLogger online at 20160427 10:06:37 in /builds/slave/test 10:06:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 10:06:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:37 INFO - {'append_to_log': False, 10:06:37 INFO - 'base_work_dir': '/builds/slave/test', 10:06:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:06:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:37 INFO - 'branch': 'Fx-Team-Non-PGO', 10:06:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:37 INFO - 'config_files': ('talos/linux_config.py',), 10:06:37 INFO - 'default_actions': ('clobber', 10:06:37 INFO - 'read-buildbot-config', 10:06:37 INFO - 'download-and-extract', 10:06:37 INFO - 'populate-webroot', 10:06:37 INFO - 'create-virtualenv', 10:06:37 INFO - 'install', 10:06:37 INFO - 'run-tests'), 10:06:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:37 INFO - 'download_minidump_stackwalk': True, 10:06:37 INFO - 'download_symbols': 'ondemand', 10:06:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:37 INFO - 'installer_path': 'installer.exe', 10:06:37 INFO - 'log_level': 'info', 10:06:37 INFO - 'log_name': 'talos', 10:06:37 INFO - 'log_to_console': True, 10:06:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:37 INFO - 'opt_config_files': (), 10:06:37 INFO - 'pip_index': False, 10:06:37 INFO - 'sps_profile': False, 10:06:37 INFO - 'sps_profile_interval': 0, 10:06:37 INFO - 'suite': 'dromaeojs-e10s', 10:06:37 INFO - 'system_bits': '32', 10:06:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:37 INFO - 'title': 'talos-linux64-ix-058', 10:06:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:37 INFO - 'use_talos_json': True, 10:06:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:37 INFO - 'work_dir': 'build'} 10:06:37 INFO - ##### 10:06:37 INFO - ##### Running clobber step. 10:06:37 INFO - ##### 10:06:37 INFO - Running pre-action listener: _resource_record_pre_action 10:06:37 INFO - Running main action method: clobber 10:06:37 INFO - rmtree: /builds/slave/test/build 10:06:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:37 INFO - Running post-action listener: _resource_record_post_action 10:06:37 INFO - ##### 10:06:37 INFO - ##### Running read-buildbot-config step. 10:06:37 INFO - ##### 10:06:37 INFO - Running pre-action listener: _resource_record_pre_action 10:06:37 INFO - Running main action method: read_buildbot_config 10:06:37 INFO - Using buildbot properties: 10:06:37 INFO - { 10:06:37 INFO - "project": "", 10:06:37 INFO - "product": "firefox", 10:06:37 INFO - "script_repo_revision": "production", 10:06:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:06:37 INFO - "repository": "", 10:06:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:06:37 INFO - "buildid": "20160427094755", 10:06:37 INFO - "pgo_build": "False", 10:06:37 INFO - "basedir": "/builds/slave/test", 10:06:37 INFO - "buildnumber": 1225, 10:06:37 INFO - "slavename": "talos-linux64-ix-058", 10:06:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:06:37 INFO - "platform": "ubuntu64_hw", 10:06:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:06:37 INFO - "branch": "fx-team", 10:06:37 INFO - "repo_path": "integration/fx-team", 10:06:37 INFO - "revision": "93c744e5c550c2265c29d5ef3c6fee4ddbcd6104", 10:06:37 INFO - "stage_platform": "linux64", 10:06:37 INFO - "builduid": "437cd82d99a6409690c348db3e6aa809", 10:06:37 INFO - "slavebuilddir": "test" 10:06:37 INFO - } 10:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:06:37 INFO - Running post-action listener: _resource_record_post_action 10:06:37 INFO - ##### 10:06:37 INFO - ##### Running download-and-extract step. 10:06:37 INFO - ##### 10:06:37 INFO - Running pre-action listener: _resource_record_pre_action 10:06:37 INFO - Running main action method: download_and_extract 10:06:37 INFO - mkdir: /builds/slave/test/build/tests 10:06: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')]} 10:06:37 INFO - https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:39 INFO - Downloaded 1361 bytes. 10:06:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:39 INFO - Using the following test package requirements: 10:06:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'jsshell-linux-x86_64.zip'], 10:06:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06:39 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')]} 10:06:39 INFO - https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:40 INFO - Downloaded 22294890 bytes. 10:06:40 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'] 10:06:40 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 10:06:41 INFO - Return code: 0 10:06:41 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 10:06:41 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')]} 10:06:41 INFO - https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:42 INFO - Downloaded 22294890 bytes. 10:06:42 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'] 10:06:42 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 10:06:44 INFO - Return code: 0 10:06: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')]} 10:06:44 INFO - https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:45 INFO - Downloaded 10840145 bytes. 10:06: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'] 10:06: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 10:06:46 INFO - Return code: 0 10:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:46 INFO - https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHdcqQHrT_-wbs363SOHWQ/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 10:06:49 INFO - Downloaded 54832710 bytes. 10:06:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:49 INFO - mkdir: /builds/slave/test/properties 10:06:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:49 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:49 INFO - Contents: 10:06:49 INFO - build_url:https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:06:50 INFO - Running post-action listener: _resource_record_post_action 10:06:50 INFO - Running post-action listener: set_extra_try_arguments 10:06:50 INFO - ##### 10:06:50 INFO - ##### Running populate-webroot step. 10:06:50 INFO - ##### 10:06:50 INFO - Running pre-action listener: _resource_record_pre_action 10:06:50 INFO - Running main action method: populate_webroot 10:06:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:50 INFO - '--tppagecycles', 10:06:50 INFO - '7'], 10:06:50 INFO - 'tests': ['tsvgm']}}, 10:06:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['damp', 'tps']}, 10:06:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'tests': ['damp', 'tps']}, 10:06:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['dromaeo_dom']}, 10:06:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['a11yr', 10:06:50 INFO - 'ts_paint', 10:06:50 INFO - 'tpaint', 10:06:50 INFO - 'sessionrestore', 10:06:50 INFO - 'sessionrestore_no_auto_restore', 10:06:50 INFO - 'tabpaint']}, 10:06:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['tsvgx', 10:06:50 INFO - 'tsvgr_opacity', 10:06:50 INFO - 'tart', 10:06:50 INFO - 'tscrollx', 10:06:50 INFO - 'cart']}, 10:06:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:50 INFO - 'tsvgr_opacity', 10:06:50 INFO - 'tart', 10:06:50 INFO - 'tscrollx', 10:06:50 INFO - 'cart']}, 10:06:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'talos_options': ['--disable-e10s'], 10:06:50 INFO - 'tests': ['tp5o']}, 10:06:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'tests': ['tp5o']}, 10:06:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'talos_options': ['--disable-e10s', 10:06:50 INFO - '--xperf_path', 10:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:50 INFO - 'tests': ['tp5n']}, 10:06:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:50 INFO - 'talos_options': ['--xperf_path', 10:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:50 INFO - 'tests': ['tp5n']}}, 10:06:50 INFO - 'talos.zip': {'path': '', 10:06:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:50 INFO - Running post-action listener: _resource_record_post_action 10:06:50 INFO - ##### 10:06:50 INFO - ##### Running create-virtualenv step. 10:06:50 INFO - ##### 10:06:50 INFO - Running pre-action listener: _resource_record_pre_action 10:06:50 INFO - Running main action method: create_virtualenv 10:06:50 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:50 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 10:06:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:50 INFO - Using real prefix '/usr' 10:06:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:51 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:53 INFO - Installing pip.................done. 10:06:53 INFO - Return code: 0 10:06:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:06: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', 'pip>=1.5'] in /builds/slave/test/build 10:06: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 pip>=1.5 10:06:53 INFO - Using env: {'DISPLAY': ':0', 10:06:53 INFO - 'HOME': '/home/cltbld', 10:06:53 INFO - 'LANG': 'en_US.UTF-8', 10:06:53 INFO - 'LANGUAGE': 'en_US:en', 10:06:53 INFO - 'LOGNAME': 'cltbld', 10:06:53 INFO - 'MAIL': '/var/mail/cltbld', 10:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:53 INFO - 'MOZ_NO_REMOTE': '1', 10:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:53 INFO - 'NO_EM_RESTART': '1', 10:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:53 INFO - 'PWD': '/builds/slave/test', 10:06:53 INFO - 'SHELL': '/bin/bash', 10:06:53 INFO - 'SHLVL': '1', 10:06:53 INFO - 'TERM': 'linux', 10:06:53 INFO - 'TMOUT': '86400', 10:06:53 INFO - 'USER': 'cltbld', 10:06:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:53 INFO - '_': '/tools/buildbot/bin/python'} 10:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:53 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 10:06:53 INFO - Cleaning up... 10:06:53 INFO - Return code: 0 10:06:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:06: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:06: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 psutil>=0.7.1 10:06:53 INFO - Using env: {'DISPLAY': ':0', 10:06:53 INFO - 'HOME': '/home/cltbld', 10:06:53 INFO - 'LANG': 'en_US.UTF-8', 10:06:53 INFO - 'LANGUAGE': 'en_US:en', 10:06:53 INFO - 'LOGNAME': 'cltbld', 10:06:53 INFO - 'MAIL': '/var/mail/cltbld', 10:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:53 INFO - 'MOZ_NO_REMOTE': '1', 10:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:53 INFO - 'NO_EM_RESTART': '1', 10:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:53 INFO - 'PWD': '/builds/slave/test', 10:06:53 INFO - 'SHELL': '/bin/bash', 10:06:53 INFO - 'SHLVL': '1', 10:06:53 INFO - 'TERM': 'linux', 10:06:53 INFO - 'TMOUT': '86400', 10:06:53 INFO - 'USER': 'cltbld', 10:06:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:53 INFO - '_': '/tools/buildbot/bin/python'} 10:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:53 INFO - Downloading/unpacking psutil>=0.7.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:55 INFO - Installing collected packages: psutil 10:06:55 INFO - Running setup.py install for psutil 10:06:55 INFO - building 'psutil._psutil_linux' extension 10:06:55 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 10:06:55 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 10:06:55 INFO - building 'psutil._psutil_posix' extension 10:06:55 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 10:06:56 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 10:06:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:56 INFO - Successfully installed psutil 10:06:56 INFO - Cleaning up... 10:06:56 INFO - Return code: 0 10:06:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:06: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:06: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 mozsystemmonitor==0.0.0 10:06:56 INFO - Using env: {'DISPLAY': ':0', 10:06:56 INFO - 'HOME': '/home/cltbld', 10:06:56 INFO - 'LANG': 'en_US.UTF-8', 10:06:56 INFO - 'LANGUAGE': 'en_US:en', 10:06:56 INFO - 'LOGNAME': 'cltbld', 10:06:56 INFO - 'MAIL': '/var/mail/cltbld', 10:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:56 INFO - 'MOZ_NO_REMOTE': '1', 10:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:56 INFO - 'NO_EM_RESTART': '1', 10:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:56 INFO - 'PWD': '/builds/slave/test', 10:06:56 INFO - 'SHELL': '/bin/bash', 10:06:56 INFO - 'SHLVL': '1', 10:06:56 INFO - 'TERM': 'linux', 10:06:56 INFO - 'TMOUT': '86400', 10:06:56 INFO - 'USER': 'cltbld', 10:06:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:56 INFO - '_': '/tools/buildbot/bin/python'} 10:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:06:58 INFO - Installing collected packages: mozsystemmonitor 10:06:58 INFO - Running setup.py install for mozsystemmonitor 10:06:58 INFO - Successfully installed mozsystemmonitor 10:06:58 INFO - Cleaning up... 10:06:58 INFO - Return code: 0 10:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:58 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')]} 10:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:58 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')]} 10:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:58 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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:06:58 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 10:06:58 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 10:06:58 INFO - Using env: {'DISPLAY': ':0', 10:06:58 INFO - 'HOME': '/home/cltbld', 10:06:58 INFO - 'LANG': 'en_US.UTF-8', 10:06:58 INFO - 'LANGUAGE': 'en_US:en', 10:06:58 INFO - 'LOGNAME': 'cltbld', 10:06:58 INFO - 'MAIL': '/var/mail/cltbld', 10:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:58 INFO - 'MOZ_NO_REMOTE': '1', 10:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:58 INFO - 'NO_EM_RESTART': '1', 10:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:58 INFO - 'PWD': '/builds/slave/test', 10:06:58 INFO - 'SHELL': '/bin/bash', 10:06:58 INFO - 'SHLVL': '1', 10:06:58 INFO - 'TERM': 'linux', 10:06:58 INFO - 'TMOUT': '86400', 10:06:58 INFO - 'USER': 'cltbld', 10:06:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:58 INFO - '_': '/tools/buildbot/bin/python'} 10:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:07:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:00 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 10:07:00 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 10:07:00 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 10:07:00 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 10:07:00 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 10:07:00 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 10:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:01 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 10:07:01 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 10:07:01 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 10:07:01 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 10:07:01 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 10:07:01 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 10:07:01 INFO - Downloading docopt-0.6.1.tar.gz 10:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:01 INFO - Running setup.py install for blobuploader 10:07:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:01 INFO - Running setup.py install for requests 10:07:01 INFO - Running setup.py install for docopt 10:07:01 INFO - Successfully installed blobuploader requests docopt 10:07:01 INFO - Cleaning up... 10:07:01 INFO - Return code: 0 10:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:07:01 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 10:07:01 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 10:07:01 INFO - Using env: {'DISPLAY': ':0', 10:07:01 INFO - 'HOME': '/home/cltbld', 10:07:01 INFO - 'LANG': 'en_US.UTF-8', 10:07:01 INFO - 'LANGUAGE': 'en_US:en', 10:07:01 INFO - 'LOGNAME': 'cltbld', 10:07:01 INFO - 'MAIL': '/var/mail/cltbld', 10:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:01 INFO - 'MOZ_NO_REMOTE': '1', 10:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:01 INFO - 'NO_EM_RESTART': '1', 10:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:01 INFO - 'PWD': '/builds/slave/test', 10:07:01 INFO - 'SHELL': '/bin/bash', 10:07:01 INFO - 'SHLVL': '1', 10:07:01 INFO - 'TERM': 'linux', 10:07:01 INFO - 'TMOUT': '86400', 10:07:01 INFO - 'USER': 'cltbld', 10:07:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:01 INFO - '_': '/tools/buildbot/bin/python'} 10:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:02 INFO - Running setup.py (path:/tmp/pip-fhErKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:02 INFO - Running setup.py (path:/tmp/pip-eI1iQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:02 INFO - Running setup.py (path:/tmp/pip-wcpGB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:02 INFO - Running setup.py (path:/tmp/pip-I22jnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:02 INFO - Running setup.py (path:/tmp/pip-rxvKSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:02 INFO - Running setup.py (path:/tmp/pip-MJhmxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:02 INFO - Running setup.py (path:/tmp/pip-HM3VS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:02 INFO - Running setup.py (path:/tmp/pip-N_3CYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:02 INFO - Running setup.py (path:/tmp/pip-0apwLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:02 INFO - Running setup.py (path:/tmp/pip-ZlyR5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:02 INFO - Running setup.py (path:/tmp/pip-Vl70rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:02 INFO - Running setup.py (path:/tmp/pip-dkl9iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:03 INFO - Running setup.py (path:/tmp/pip-WzWc5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:03 INFO - Running setup.py (path:/tmp/pip-7xWEXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:03 INFO - Running setup.py (path:/tmp/pip-RTind7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:03 INFO - Running setup.py (path:/tmp/pip-oNr0Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:03 INFO - Running setup.py (path:/tmp/pip-qai_c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:03 INFO - Running setup.py install for manifestparser 10:07:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:03 INFO - Running setup.py install for mozcrash 10:07:03 INFO - Running setup.py install for mozdebug 10:07:03 INFO - Running setup.py install for mozdevice 10:07:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:03 INFO - Running setup.py install for mozfile 10:07:03 INFO - Running setup.py install for mozhttpd 10:07:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:03 INFO - Running setup.py install for mozinfo 10:07:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for mozInstall 10:07:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for mozleak 10:07:04 INFO - Running setup.py install for mozlog 10:07:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for moznetwork 10:07:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for mozprocess 10:07:04 INFO - Running setup.py install for mozprofile 10:07:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for mozrunner 10:07:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:04 INFO - Running setup.py install for mozscreenshot 10:07:04 INFO - Running setup.py install for moztest 10:07:05 INFO - Running setup.py install for mozversion 10:07:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:05 INFO - Cleaning up... 10:07:05 INFO - Return code: 0 10:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:05 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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:07:05 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 10:07:05 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 10:07:05 INFO - Using env: {'DISPLAY': ':0', 10:07:05 INFO - 'HOME': '/home/cltbld', 10:07:05 INFO - 'LANG': 'en_US.UTF-8', 10:07:05 INFO - 'LANGUAGE': 'en_US:en', 10:07:05 INFO - 'LOGNAME': 'cltbld', 10:07:05 INFO - 'MAIL': '/var/mail/cltbld', 10:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:05 INFO - 'MOZ_NO_REMOTE': '1', 10:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:05 INFO - 'NO_EM_RESTART': '1', 10:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:05 INFO - 'PWD': '/builds/slave/test', 10:07:05 INFO - 'SHELL': '/bin/bash', 10:07:05 INFO - 'SHLVL': '1', 10:07:05 INFO - 'TERM': 'linux', 10:07:05 INFO - 'TMOUT': '86400', 10:07:05 INFO - 'USER': 'cltbld', 10:07:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:05 INFO - '_': '/tools/buildbot/bin/python'} 10:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:05 INFO - Running setup.py (path:/tmp/pip-ZOo4XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:05 INFO - Running setup.py (path:/tmp/pip-hVTViY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:05 INFO - Running setup.py (path:/tmp/pip-dTg6Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:05 INFO - Running setup.py (path:/tmp/pip-OW63xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:05 INFO - Running setup.py (path:/tmp/pip-PTV5PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:05 INFO - Running setup.py (path:/tmp/pip-t_Az5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:05 INFO - Running setup.py (path:/tmp/pip-UFbAV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:05 INFO - Running setup.py (path:/tmp/pip-OhvDio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:05 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)) 10:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:05 INFO - Running setup.py (path:/tmp/pip-TMrzNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:06 INFO - Running setup.py (path:/tmp/pip-siHfmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:06 INFO - Running setup.py (path:/tmp/pip-hNRD1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:06 INFO - Running setup.py (path:/tmp/pip-3g0hfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:06 INFO - Running setup.py (path:/tmp/pip-2CIMeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:06 INFO - Running setup.py (path:/tmp/pip-fKgEPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:06 INFO - Running setup.py (path:/tmp/pip-Tez10L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:06 INFO - Running setup.py (path:/tmp/pip-hVAX9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:06 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)) 10:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:06 INFO - Running setup.py (path:/tmp/pip-_JhT8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:06 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)) 10:07:06 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)) 10:07:06 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)) 10:07:06 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)) 10:07:06 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)) 10:07:06 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)) 10:07:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:08 INFO - Downloading blessings-1.6.tar.gz 10:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:08 INFO - Installing collected packages: blessings 10:07:08 INFO - Running setup.py install for blessings 10:07:08 INFO - Successfully installed blessings 10:07:08 INFO - Cleaning up... 10:07:08 INFO - Return code: 0 10:07:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:08 INFO - Reading from file tmpfile_stdout 10:07:08 INFO - Current package versions: 10:07:08 INFO - argparse == 1.2.1 10:07:08 INFO - blessings == 1.6 10:07:08 INFO - blobuploader == 1.2.4 10:07:08 INFO - docopt == 0.6.1 10:07:08 INFO - manifestparser == 1.1 10:07:08 INFO - mozInstall == 1.12 10:07:08 INFO - mozcrash == 0.17 10:07:08 INFO - mozdebug == 0.1 10:07:08 INFO - mozdevice == 0.48 10:07:08 INFO - mozfile == 1.2 10:07:08 INFO - mozhttpd == 0.7 10:07:08 INFO - mozinfo == 0.9 10:07:08 INFO - mozleak == 0.1 10:07:08 INFO - mozlog == 3.1 10:07:08 INFO - moznetwork == 0.27 10:07:08 INFO - mozprocess == 0.22 10:07:08 INFO - mozprofile == 0.28 10:07:08 INFO - mozrunner == 6.11 10:07:08 INFO - mozscreenshot == 0.1 10:07:08 INFO - mozsystemmonitor == 0.0 10:07:08 INFO - moztest == 0.7 10:07:08 INFO - mozversion == 1.4 10:07:08 INFO - psutil == 3.1.1 10:07:08 INFO - requests == 1.2.3 10:07:08 INFO - wsgiref == 0.1.2 10:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:08 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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:07:08 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 10:07:08 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 10:07:08 INFO - Using env: {'DISPLAY': ':0', 10:07:08 INFO - 'HOME': '/home/cltbld', 10:07:08 INFO - 'LANG': 'en_US.UTF-8', 10:07:08 INFO - 'LANGUAGE': 'en_US:en', 10:07:08 INFO - 'LOGNAME': 'cltbld', 10:07:08 INFO - 'MAIL': '/var/mail/cltbld', 10:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:08 INFO - 'MOZ_NO_REMOTE': '1', 10:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:08 INFO - 'NO_EM_RESTART': '1', 10:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:08 INFO - 'PWD': '/builds/slave/test', 10:07:08 INFO - 'SHELL': '/bin/bash', 10:07:08 INFO - 'SHLVL': '1', 10:07:08 INFO - 'TERM': 'linux', 10:07:08 INFO - 'TMOUT': '86400', 10:07:08 INFO - 'USER': 'cltbld', 10:07:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:08 INFO - '_': '/tools/buildbot/bin/python'} 10:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 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)) 10:07:09 INFO - Cleaning up... 10:07:09 INFO - Return code: 0 10:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:07: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', 'jsonschema'] in /builds/slave/test/build 10:07: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 jsonschema 10:07:09 INFO - Using env: {'DISPLAY': ':0', 10:07:09 INFO - 'HOME': '/home/cltbld', 10:07:09 INFO - 'LANG': 'en_US.UTF-8', 10:07:09 INFO - 'LANGUAGE': 'en_US:en', 10:07:09 INFO - 'LOGNAME': 'cltbld', 10:07:09 INFO - 'MAIL': '/var/mail/cltbld', 10:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:09 INFO - 'MOZ_NO_REMOTE': '1', 10:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:09 INFO - 'NO_EM_RESTART': '1', 10:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:09 INFO - 'PWD': '/builds/slave/test', 10:07:09 INFO - 'SHELL': '/bin/bash', 10:07:09 INFO - 'SHLVL': '1', 10:07:09 INFO - 'TERM': 'linux', 10:07:09 INFO - 'TMOUT': '86400', 10:07:09 INFO - 'USER': 'cltbld', 10:07:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:09 INFO - '_': '/tools/buildbot/bin/python'} 10:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:09 INFO - Downloading/unpacking jsonschema 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:11 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:11 INFO - warning: no files found matching '*.txt' 10:07:11 INFO - no previously-included directories found matching 'build' 10:07:11 INFO - no previously-included directories found matching 'dist' 10:07:11 INFO - no previously-included directories found matching '.git*' 10:07:11 INFO - Installing collected packages: jsonschema, functools32 10:07:11 INFO - Running setup.py install for functools32 10:07:11 INFO - warning: no files found matching '*.txt' 10:07:11 INFO - no previously-included directories found matching 'build' 10:07:11 INFO - no previously-included directories found matching 'dist' 10:07:11 INFO - no previously-included directories found matching '.git*' 10:07:11 INFO - Successfully installed jsonschema functools32 10:07:11 INFO - Cleaning up... 10:07:11 INFO - Return code: 0 10:07:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07:11 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')]} 10:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 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')]} 10:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 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 0x7f2bf6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', '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 10:07:11 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 10:07:11 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 10:07:11 INFO - Using env: {'DISPLAY': ':0', 10:07:11 INFO - 'HOME': '/home/cltbld', 10:07:11 INFO - 'LANG': 'en_US.UTF-8', 10:07:11 INFO - 'LANGUAGE': 'en_US:en', 10:07:11 INFO - 'LOGNAME': 'cltbld', 10:07:11 INFO - 'MAIL': '/var/mail/cltbld', 10:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:11 INFO - 'MOZ_NO_REMOTE': '1', 10:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:11 INFO - 'NO_EM_RESTART': '1', 10:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:11 INFO - 'PWD': '/builds/slave/test', 10:07:11 INFO - 'SHELL': '/bin/bash', 10:07:11 INFO - 'SHLVL': '1', 10:07:11 INFO - 'TERM': 'linux', 10:07:11 INFO - 'TMOUT': '86400', 10:07:11 INFO - 'USER': 'cltbld', 10:07:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:11 INFO - '_': '/tools/buildbot/bin/python'} 10:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:11 INFO - Downloading/unpacking flake8 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 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 10:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:14 INFO - no previously-included directories found matching 'docs/_build' 10:07:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:14 INFO - Running setup.py install for pep8 10:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:14 INFO - no previously-included directories found matching 'docs/_build' 10:07:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:14 INFO - Cleaning up... 10:07:15 INFO - Return code: 0 10:07:15 INFO - Running post-action listener: _resource_record_post_action 10:07:15 INFO - Running post-action listener: _start_resource_monitoring 10:07:16 INFO - Starting resource monitoring. 10:07:16 INFO - ##### 10:07:16 INFO - ##### Running install step. 10:07:16 INFO - ##### 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: install 10:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:16 INFO - Reading from file tmpfile_stdout 10:07:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:16 INFO - Reading from file tmpfile_stdout 10:07:16 INFO - Output received: 10:07:16 INFO - Usage: mozinstall [options] installer 10:07:16 INFO - Options: 10:07:16 INFO - -h, --help show this help message and exit 10:07:16 INFO - -d DEST, --destination=DEST 10:07:16 INFO - Directory to install application into. [default: 10:07:16 INFO - "/builds/slave/test"] 10:07:16 INFO - --app=APP Application being installed. [default: firefox] 10:07:16 INFO - mkdir: /builds/slave/test/build/application 10:07:16 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'] 10:07:16 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 10:07:32 INFO - Reading from file tmpfile_stdout 10:07:32 INFO - Output received: 10:07:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:32 INFO - Running post-action listener: _resource_record_post_action 10:07:32 INFO - ##### 10:07:32 INFO - ##### Running run-tests step. 10:07:32 INFO - ##### 10:07:32 INFO - Running pre-action listener: _resource_record_pre_action 10:07:32 INFO - Running main action method: run_tests 10:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:32 INFO - Python 2.7.3 10:07:32 INFO - Return code: 0 10:07:32 INFO - grabbing minidump binary from tooltool 10:07: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')]} 10:07:32 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 0xdf0410>, '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 0xdf1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:32 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 10:07:32 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 10:07:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:32 INFO - Return code: 0 10:07:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:33 INFO - Return code: 0 10:07:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:07:33 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:07:33 INFO - Using env: {'DISPLAY': ':0', 10:07:33 INFO - 'HOME': '/home/cltbld', 10:07:33 INFO - 'LANG': 'en_US.UTF-8', 10:07:33 INFO - 'LANGUAGE': 'en_US:en', 10:07:33 INFO - 'LOGNAME': 'cltbld', 10:07:33 INFO - 'MAIL': '/var/mail/cltbld', 10:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:33 INFO - 'MOZ_NO_REMOTE': '1', 10:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:33 INFO - 'NO_EM_RESTART': '1', 10:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:33 INFO - 'PWD': '/builds/slave/test', 10:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:33 INFO - 'SHELL': '/bin/bash', 10:07:33 INFO - 'SHLVL': '1', 10:07:33 INFO - 'TERM': 'linux', 10:07:33 INFO - 'TMOUT': '86400', 10:07:33 INFO - 'USER': 'cltbld', 10:07:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776', 10:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:33 INFO - '_': '/tools/buildbot/bin/python'} 10:07:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:07:33 INFO - mozversion application_buildid: 20160427094755 10:07:33 INFO - mozversion application_changeset: 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 10:07:33 INFO - mozversion application_display_name: Nightly 10:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:33 INFO - mozversion application_name: Firefox 10:07:33 INFO - mozversion application_remotingname: firefox 10:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:07:33 INFO - mozversion application_vendor: Mozilla 10:07:33 INFO - mozversion application_version: 49.0a1 10:07:33 INFO - mozversion platform_buildid: 20160427094755 10:07:33 INFO - mozversion platform_changeset: 93c744e5c550c2265c29d5ef3c6fee4ddbcd6104 10:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:07:33 INFO - mozversion platform_version: 49.0a1 10:07:33 INFO - using testdate: 1461776853 10:07:33 INFO - actual date: 1461776853 10:07:33 INFO - starting webserver on 'localhost:42335' 10:07:33 INFO - SUITE-START | Running 2 tests 10:07:33 INFO - TEST-START | dromaeo_css 10:07:33 INFO - operating with platform_type : linux_ 10:07:33 INFO - Initialising browser for dromaeo_css test... 10:07:33 INFO - TEST-INFO | started process 7347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYf4wWY/profile http://localhost:42335/getInfo.html) 10:07:37 INFO - PROCESS | 7347 | 10:07:37 INFO - PROCESS | 7347 | (process:7417): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:38 INFO - PROCESS | 7347 | __metrics Screen width/height:1600/1200 10:07:38 INFO - PROCESS | 7347 | colorDepth:24 10:07:38 INFO - PROCESS | 7347 | Browser inner width/height: 1024/697 10:07:38 INFO - PROCESS | 7347 | __metrics 10:07:39 ERROR - PROCESS | 7347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:07:40 INFO - TEST-INFO | 7347: exit 0 10:07:40 INFO - Browser initialized. 10:07:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:40 INFO - TEST-INFO | started process 7468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYf4wWY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:42 INFO - PROCESS | 7468 | 10:07:42 INFO - PROCESS | 7468 | (process:7529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:52 INFO - PROCESS | 7468 | RSS: Main: 165896192 10:07:52 INFO - PROCESS | 7468 | 10:08:41 INFO - PROCESS | 7468 | 1461776921720 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] 10:10:53 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42335/tests/dromaeo/cssquery-ext.html) 10:10:54 INFO - PROCESS | 7468 | RSS: Main: 169586688 10:10:54 INFO - PROCESS | 7468 | 10:13:56 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-ext.html (next: http://localhost:42335/tests/dromaeo/cssquery-jquery.html) 10:13:57 INFO - PROCESS | 7468 | RSS: Main: 167317504 10:13:57 INFO - PROCESS | 7468 | 10:16:59 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42335/tests/dromaeo/cssquery-mootools.html) 10:16:59 INFO - PROCESS | 7468 | RSS: Main: 168181760 10:16:59 INFO - PROCESS | 7468 | 10:20:01 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42335/tests/dromaeo/cssquery-prototype.html) 10:20:02 INFO - PROCESS | 7468 | RSS: Main: 165646336 10:20:02 INFO - PROCESS | 7468 | 10:23:04 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42335/tests/dromaeo/cssquery-yui.html) 10:23:05 INFO - PROCESS | 7468 | RSS: Main: 167387136 10:23:05 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:42335/tests/dromaeo/cssquery-yui.html (next: http://localhost:42335/tests/dromaeo/cssquery-dojo.html) 10:26:08 INFO - PROCESS | 7468 | RSS: Main: 169635840 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | __start_tp_report 10:26:08 INFO - PROCESS | 7468 | _x_x_mozilla_page_load 10:26:08 INFO - PROCESS | 7468 | _x_x_mozilla_page_load_details 10:26:08 INFO - PROCESS | 7468 | |i|pagename|runs| 10:26:08 INFO - PROCESS | 7468 | |0;dojo.html;2635.934101647458;2644.907428240012;2708.5937109433585;2714.1586108306415;2714.1857442767177;4745.976270118653;4769.546893045163;4794.280857871317;4799.040191961613;4815.277708343741;4726.361941137945;4777.402824646919;4808.783604737787;4860.538248866361;4867.975660121703;4448.310511870657;4493.955060449386;4525.524819893913;4542.8188670945465;4549.226631472658;4410.831129750619;4495.617872480827;4513.774311284423;4546.522615125414;4552.9528208512065;4350.7607081610495;4379.233634114017;4401.449818772653;4432.202203603366;4498.415206023229;4366.541513141106;4394.099209662011;4395.934060989088;4411.470623525165;4447;4395.09900470406;4403.955960440387;4406.471223453174;4412.514623391425;4440.822367105312;4715.056988602293;4744.667873248874;4777.402824646919;4816.301636262758;4822.855314340575;5027.4721154279005;5046.5710414614805;5056.988602279559;5060.9493905060845;5081.949180508184;5041.823536176253;5072.6195535335;5074.13739664258;5075.6447048706605;5108.182690769496;4802.4237091548885;4847.830325938575;4865.270209468608;4892.828750993734;4899.485554016848;5317.096093664087;5372.7313634318125;5373.2208829719475;5379.973100134474;5389.51494365509;4944.9258261126115;5120.4111527174855;5135.614828887774;5139.12634852076;5149.407818100892;5198.428172900978;5202.869928251824;5209.426963034063;5223.268742376071;5254.185601231815;4988.201887697951;5140.023395554907;5153.2785410042625;5205.063088644005;5239.240310155083;5013.799448022111;5056.938043011009;5062.848114556569;5079.644424890296;5180.300659410931;4316.784160791948;4332.566743325705;4339.067100573392;4358.171947329997;4383.583559561836;3754.9249015019545;3782.5460944686265;3800.771953682788;3819.598942111094;3838.0213045673177;4414.27164517851;4499.10017996402;4549.249373853343;4551.385562949025;4608.608268297232;5230.895382092413;5249.816256431083;5260.789568417221;5262.815801446931;5298.682079075191;4564.269716845289;4566.97716511422;4569.360289559398;4579.793909274091;4608.400907882021;4486.7083639563325;4654.976725116353;4713.151632706145;4714.151452738472;4738.47876733559;4898;4922.680025798311;4932.235503496964;4946.431160416598;4988.326575912205;5214.8957020860125;5218.765155568084;5219.660722053054;5232.529072383504;5239.790408383775;4785.545373189541;4902.313676085279;4949.331840201527;4983.053219888209;5009.298698182331;5046.798128074983;5085.084684756779;5102.642815002914;5105;5124.436312005751;5078.695278283315;5154.5103215194495;5173.430922598436;5198.298229739088;5200.713960732196;4915.21356582945;4948.678335908155;5000.6249531284575;5080.288759573737;5105.2342148678;5043.36957880265;5053.823116190915;5067.265246539305;5101.234814777813;5111;4949.109160351171;4970.155073637418;4970.7514624267915;4981.302617633607;5029.145045342228;5000.87497812543;5053.59571234293;5096.872578185426;5150.381954165524;5165.018646457161;4897.4857639947295;4899.902001960012;4940.061388336205;4940.333055037668;4968.552830245295 10:26:08 INFO - PROCESS | 7468 | |1;ext.html;578.3580225949196;601.6209787833666;608.680442767547;627.5544363501914;630.143005512503;32110.715571377146;32389.838050809773;32445.67554324456;32881.342373152525;32957;35318;35925;35936.82031589838;36305.45541816875;36528.81735591318;7397.889031664529;7583.772486825376;7598.73404430845;7612.086549614054;7655.808604784897;7453.850922981537;7546.169921308651;7554.924450755477;7575.545467271982;7607.315341619254;7582.848343033136;7586.203448637896;7591.392688584928;7658.770236892902;7661.578613176273;7516.436267279949;7550.773476795677;7627.427942904276;7631.275028872248;7635.23647635232;7601.581912994783;7628.771136865903;7682.807929801744;7684.615769211517;7710.460267781257;24849.87575062131;33301.833490832636;33754.32491350184;33775;33857;2878.2228798224573;2987.1785259053718;3088.181631867557;3104.5343198520177;3127.37452509499;25901;26323.868380657976;26731.465370692673;26774.464510709677;26951.59572606393;3338.315645292709;3339.6493368196475;3366.6454740522945;3480.112571294329;3484.756067075306;187715;189628;191367;191593.9999999986;192800;52599.73700131475;53088.203676944875;53201.46798532043;53201.73399133057;53283.46716532785;43408.782956085015;44735.32897006548;45018.32472512915;54467.72766136223;54567.18149227765;14801.407943682347;15053.473128440452;15148.545543633709;15191.468298609716;15218.543443696706;11245.381504017358;11538.538458461568;11565.826512602318;11567.479463424166;11575;17158.31366745341;17403.564910877078;17411.912940435217;17484;17570.736438953427;7175.497715159993;7325.267473252632;7412.518186317872;7440.85118297631;7454.254574542502;864.6333240788572;939.2251392601131;1023.5803320638503;1031.1956673794452;1075.956961721538;26233.52165725062;26804.463910721675;27133.728662713514;27144.321391965357;27436.588451173247;1026.8151732688189;1041.2450973044633;1080.6649938519083;1107.3577325151393;1148.328227986637;13916.165030098024;14333.928330358282;14417.3571674732;14535.127892326494;14633.195174265305;255035;257823;258123;258359;258598;43748;44931;44932.77533612376;45151.322730159074;45224.79914809839;1218.0499210615733;1249.6001279590625;1249.9937500312622;1256.9120161588785;1272.9688951948951;26015;26338.473230535667;26662.06682766094;26756.732432675424;27176.1847144586;39532.60467395404;39620.2075958485;40007.59992400155;40071.799641001606;40073.79963100166;233840;234986;235569;235578;236337;24444.14445494399;24467.51064978655;24577.385565361008;24781;24800.50398991974;37886.810565946995;38495.615043850325;38812.80593597014;38829;39644.405333919436;32764.67235327616;33415.66584334125;33586.49620255747;33808.3238335227;34272.65727342795;33532.32935341328;33763.32473350568;34046.14884627805;34228.315433691685;34304;26551;30976.22559435942;31443.37113257676;33356.666433335355;33479.66520334766;27894;28132.85933570319;29360.55959160657;30324.393512130075;30589;23624.409389765395;24026.996625421823;24188.879055605314;24450.266492005267;24542.631860522462 10:26:08 INFO - PROCESS | 7468 | |2;jquery.html;383.61638361638364;391.0302449924187;394.3650722337037;394.6753278708691;395.32596922247563;12246.693832654188;14682.192479413628;14856.925715371435;15260.00809947354;15266.236688165589;15516.534503964898;15612;15757.684846303067;15845;16297.755533667005;4833.80366106437;4874.561289483946;4983.626228032894;5008.348914641109;5013.974930125344;4915.557599816016;4961.107000739866;4993.725345106018;4995;5004.374453193351;4899.3385892904535;4941.579965702919;4953.356063711731;4961.6278779091535;5001.6998980061135;4834.057358815033;4922.483139270379;4969.18008528596;4988.401391832985;4997.750112494361;4457.796394973371;4459.175052615245;4468.218061839198;4472.619827314682;4472.8881777955485;17561.20974556135;18179;18849.434516964513;18895.244190232374;18945.33691320797;1713.4003098915405;1952.4630726550313;1983.8512111591688;1989.2142603671614;2061.7319748432756;8728.60721267538;8804.383693141483;8895.110488951117;8897.822043559157;9045.638174473013;1745.572334777975;1778.9555261118446;1782.073321872619;1783.7146056630877;1832.138894719493;51753.7412312936;54692.45307546914;55172.448275517134;55878.44121558814;56353.71823140899;9256.352055356196;9644.373115747454;9858.063483969012;9880.703578892644;10121.746956326004;11833.704157395961;12545.12184147101;13762.862371376157;13764.862351376358;13770.586882393543;7244.565326080452;7308.817279567947;7321.158066822277;7410.296021878021;7445.36714379273;6976.860462790817;7004.614746189009;7169.6773645186095;7189.820254493679;7221.350078492856;3997.340438827561;4048.935043127967;4257.74453532789;4370.497392799869;4376.277914144131;1818.472642933561;1864.794872564017;1879.4831421359236;1904.3334832808682;1958.067056817844;818.5252553518944;883.9878339301464;891.9866202006975;921.709661456639;974.8196583632051;14811.629709257355;14812.851871481147;15147.621309467351;15407.61480962985;15679.68640627181;876.1807709791366;907.7503686486269;909.3725329522608;924.9537523123817;967.2165545907837;8561.828763424697;8711.259542938795;8794.164554367326;8892.822143557221;8995.145461181177;347232;356639;359693;364182;365072;42252.78873605612;44598.33102503465;70642;73691.63154184195;74104;938.7418459923439;953.6852838563258;959.1990687775785;967.8548217767251;973.9123478886934;9577.664781732607;9803.313768036169;9925.35485193489;10015.14871235953;14538;23955.640665390383;31173.37653246877;31708.207294817814;33752.66247337495;35961.460578090824;38771.41842872303;42773.35839962341;43675.56324436842;44315;44922;9971.650992215238;10025.498725063571;10253.282270241012;10380.273380863267;10599.947000264949;6269.811905642838;9391.765205869908;11243.943780281046;11392.772144556897;11436.19946603763;7373.852522949618;7379.298966598165;7419.07261592301;9655.372400793925;10409.271351005356;7324.267573242633;7343.742968996059;7410.96294518524;7441.888371674321;7451.701931922662;7334.486585938933;7398.075240594926;7442.330190282901;7475.439342049477;7533.322001019935;10433.739156520844;10439.11267542237;10554.261201715806;10607.20445966571;10695.732606684895;9496.002919693332;9606.327557070937;9697.566899077843;9806;9869.802603948025 10:26:08 INFO - PROCESS | 7468 | |3;mootools.html;1448.4495891561203;1494.775783632455;1597.3131553432027;1762.8765986380959;1781.9753641656043;6547;7387.667554960026;7506.099268087837;7672.6930922763095;7695.538267703928;7469.701211951529;7504.924950750491;7534.171241163468;7563.470557061008;7573.053368328959;2209.6795964585126;2259.6271615183473;2261.807746341563;2264.830137739676;2272.1593010586107;2219.178903805594;2233.062113912161;2283.9771602284013;2284.6344584866424;2287.668288098225;2277.840551161419;2285.268714011517;2286.2912497125944;2297.448612333036;2307.40007598024;2238.529908719171;2258.3450799268194;2260.2654137405407;2264.1735766445213;2266.0256089881345;2190.353845615547;2211.07135003299;2211.800937915595;2212.6127927612765;2223.132978138527;7637.083549973983;7702.383809295243;7734.226577342277;7741.961290193569;7760;4584.816607335736;4754.215554433515;4754.9286760698615;4764.666473346867;4778.976105119452;2944.6319210098736;2958.6745457999605;3096.256898344381;3109.7250127447637;3149.1339881532763;982.1602529836958;990.3810118675827;1000.1448761309049;1016.8017236638858;1028.6091285311609;10072.446015469146;10101.040401161878;10110.393376397366;10116.89883101167;10126.139278161365;4242.596953289432;4268.829246830154;4312.590303921185;4401.625861801719;4405.0969551241915;8692.78268043304;8757.956210218908;8766.956165219133;8778.648854045894;8794.91205087941;4704.341392205094;4762.738049407316;4787.497312782178;4787.904241915212;4823.758812059383;3736.308782875177;4164.937525937114;4321.157374312042;4347.934780978288;4374.256376416017;3639.727020473475;3646.1249300168297;3654.9817250913575;3674.4488326751202;3684.1894783147663;1227.8526576810661;1228.6744012836605;1240.1690867119053;1254.5295514182183;1258.4714419943646;772.3473664753275;909.9727008189765;919.5172534419484;929.5027160469117;930.0467021303083;5150.639455238097;5237.9476205238225;5283.128283833202;5397.433269506724;5443.972780136074;425.85520922886366;430.5758827554856;434.95432979537327;437.91241751649795;444.034225559407;3639.8180090995343;3640.381135207021;3677.724170687209;3731.9813400933363;3738.682212011955;9009.684661036963;9381.812363752686;9448.763780905532;9469.715908522756;9507.239420846316;8567.100454452193;8894.688685895962;8904.955475222712;8949.194572488377;8958.238549723346;6870.20992585859;6986.196587392414;6999.055127557816;7002.474814388941;7064.222935477196;5482.616216864941;5514.80698175562;5555.416681248573;5580.637258578179;5596.38439771633;8476.618552165044;8696.17386348296;8702.347323950855;8715.956420217859;8824.5587720615;8030.6787728492545;8533.274671652978;8585.055643879294;8600;8835.734927952171;5891.293044834647;6349.746010159542;6421.261554921244;6469.223693156851;6588.670566471561;7194.136703595602;7279.381252593589;7298.2701729826595;7318.560886346836;7348.154962179204;6301.40136687014;6634.933650663432;6642.302558231316;6644.136262285871;6709;6540.640264785482;6622.271550129385;6654.268030516542;6679.866402672016;6753.628550429774;6017.18767966319;6183.072539119168;6203.627782333075;6206.751729930752;6210.3168651449205;4444.777761111867;4515.7967891444305;4607.585317321457;4656.278276867091;4656.720596764205;4583.9541604584865;4600.148972440109;4607.6083532900075;4658.324542941323;4666.206744853315 10:26:08 INFO - PROCESS | 7468 | |4;prototype.html;290.60187543066;291.727235035242;297.21831582936875;297.5759542651721;309.105140617911;4801.90396192076;4896;4923.187674033785;5030.730025483433;5036.773345199465;4943.975280123604;4962.702237865721;4977.925331120036;4989.301497790303;4999.400071991357;3901.8979910970847;3903.555684396777;3906.6321895310602;3911.1004468972155;3912.454580440731;3636.672699457048;3920.5099362579676;3928.0769019280447;3932.941005884914;3940.665043471294;3790.0714324990277;3815.332316844555;3823.3691440912216;3864.7487913285545;3873.2253549290112;3827.9808600957094;3849.480320156771;3855.5951625079383;3856.749311294757;3859.4755071746504;3348.3303339331987;3361.8151001694896;3364.8822291219935;3386.356592247465;3399.847006884696;4717;4768.904621907577;4806.3511425957395;4818.16909574363;4822.324874517535;4331.6318112960125;4336.1978034063795;4337.522872484024;4349.456317960255;4400.515943246241;5091.745412729349;5125.410577783528;5126.53861152498;5161.380634323905;5166.715830629314;3555.1112221944513;3576.46353047045;3644.8177591120602;3654.086478380405;3666.2667466506805;5347.51872331492;5355.866103347408;5356;5376.924615077;5399.892002159974;3676.411774116182;3695.427208782643;3717.70258379329;3719.4420836874683;3733.757305775116;3727.6458736419995;3780.981095094507;3784.6215378461934;3793.336166170964;3795.7532760370486;4083.3670781028986;4320.740755554677;4333.328334108218;4360.672949528798;4378.365137055109;5162.819301324435;5170.6814762236145;5192.143296356135;5213.817516386908;5217.295665085165;1299.753046921082;1336.1515437696937;1366.8586730080494;1370.3627813066971;1386.2791348498724;882.8057827277988;916.2303664921498;919.0533750237266;921.8571121476182;936.9016253293443;4792.400949881265;4808.326834243208;4810.350602668665;4810.59109975649;4829.5653391194965;5612.859678507988;5665.9716701417055;5671.319441667027;5672.574556908248;5709.514691251207;4693.084848454587;4823.1800593898415;4840.515948405131;4848.684835485753;4849.684770489977;3014.7136022077866;3039.589655396537;3053.7098975597282;3059.9694003059685;3064.130880163099;5335.199720042025;5342.545883599938;5343.95792820404;5351.929614077122;5375;5532.5573954083575;5759.366469688331;5759.712014399263;5777.45114214149;5833.941660583425;5383.246345511631;5390.865228369322;5396.595255355864;5397.35231772182;5406.432324606017;5549.944500555104;5698.230738850202;5704.743286552198;5706.885862282814;5740.598158128891;5476.452354764491;5512.862178445571;5526.253955715927;5541.168824676331;5543.89332053817;5343.732813359395;5351.759170837244;5372.677639341652;5392.110301800159;5394.595405344537;3851.094992676775;3928.3125453046173;3938.862139825207;3940.645341919241;3953.92092158161;5033.446320904624;5564.721763911869;5594.244776955059;5625.971870140786;5629.8592535186945;5060.291559181644;5209.463208353469;5220.921686174786;5232.686038837682;5240.528352448298;5182.404023537341;5189.351331083614;5203.453637368173;5209.322788037531;5221.503957124067;4800.495947925558;5097.16502059251;5124.256982737556;5132.178851383761;5134.640575159852;5216;5225.16397376418;5246.76389562463;5260.736963151904;5270.920936185884;5141.511556402285;5144.202648589475;5150.9227361588855;5161.354830646169;5179.093658609803 10:26:08 INFO - PROCESS | 7468 | |5;yui.html;618.3692633513816;713.1121753416996;717.3507975282369;726.2048057377174;745.0351794426217;10471.476426178699;10775.191860610455;11108.500117494712;11123.888761112376;12908.225506469618;12015;12138.514459421634;12194.390280485963;12199.878001219986;12228.266304021765;798.4849771897123;800.4596897094467;802.7872613757359;808.1030056637128;809.8096947217399;804.4127786715701;807.5598798654718;809.0210844877705;810.092696180279;810.6554714246452;845.2519520224615;848.0459483081534;852.9019162796264;854.1927878155146;854.6154230596226;849.452103393311;849.8087930215714;850.2262940723942;852.1819053708448;853.1298075962484;575.8992176369161;610.5664977865721;611.8500967263004;615.1080932647678;615.2493957371998;12439.75120497594;12483.251004939733;12528;12598.874011259863;12623.116381853273;11482.425878706032;12290.262584244885;12307.384630768425;12310.876891231062;12603.684907877376;10020.448875311855;10076.345037572608;10081.042300981395;10159.441230732307;10246.53890574926;3024.4555979923607;3027.8486075696346;3046.8324242166673;3091.8917837875565;3133.388989147117;46371.76814115942;46528.53471465276;47547.76226118882;47579.28631070536;47615.523844761454;9634.277429192838;9840.346016623165;9851.310408271496;10012.54943527543;10123.848142277871;16426.917865410596;16927.069011204254;16933.830661693224;16948.74576881348;17496.91251543734;6688.799336019927;6705.765298214539;6818.318168183142;6824.18109826814;6836.623985680835;3656.542932133483;3690.9077273068388;3744;3756.4553139794575;3777.112378591029;2641.537730897085;2715.3347429879805;2922.897698580582;3035.8178509289514;3036.8481575921114;563.1299642053037;584.1967294969417;584.4506164205633;595.8916415467228;596.6181643748005;468.95310468952835;582.8488734748837;595.967221802805;601.5398220361427;661.1867403094221;8132.878006829902;8211.137830527829;8231.176882311722;8263.628136733862;8360.331173506105;530.8513616187473;605.3976293587821;611.0925275965188;621.5959626242887;653.8103949854584;3513.9121521962156;3606.495090687306;3656.0859785053735;3680.595134535199;3850.249201405699;47035.294470582965;51525.7423712879;58844.705776470844;60137;60169.39830601638;41853.372199417034;44834.55165448304;44993.77503112529;45179.32231016537;45200.77399613047;42748.145037099086;43349.349759753626;43396.69809905708;44550.55449445529;44552.55447445484;7725.420593455401;7879.881801773093;8040;8128.105908349959;8190.7952301192945;28706.83750856156;30297;30876.22809429782;31122.844385778833;31236;39762.60237397589;40365.1926961465;40512.59487405088;40558.594414056664;41073.794631026656;11017.889821101686;11019.449027548751;11099.5560177592;11182.832257515982;11332.433378331216;12241.938790305992;12349.567765128177;12417.254964702146;12473.93763031179;12804.167729097579;11106.222564420414;11415.029722473682;11673.299602023906;11722.70693232676;11933.46299416511;10449.16406687448;10509.159267258754;10681.626143084955;10935.45322733876;11095.334279943228;10394.428306443218;10898.237123401286;11538.596149135075;11820.940895295469;11824.054075674097;8482.321414286718;8767.167119123673;8930.464172149692;9136.95431522838;9373.578188981375;9120.133587309196;9395.85906211421;9468.479233642216;9529.52352382392;9534.713958581253 10:26:08 INFO - PROCESS | 7468 | __end_tp_report 10:26:08 INFO - PROCESS | 7468 | __start_cc_report 10:26:08 INFO - PROCESS | 7468 | _x_x_mozilla_cycle_collect,388 10:26:08 INFO - PROCESS | 7468 | __end_cc_report 10:26:08 INFO - PROCESS | 7468 | __startTimestamp1461777968431__endTimestamp 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | ------- Summary: start ------- 10:26:08 INFO - PROCESS | 7468 | Number of tests: 6 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#0] dojo.html Cycles:165 Average:4781.57 Median:4932.24 stddev:504.35 (10.2%) stddev-sans-first:476.99 10:26:08 INFO - PROCESS | 7468 | Values: 2635.9 2644.9 2708.6 2714.2 2714.2 4746.0 4769.5 4794.3 4799.0 4815.3 4726.4 4777.4 4808.8 4860.5 4868.0 4448.3 4494.0 4525.5 4542.8 4549.2 4410.8 4495.6 4513.8 4546.5 4553.0 4350.8 4379.2 4401.4 4432.2 4498.4 4366.5 4394.1 4395.9 4411.5 4447.0 4395.1 4404.0 4406.5 4412.5 4440.8 4715.1 4744.7 4777.4 4816.3 4822.9 5027.5 5046.6 5057.0 5060.9 5081.9 5041.8 5072.6 5074.1 5075.6 5108.2 4802.4 4847.8 4865.3 4892.8 4899.5 5317.1 5372.7 5373.2 5380.0 5389.5 4944.9 5120.4 5135.6 5139.1 5149.4 5198.4 5202.9 5209.4 5223.3 5254.2 4988.2 5140.0 5153.3 5205.1 5239.2 5013.8 5056.9 5062.8 5079.6 5180.3 4316.8 4332.6 4339.1 4358.2 4383.6 3754.9 3782.5 3800.8 3819.6 3838.0 4414.3 4499.1 4549.2 4551.4 4608.6 5230.9 5249.8 5260.8 5262.8 5298.7 4564.3 4567.0 4569.4 4579.8 4608.4 4486.7 4655.0 4713.2 4714.2 4738.5 4898.0 4922.7 4932.2 4946.4 4988.3 5214.9 5218.8 5219.7 5232.5 5239.8 4785.5 4902.3 4949.3 4983.1 5009.3 5046.8 5085.1 5102.6 5105.0 5124.4 5078.7 5154.5 5173.4 5198.3 5200.7 4915.2 4948.7 5000.6 5080.3 5105.2 5043.4 5053.8 5067.3 5101.2 5111.0 4949.1 4970.2 4970.8 4981.3 5029.1 5000.9 5053.6 5096.9 5150.4 5165.0 4897.5 4899.9 4940.1 4940.3 4968.6 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#1] ext.html Cycles:180 Average:38326.01 Median:32823.01 stddev:59681.37 (181.8%) stddev-sans-first:59781.49 10:26:08 INFO - PROCESS | 7468 | Values: 578.4 601.6 608.7 627.6 630.1 32110.7 32389.8 32445.7 32881.3 32957.0 35318.0 35925.0 35936.8 36305.5 36528.8 7397.9 7583.8 7598.7 7612.1 7655.8 7453.9 7546.2 7554.9 7575.5 7607.3 7582.8 7586.2 7591.4 7658.8 7661.6 7516.4 7550.8 7627.4 7631.3 7635.2 7601.6 7628.8 7682.8 7684.6 7710.5 24849.9 33301.8 33754.3 33775.0 33857.0 2878.2 2987.2 3088.2 3104.5 3127.4 25901.0 26323.9 26731.5 26774.5 26951.6 3338.3 3339.6 3366.6 3480.1 3484.8 187715.0 189628.0 191367.0 191594.0 192800.0 52599.7 53088.2 53201.5 53201.7 53283.5 43408.8 44735.3 45018.3 54467.7 54567.2 14801.4 15053.5 15148.5 15191.5 15218.5 11245.4 11538.5 11565.8 11567.5 11575.0 17158.3 17403.6 17411.9 17484.0 17570.7 7175.5 7325.3 7412.5 7440.9 7454.3 864.6 939.2 1023.6 1031.2 1076.0 26233.5 26804.5 27133.7 27144.3 27436.6 1026.8 1041.2 1080.7 1107.4 1148.3 13916.2 14333.9 14417.4 14535.1 14633.2 255035.0 257823.0 258123.0 258359.0 258598.0 43748.0 44931.0 44932.8 45151.3 45224.8 1218.0 1249.6 1250.0 1256.9 1273.0 26015.0 26338.5 26662.1 26756.7 27176.2 39532.6 39620.2 40007.6 40071.8 40073.8 233840.0 234986.0 235569.0 235578.0 236337.0 24444.1 24467.5 24577.4 24781.0 24800.5 37886.8 38495.6 38812.8 38829.0 39644.4 32764.7 33415.7 33586.5 33808.3 34272.7 33532.3 33763.3 34046.1 34228.3 34304.0 26551.0 30976.2 31443.4 33356.7 33479.7 27894.0 28132.9 29360.6 30324.4 30589.0 23624.4 24027.0 24188.9 24450.3 24542.6 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#2] jquery.html Cycles:180 Average:21646.61 Median:4886.95 stddev:58840.76 (1204.0%) stddev-sans-first:58984.16 10:26:08 INFO - PROCESS | 7468 | Values: 383.6 391.0 394.4 394.7 395.3 12246.7 14682.2 14856.9 15260.0 15266.2 15516.5 15612.0 15757.7 15845.0 16297.8 4833.8 4874.6 4983.6 5008.3 5014.0 4915.6 4961.1 4993.7 4995.0 5004.4 4899.3 4941.6 4953.4 4961.6 5001.7 4834.1 4922.5 4969.2 4988.4 4997.8 4457.8 4459.2 4468.2 4472.6 4472.9 17561.2 18179.0 18849.4 18895.2 18945.3 1713.4 1952.5 1983.9 1989.2 2061.7 8728.6 8804.4 8895.1 8897.8 9045.6 1745.6 1779.0 1782.1 1783.7 1832.1 51753.7 54692.5 55172.4 55878.4 56353.7 9256.4 9644.4 9858.1 9880.7 10121.7 11833.7 12545.1 13762.9 13764.9 13770.6 7244.6 7308.8 7321.2 7410.3 7445.4 6976.9 7004.6 7169.7 7189.8 7221.4 3997.3 4048.9 4257.7 4370.5 4376.3 1818.5 1864.8 1879.5 1904.3 1958.1 818.5 884.0 892.0 921.7 974.8 14811.6 14812.9 15147.6 15407.6 15679.7 876.2 907.8 909.4 925.0 967.2 8561.8 8711.3 8794.2 8892.8 8995.1 347232.0 356639.0 359693.0 364182.0 365072.0 42252.8 44598.3 70642.0 73691.6 74104.0 938.7 953.7 959.2 967.9 973.9 9577.7 9803.3 9925.4 10015.1 14538.0 23955.6 31173.4 31708.2 33752.7 35961.5 38771.4 42773.4 43675.6 44315.0 44922.0 9971.7 10025.5 10253.3 10380.3 10599.9 6269.8 9391.8 11243.9 11392.8 11436.2 7373.9 7379.3 7419.1 9655.4 10409.3 7324.3 7343.7 7411.0 7441.9 7451.7 7334.5 7398.1 7442.3 7475.4 7533.3 10433.7 10439.1 10554.3 10607.2 10695.7 9496.0 9606.3 9697.6 9806.0 9869.8 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#3] mootools.html Cycles:180 Average:5050.81 Median:4787.70 stddev:2713.49 (56.7%) stddev-sans-first:2707.60 10:26:08 INFO - PROCESS | 7468 | Values: 1448.4 1494.8 1597.3 1762.9 1782.0 6547.0 7387.7 7506.1 7672.7 7695.5 7469.7 7504.9 7534.2 7563.5 7573.1 2209.7 2259.6 2261.8 2264.8 2272.2 2219.2 2233.1 2284.0 2284.6 2287.7 2277.8 2285.3 2286.3 2297.4 2307.4 2238.5 2258.3 2260.3 2264.2 2266.0 2190.4 2211.1 2211.8 2212.6 2223.1 7637.1 7702.4 7734.2 7742.0 7760.0 4584.8 4754.2 4754.9 4764.7 4779.0 2944.6 2958.7 3096.3 3109.7 3149.1 982.2 990.4 1000.1 1016.8 1028.6 10072.4 10101.0 10110.4 10116.9 10126.1 4242.6 4268.8 4312.6 4401.6 4405.1 8692.8 8758.0 8767.0 8778.6 8794.9 4704.3 4762.7 4787.5 4787.9 4823.8 3736.3 4164.9 4321.2 4347.9 4374.3 3639.7 3646.1 3655.0 3674.4 3684.2 1227.9 1228.7 1240.2 1254.5 1258.5 772.3 910.0 919.5 929.5 930.0 5150.6 5237.9 5283.1 5397.4 5444.0 425.9 430.6 435.0 437.9 444.0 3639.8 3640.4 3677.7 3732.0 3738.7 9009.7 9381.8 9448.8 9469.7 9507.2 8567.1 8894.7 8905.0 8949.2 8958.2 6870.2 6986.2 6999.1 7002.5 7064.2 5482.6 5514.8 5555.4 5580.6 5596.4 8476.6 8696.2 8702.3 8716.0 8824.6 8030.7 8533.3 8585.1 8600.0 8835.7 5891.3 6349.7 6421.3 6469.2 6588.7 7194.1 7279.4 7298.3 7318.6 7348.2 6301.4 6634.9 6642.3 6644.1 6709.0 6540.6 6622.3 6654.3 6679.9 6753.6 6017.2 6183.1 6203.6 6206.8 6210.3 4444.8 4515.8 4607.6 4656.3 4656.7 4584.0 4600.1 4607.6 4658.3 4666.2 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#4] prototype.html Cycles:180 Average:4394.09 Median:4970.31 stddev:1301.54 (26.2%) stddev-sans-first:1268.23 10:26:08 INFO - PROCESS | 7468 | Values: 290.6 291.7 297.2 297.6 309.1 4801.9 4896.0 4923.2 5030.7 5036.8 4944.0 4962.7 4977.9 4989.3 4999.4 3901.9 3903.6 3906.6 3911.1 3912.5 3636.7 3920.5 3928.1 3932.9 3940.7 3790.1 3815.3 3823.4 3864.7 3873.2 3828.0 3849.5 3855.6 3856.7 3859.5 3348.3 3361.8 3364.9 3386.4 3399.8 4717.0 4768.9 4806.4 4818.2 4822.3 4331.6 4336.2 4337.5 4349.5 4400.5 5091.7 5125.4 5126.5 5161.4 5166.7 3555.1 3576.5 3644.8 3654.1 3666.3 5347.5 5355.9 5356.0 5376.9 5399.9 3676.4 3695.4 3717.7 3719.4 3733.8 3727.6 3781.0 3784.6 3793.3 3795.8 4083.4 4320.7 4333.3 4360.7 4378.4 5162.8 5170.7 5192.1 5213.8 5217.3 1299.8 1336.2 1366.9 1370.4 1386.3 882.8 916.2 919.1 921.9 936.9 4792.4 4808.3 4810.4 4810.6 4829.6 5612.9 5666.0 5671.3 5672.6 5709.5 4693.1 4823.2 4840.5 4848.7 4849.7 3014.7 3039.6 3053.7 3060.0 3064.1 5335.2 5342.5 5344.0 5351.9 5375.0 5532.6 5759.4 5759.7 5777.5 5833.9 5383.2 5390.9 5396.6 5397.4 5406.4 5549.9 5698.2 5704.7 5706.9 5740.6 5476.5 5512.9 5526.3 5541.2 5543.9 5343.7 5351.8 5372.7 5392.1 5394.6 3851.1 3928.3 3938.9 3940.6 3953.9 5033.4 5564.7 5594.2 5626.0 5629.9 5060.3 5209.5 5220.9 5232.7 5240.5 5182.4 5189.4 5203.5 5209.3 5221.5 4800.5 5097.2 5124.3 5132.2 5134.6 5216.0 5225.2 5246.8 5260.7 5270.9 5141.5 5144.2 5150.9 5161.4 5179.1 10:26:08 INFO - PROCESS | 7468 | 10:26:08 INFO - PROCESS | 7468 | [#5] yui.html Cycles:180 Average:12919.09 Median:43973.63 stddev:14853.45 (33.8%) stddev-sans-first:14866.40 10:26:08 INFO - PROCESS | 7468 | Values: 618.4 713.1 717.4 726.2 745.0 10471.5 10775.2 11108.5 11123.9 12908.2 12015.0 12138.5 12194.4 12199.9 12228.3 798.5 800.5 802.8 808.1 809.8 804.4 807.6 809.0 810.1 810.7 845.3 848.0 852.9 854.2 854.6 849.5 849.8 850.2 852.2 853.1 575.9 610.6 611.9 615.1 615.2 12439.8 12483.3 12528.0 12598.9 12623.1 11482.4 12290.3 12307.4 12310.9 12603.7 10020.4 10076.3 10081.0 10159.4 10246.5 3024.5 3027.8 3046.8 3091.9 3133.4 46371.8 46528.5 47547.8 47579.3 47615.5 9634.3 9840.3 9851.3 10012.5 10123.8 16426.9 16927.1 16933.8 16948.7 17496.9 6688.8 6705.8 6818.3 6824.2 6836.6 3656.5 3690.9 3744.0 3756.5 3777.1 2641.5 2715.3 2922.9 3035.8 3036.8 563.1 584.2 584.5 595.9 596.6 469.0 582.8 596.0 601.5 661.2 8132.9 8211.1 8231.2 8263.6 8360.3 530.9 605.4 611.1 621.6 653.8 3513.9 3606.5 3656.1 3680.6 3850.2 47035.3 51525.7 58844.7 60137.0 60169.4 41853.4 44834.6 44993.8 45179.3 45200.8 42748.1 43349.3 43396.7 44550.6 44552.6 7725.4 7879.9 8040.0 8128.1 8190.8 28706.8 30297.0 30876.2 31122.8 31236.0 39762.6 40365.2 40512.6 40558.6 41073.8 11017.9 11019.4 11099.6 11182.8 11332.4 12241.9 12349.6 12417.3 12473.9 12804.2 11106.2 11415.0 11673.3 11722.7 11933.5 10449.2 10509.2 10681.6 10935.5 11095.3 10394.4 10898.2 11538.6 11820.9 11824.1 8482.3 8767.2 8930.5 9137.0 9373.6 9120.1 9395.9 9468.5 9529.5 9534.7 10:26:08 INFO - PROCESS | 7468 | -------- Summary: end -------- 10:26:08 INFO - PROCESS | 7468 | 10:26:09 INFO - TEST-INFO | 7468: exit 0 10:26:09 INFO - TEST-OK | dromaeo_css | took 1115446ms 10:26:09 INFO - TEST-START | kraken 10:26:09 INFO - operating with platform_type : linux_ 10:26:09 INFO - Initialising browser for kraken test... 10:26:09 INFO - TEST-INFO | started process 7717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKYuOc/profile http://localhost:42335/getInfo.html) 10:26:13 INFO - PROCESS | 7717 | 10:26:13 INFO - PROCESS | 7717 | (process:7786): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:13 INFO - PROCESS | 7717 | __metrics Screen width/height:1600/1200 10:26:13 INFO - PROCESS | 7717 | colorDepth:24 10:26:13 INFO - PROCESS | 7717 | Browser inner width/height: 1024/697 10:26:13 INFO - PROCESS | 7717 | __metrics 10:26:14 ERROR - PROCESS | 7717 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:26:15 INFO - TEST-INFO | 7717: exit 0 10:26:15 INFO - Browser initialized. 10:26:15 INFO - Running cycle 1/1 for kraken test... 10:26:15 INFO - TEST-INFO | started process 7837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKYuOc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:17 INFO - PROCESS | 7837 | 10:26:17 INFO - PROCESS | 7837 | (process:7897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:27 INFO - PROCESS | 7837 | RSS: Main: 166039552 10:26:27 INFO - PROCESS | 7837 | 10:26:29 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42335/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:30 INFO - PROCESS | 7837 | RSS: Main: 170446848 10:26:30 INFO - PROCESS | 7837 | 10:26:33 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42335/tests/kraken/driver.html?testName=audio-dft) 10:26:34 INFO - PROCESS | 7837 | RSS: Main: 173469696 10:26:34 INFO - PROCESS | 7837 | 10:26:37 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42335/tests/kraken/driver.html?testName=audio-fft) 10:26:37 INFO - PROCESS | 7837 | RSS: Main: 163885056 10:26:37 INFO - PROCESS | 7837 | 10:26:40 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42335/tests/kraken/driver.html?testName=audio-oscillator) 10:26:40 INFO - PROCESS | 7837 | RSS: Main: 164417536 10:26:40 INFO - PROCESS | 7837 | 10:26:42 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:43 INFO - PROCESS | 7837 | RSS: Main: 165842944 10:26:43 INFO - PROCESS | 7837 | 10:26:46 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42335/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:47 INFO - PROCESS | 7837 | RSS: Main: 166379520 10:26:47 INFO - PROCESS | 7837 | 10:26:50 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42335/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:51 INFO - PROCESS | 7837 | RSS: Main: 165748736 10:26:51 INFO - PROCESS | 7837 | 10:26:54 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42335/tests/kraken/driver.html?testName=json-parse-financial) 10:26:55 INFO - PROCESS | 7837 | RSS: Main: 166248448 10:26:55 INFO - PROCESS | 7837 | 10:26:56 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:57 INFO - PROCESS | 7837 | RSS: Main: 166604800 10:26:57 INFO - PROCESS | 7837 | 10:26:59 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:59 INFO - PROCESS | 7837 | RSS: Main: 166817792 10:26:59 INFO - PROCESS | 7837 | 10:27:02 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:02 INFO - PROCESS | 7837 | RSS: Main: 167366656 10:27:02 INFO - PROCESS | 7837 | 10:27:05 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:06 INFO - PROCESS | 7837 | RSS: Main: 167321600 10:27:06 INFO - PROCESS | 7837 | 10:27:09 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:10 INFO - PROCESS | 7837 | RSS: Main: 164892672 10:27:10 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:42335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42335/tests/kraken/driver.html?testName=ai-astar) 10:27:12 INFO - PROCESS | 7837 | RSS: Main: 166916096 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | __start_tp_report 10:27:12 INFO - PROCESS | 7837 | _x_x_mozilla_page_load 10:27:12 INFO - PROCESS | 7837 | _x_x_mozilla_page_load_details 10:27:12 INFO - PROCESS | 7837 | |i|pagename|runs| 10:27:12 INFO - PROCESS | 7837 | |0;ai-astar;114;108;114;112;113;126;115;114;113;113 10:27:12 INFO - PROCESS | 7837 | |1;audio-beat-detection;166;132;161;193;135;160;174;134;197;134 10:27:12 INFO - PROCESS | 7837 | |2;audio-dft;163;164;165;171;166;163;165;162;166;163 10:27:12 INFO - PROCESS | 7837 | |3;audio-fft;74;74;74;169;78;75;73;75;163;77 10:27:12 INFO - PROCESS | 7837 | |4;audio-oscillator;95;94;142;95;95;94;138;95;94;137 10:27:12 INFO - PROCESS | 7837 | |5;imaging-gaussian-blur;117;118;120;117;118;117;118;117;118;118 10:27:12 INFO - PROCESS | 7837 | |6;imaging-darkroom;148;147;147;148;148;151;148;147;148;147 10:27:12 INFO - PROCESS | 7837 | |7;imaging-desaturate;96;96;96;96;95;100;96;95;95;96 10:27:12 INFO - PROCESS | 7837 | |8;json-parse-financial;64;65;66;67;68;65;65;91;63;64 10:27:12 INFO - PROCESS | 7837 | |9;json-stringify-tinderbox;64;64;65;65;65;65;65;64;64;69 10:27:12 INFO - PROCESS | 7837 | |10;stanford-crypto-aes;87;79;80;79;79;80;80;80;82;82 10:27:12 INFO - PROCESS | 7837 | |11;stanford-crypto-ccm;143;139;137;134;146;137;134;151;185;138 10:27:12 INFO - PROCESS | 7837 | |12;stanford-crypto-pbkdf2;219;234;221;219;218;221;231;223;224;221 10:27:12 INFO - PROCESS | 7837 | |13;stanford-crypto-sha256-iterative;77;75;74;75;77;73;75;74;76;77 10:27:12 INFO - PROCESS | 7837 | __end_tp_report 10:27:12 INFO - PROCESS | 7837 | __start_cc_report 10:27:12 INFO - PROCESS | 7837 | _x_x_mozilla_cycle_collect,919 10:27:12 INFO - PROCESS | 7837 | __end_cc_report 10:27:12 INFO - PROCESS | 7837 | __startTimestamp1461778032564__endTimestamp 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | ------- Summary: start ------- 10:27:12 INFO - PROCESS | 7837 | Number of tests: 14 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.57 (4.0%) stddev-sans-first:4.84 10:27:12 INFO - PROCESS | 7837 | Values: 114.0 108.0 114.0 112.0 113.0 126.0 115.0 114.0 113.0 113.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:163.50 stddev:24.57 (15.0%) stddev-sans-first:25.91 10:27:12 INFO - PROCESS | 7837 | Values: 166.0 132.0 161.0 193.0 135.0 160.0 174.0 134.0 197.0 134.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.57 (1.6%) stddev-sans-first:2.65 10:27:12 INFO - PROCESS | 7837 | Values: 163.0 164.0 165.0 171.0 166.0 163.0 165.0 162.0 166.0 163.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:38.42 (51.6%) stddev-sans-first:40.12 10:27:12 INFO - PROCESS | 7837 | Values: 74.0 74.0 74.0 169.0 78.0 75.0 73.0 75.0 163.0 77.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.50 stddev:21.50 (22.8%) stddev-sans-first:22.29 10:27:12 INFO - PROCESS | 7837 | Values: 95.0 94.0 142.0 95.0 95.0 94.0 138.0 95.0 94.0 137.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 10:27:12 INFO - PROCESS | 7837 | Values: 117.0 118.0 120.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 10:27:12 INFO - PROCESS | 7837 | Values: 148.0 147.0 147.0 148.0 148.0 151.0 148.0 147.0 148.0 147.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.45 (1.5%) stddev-sans-first:1.54 10:27:12 INFO - PROCESS | 7837 | Values: 96.0 96.0 96.0 96.0 95.0 100.0 96.0 95.0 95.0 96.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:65.50 stddev:8.28 (12.6%) stddev-sans-first:8.67 10:27:12 INFO - PROCESS | 7837 | Values: 64.0 65.0 66.0 67.0 68.0 65.0 65.0 91.0 63.0 64.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.54 10:27:12 INFO - PROCESS | 7837 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 69.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.44 (3.1%) stddev-sans-first:1.17 10:27:12 INFO - PROCESS | 7837 | Values: 87.0 79.0 80.0 79.0 79.0 80.0 80.0 80.0 82.0 82.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:141.00 stddev:15.25 (10.8%) stddev-sans-first:16.16 10:27:12 INFO - PROCESS | 7837 | Values: 143.0 139.0 137.0 134.0 146.0 137.0 134.0 151.0 185.0 138.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:223.10 Median:222.00 stddev:5.32 (2.4%) stddev-sans-first:5.43 10:27:12 INFO - PROCESS | 7837 | Values: 219.0 234.0 221.0 219.0 218.0 221.0 231.0 223.0 224.0 221.0 10:27:12 INFO - PROCESS | 7837 | 10:27:12 INFO - PROCESS | 7837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.50 stddev:1.42 (1.9%) stddev-sans-first:1.36 10:27:12 INFO - PROCESS | 7837 | Values: 77.0 75.0 74.0 75.0 77.0 73.0 75.0 74.0 76.0 77.0 10:27:12 INFO - PROCESS | 7837 | -------- Summary: end -------- 10:27:12 INFO - PROCESS | 7837 | 10:27:13 INFO - TEST-INFO | 7837: exit 0 10:27:13 INFO - TEST-OK | kraken | took 64377ms 10:27:13 INFO - SUITE-END | took 1179s 10:27:13 INFO - Completed test suite (00:19:39) 10:27:13 INFO - javascript benchmark 10:27:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.934101647458, 2644.907428240012, 2708.5937109433585, 2714.1586108306415, 2714.1857442767177, 4745.976270118653, 4769.546893045163, 4794.280857871317, 4799.040191961613, 4815.277708343741, 4726.361941137945, 4777.402824646919, 4808.783604737787, 4860.538248866361, 4867.975660121703, 4448.310511870657, 4493.955060449386, 4525.524819893913, 4542.8188670945465, 4549.226631472658, 4410.831129750619, 4495.617872480827, 4513.774311284423, 4546.522615125414, 4552.9528208512065, 4350.7607081610495, 4379.233634114017, 4401.449818772653, 4432.202203603366, 4498.415206023229, 4366.541513141106, 4394.099209662011, 4395.934060989088, 4411.470623525165, 4447.0, 4395.09900470406, 4403.955960440387, 4406.471223453174, 4412.514623391425, 4440.822367105312, 4715.056988602293, 4744.667873248874, 4777.402824646919, 4816.301636262758, 4822.855314340575, 5027.4721154279005, 5046.5710414614805, 5056.988602279559, 5060.9493905060845, 5081.949180508184, 5041.823536176253, 5072.6195535335, 5074.13739664258, 5075.6447048706605, 5108.182690769496, 4802.4237091548885, 4847.830325938575, 4865.270209468608, 4892.828750993734, 4899.485554016848, 5317.096093664087, 5372.7313634318125, 5373.2208829719475, 5379.973100134474, 5389.51494365509, 4944.9258261126115, 5120.4111527174855, 5135.614828887774, 5139.12634852076, 5149.407818100892, 5198.428172900978, 5202.869928251824, 5209.426963034063, 5223.268742376071, 5254.185601231815, 4988.201887697951, 5140.023395554907, 5153.2785410042625, 5205.063088644005, 5239.240310155083, 5013.799448022111, 5056.938043011009, 5062.848114556569, 5079.644424890296, 5180.300659410931, 4316.784160791948, 4332.566743325705, 4339.067100573392, 4358.171947329997, 4383.583559561836, 3754.9249015019545, 3782.5460944686265, 3800.771953682788, 3819.598942111094, 3838.0213045673177, 4414.27164517851, 4499.10017996402, 4549.249373853343, 4551.385562949025, 4608.608268297232, 5230.895382092413, 5249.816256431083, 5260.789568417221, 5262.815801446931, 5298.682079075191, 4564.269716845289, 4566.97716511422, 4569.360289559398, 4579.793909274091, 4608.400907882021, 4486.7083639563325, 4654.976725116353, 4713.151632706145, 4714.151452738472, 4738.47876733559, 4898.0, 4922.680025798311, 4932.235503496964, 4946.431160416598, 4988.326575912205, 5214.8957020860125, 5218.765155568084, 5219.660722053054, 5232.529072383504, 5239.790408383775, 4785.545373189541, 4902.313676085279, 4949.331840201527, 4983.053219888209, 5009.298698182331, 5046.798128074983, 5085.084684756779, 5102.642815002914, 5105.0, 5124.436312005751, 5078.695278283315, 5154.5103215194495, 5173.430922598436, 5198.298229739088, 5200.713960732196, 4915.21356582945, 4948.678335908155, 5000.6249531284575, 5080.288759573737, 5105.2342148678, 5043.36957880265, 5053.823116190915, 5067.265246539305, 5101.234814777813, 5111.0, 4949.109160351171, 4970.155073637418, 4970.7514624267915, 4981.302617633607, 5029.145045342228, 5000.87497812543, 5053.59571234293, 5096.872578185426, 5150.381954165524, 5165.018646457161, 4897.4857639947295, 4899.902001960012, 4940.061388336205, 4940.333055037668, 4968.552830245295], "value": 4748.992728129359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3580225949196, 601.6209787833666, 608.680442767547, 627.5544363501914, 630.143005512503, 32110.715571377146, 32389.838050809773, 32445.67554324456, 32881.342373152525, 32957.0, 35318.0, 35925.0, 35936.82031589838, 36305.45541816875, 36528.81735591318, 7397.889031664529, 7583.772486825376, 7598.73404430845, 7612.086549614054, 7655.808604784897, 7453.850922981537, 7546.169921308651, 7554.924450755477, 7575.545467271982, 7607.315341619254, 7582.848343033136, 7586.203448637896, 7591.392688584928, 7658.770236892902, 7661.578613176273, 7516.436267279949, 7550.773476795677, 7627.427942904276, 7631.275028872248, 7635.23647635232, 7601.581912994783, 7628.771136865903, 7682.807929801744, 7684.615769211517, 7710.460267781257, 24849.87575062131, 33301.833490832636, 33754.32491350184, 33775.0, 33857.0, 2878.2228798224573, 2987.1785259053718, 3088.181631867557, 3104.5343198520177, 3127.37452509499, 25901.0, 26323.868380657976, 26731.465370692673, 26774.464510709677, 26951.59572606393, 3338.315645292709, 3339.6493368196475, 3366.6454740522945, 3480.112571294329, 3484.756067075306, 187715.0, 189628.0, 191367.0, 191593.9999999986, 192800.0, 52599.73700131475, 53088.203676944875, 53201.46798532043, 53201.73399133057, 53283.46716532785, 43408.782956085015, 44735.32897006548, 45018.32472512915, 54467.72766136223, 54567.18149227765, 14801.407943682347, 15053.473128440452, 15148.545543633709, 15191.468298609716, 15218.543443696706, 11245.381504017358, 11538.538458461568, 11565.826512602318, 11567.479463424166, 11575.0, 17158.31366745341, 17403.564910877078, 17411.912940435217, 17484.0, 17570.736438953427, 7175.497715159993, 7325.267473252632, 7412.518186317872, 7440.85118297631, 7454.254574542502, 864.6333240788572, 939.2251392601131, 1023.5803320638503, 1031.1956673794452, 1075.956961721538, 26233.52165725062, 26804.463910721675, 27133.728662713514, 27144.321391965357, 27436.588451173247, 1026.8151732688189, 1041.2450973044633, 1080.6649938519083, 1107.3577325151393, 1148.328227986637, 13916.165030098024, 14333.928330358282, 14417.3571674732, 14535.127892326494, 14633.195174265305, 255035.0, 257823.0, 258123.0, 258359.0, 258598.0, 43748.0, 44931.0, 44932.77533612376, 45151.322730159074, 45224.79914809839, 1218.0499210615733, 1249.6001279590625, 1249.9937500312622, 1256.9120161588785, 1272.9688951948951, 26015.0, 26338.473230535667, 26662.06682766094, 26756.732432675424, 27176.1847144586, 39532.60467395404, 39620.2075958485, 40007.59992400155, 40071.799641001606, 40073.79963100166, 233840.0, 234986.0, 235569.0, 235578.0, 236337.0, 24444.14445494399, 24467.51064978655, 24577.385565361008, 24781.0, 24800.50398991974, 37886.810565946995, 38495.615043850325, 38812.80593597014, 38829.0, 39644.405333919436, 32764.67235327616, 33415.66584334125, 33586.49620255747, 33808.3238335227, 34272.65727342795, 33532.32935341328, 33763.32473350568, 34046.14884627805, 34228.315433691685, 34304.0, 26551.0, 30976.22559435942, 31443.37113257676, 33356.666433335355, 33479.66520334766, 27894.0, 28132.85933570319, 29360.55959160657, 30324.393512130075, 30589.0, 23624.409389765395, 24026.996625421823, 24188.879055605314, 24450.266492005267, 24542.631860522462], "value": 16457.607446867987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.61638361638364, 391.0302449924187, 394.3650722337037, 394.6753278708691, 395.32596922247563, 12246.693832654188, 14682.192479413628, 14856.925715371435, 15260.00809947354, 15266.236688165589, 15516.534503964898, 15612.0, 15757.684846303067, 15845.0, 16297.755533667005, 4833.80366106437, 4874.561289483946, 4983.626228032894, 5008.348914641109, 5013.974930125344, 4915.557599816016, 4961.107000739866, 4993.725345106018, 4995.0, 5004.374453193351, 4899.3385892904535, 4941.579965702919, 4953.356063711731, 4961.6278779091535, 5001.6998980061135, 4834.057358815033, 4922.483139270379, 4969.18008528596, 4988.401391832985, 4997.750112494361, 4457.796394973371, 4459.175052615245, 4468.218061839198, 4472.619827314682, 4472.8881777955485, 17561.20974556135, 18179.0, 18849.434516964513, 18895.244190232374, 18945.33691320797, 1713.4003098915405, 1952.4630726550313, 1983.8512111591688, 1989.2142603671614, 2061.7319748432756, 8728.60721267538, 8804.383693141483, 8895.110488951117, 8897.822043559157, 9045.638174473013, 1745.572334777975, 1778.9555261118446, 1782.073321872619, 1783.7146056630877, 1832.138894719493, 51753.7412312936, 54692.45307546914, 55172.448275517134, 55878.44121558814, 56353.71823140899, 9256.352055356196, 9644.373115747454, 9858.063483969012, 9880.703578892644, 10121.746956326004, 11833.704157395961, 12545.12184147101, 13762.862371376157, 13764.862351376358, 13770.586882393543, 7244.565326080452, 7308.817279567947, 7321.158066822277, 7410.296021878021, 7445.36714379273, 6976.860462790817, 7004.614746189009, 7169.6773645186095, 7189.820254493679, 7221.350078492856, 3997.340438827561, 4048.935043127967, 4257.74453532789, 4370.497392799869, 4376.277914144131, 1818.472642933561, 1864.794872564017, 1879.4831421359236, 1904.3334832808682, 1958.067056817844, 818.5252553518944, 883.9878339301464, 891.9866202006975, 921.709661456639, 974.8196583632051, 14811.629709257355, 14812.851871481147, 15147.621309467351, 15407.61480962985, 15679.68640627181, 876.1807709791366, 907.7503686486269, 909.3725329522608, 924.9537523123817, 967.2165545907837, 8561.828763424697, 8711.259542938795, 8794.164554367326, 8892.822143557221, 8995.145461181177, 347232.0, 356639.0, 359693.0, 364182.0, 365072.0, 42252.78873605612, 44598.33102503465, 70642.0, 73691.63154184195, 74104.0, 938.7418459923439, 953.6852838563258, 959.1990687775785, 967.8548217767251, 973.9123478886934, 9577.664781732607, 9803.313768036169, 9925.35485193489, 10015.14871235953, 14538.0, 23955.640665390383, 31173.37653246877, 31708.207294817814, 33752.66247337495, 35961.460578090824, 38771.41842872303, 42773.35839962341, 43675.56324436842, 44315.0, 44922.0, 9971.650992215238, 10025.498725063571, 10253.282270241012, 10380.273380863267, 10599.947000264949, 6269.811905642838, 9391.765205869908, 11243.943780281046, 11392.772144556897, 11436.19946603763, 7373.852522949618, 7379.298966598165, 7419.07261592301, 9655.372400793925, 10409.271351005356, 7324.267573242633, 7343.742968996059, 7410.96294518524, 7441.888371674321, 7451.701931922662, 7334.486585938933, 7398.075240594926, 7442.330190282901, 7475.439342049477, 7533.322001019935, 10433.739156520844, 10439.11267542237, 10554.261201715806, 10607.20445966571, 10695.732606684895, 9496.002919693332, 9606.327557070937, 9697.566899077843, 9806.0, 9869.802603948025], "value": 7649.196620067585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.4495891561203, 1494.775783632455, 1597.3131553432027, 1762.8765986380959, 1781.9753641656043, 6547.0, 7387.667554960026, 7506.099268087837, 7672.6930922763095, 7695.538267703928, 7469.701211951529, 7504.924950750491, 7534.171241163468, 7563.470557061008, 7573.053368328959, 2209.6795964585126, 2259.6271615183473, 2261.807746341563, 2264.830137739676, 2272.1593010586107, 2219.178903805594, 2233.062113912161, 2283.9771602284013, 2284.6344584866424, 2287.668288098225, 2277.840551161419, 2285.268714011517, 2286.2912497125944, 2297.448612333036, 2307.40007598024, 2238.529908719171, 2258.3450799268194, 2260.2654137405407, 2264.1735766445213, 2266.0256089881345, 2190.353845615547, 2211.07135003299, 2211.800937915595, 2212.6127927612765, 2223.132978138527, 7637.083549973983, 7702.383809295243, 7734.226577342277, 7741.961290193569, 7760.0, 4584.816607335736, 4754.215554433515, 4754.9286760698615, 4764.666473346867, 4778.976105119452, 2944.6319210098736, 2958.6745457999605, 3096.256898344381, 3109.7250127447637, 3149.1339881532763, 982.1602529836958, 990.3810118675827, 1000.1448761309049, 1016.8017236638858, 1028.6091285311609, 10072.446015469146, 10101.040401161878, 10110.393376397366, 10116.89883101167, 10126.139278161365, 4242.596953289432, 4268.829246830154, 4312.590303921185, 4401.625861801719, 4405.0969551241915, 8692.78268043304, 8757.956210218908, 8766.956165219133, 8778.648854045894, 8794.91205087941, 4704.341392205094, 4762.738049407316, 4787.497312782178, 4787.904241915212, 4823.758812059383, 3736.308782875177, 4164.937525937114, 4321.157374312042, 4347.934780978288, 4374.256376416017, 3639.727020473475, 3646.1249300168297, 3654.9817250913575, 3674.4488326751202, 3684.1894783147663, 1227.8526576810661, 1228.6744012836605, 1240.1690867119053, 1254.5295514182183, 1258.4714419943646, 772.3473664753275, 909.9727008189765, 919.5172534419484, 929.5027160469117, 930.0467021303083, 5150.639455238097, 5237.9476205238225, 5283.128283833202, 5397.433269506724, 5443.972780136074, 425.85520922886366, 430.5758827554856, 434.95432979537327, 437.91241751649795, 444.034225559407, 3639.8180090995343, 3640.381135207021, 3677.724170687209, 3731.9813400933363, 3738.682212011955, 9009.684661036963, 9381.812363752686, 9448.763780905532, 9469.715908522756, 9507.239420846316, 8567.100454452193, 8894.688685895962, 8904.955475222712, 8949.194572488377, 8958.238549723346, 6870.20992585859, 6986.196587392414, 6999.055127557816, 7002.474814388941, 7064.222935477196, 5482.616216864941, 5514.80698175562, 5555.416681248573, 5580.637258578179, 5596.38439771633, 8476.618552165044, 8696.17386348296, 8702.347323950855, 8715.956420217859, 8824.5587720615, 8030.6787728492545, 8533.274671652978, 8585.055643879294, 8600.0, 8835.734927952171, 5891.293044834647, 6349.746010159542, 6421.261554921244, 6469.223693156851, 6588.670566471561, 7194.136703595602, 7279.381252593589, 7298.2701729826595, 7318.560886346836, 7348.154962179204, 6301.40136687014, 6634.933650663432, 6642.302558231316, 6644.136262285871, 6709.0, 6540.640264785482, 6622.271550129385, 6654.268030516542, 6679.866402672016, 6753.628550429774, 6017.18767966319, 6183.072539119168, 6203.627782333075, 6206.751729930752, 6210.3168651449205, 4444.777761111867, 4515.7967891444305, 4607.585317321457, 4656.278276867091, 4656.720596764205, 4583.9541604584865, 4600.148972440109, 4607.6083532900075, 4658.324542941323, 4666.206744853315], "value": 4080.618957216412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.60187543066, 291.727235035242, 297.21831582936875, 297.5759542651721, 309.105140617911, 4801.90396192076, 4896.0, 4923.187674033785, 5030.730025483433, 5036.773345199465, 4943.975280123604, 4962.702237865721, 4977.925331120036, 4989.301497790303, 4999.400071991357, 3901.8979910970847, 3903.555684396777, 3906.6321895310602, 3911.1004468972155, 3912.454580440731, 3636.672699457048, 3920.5099362579676, 3928.0769019280447, 3932.941005884914, 3940.665043471294, 3790.0714324990277, 3815.332316844555, 3823.3691440912216, 3864.7487913285545, 3873.2253549290112, 3827.9808600957094, 3849.480320156771, 3855.5951625079383, 3856.749311294757, 3859.4755071746504, 3348.3303339331987, 3361.8151001694896, 3364.8822291219935, 3386.356592247465, 3399.847006884696, 4717.0, 4768.904621907577, 4806.3511425957395, 4818.16909574363, 4822.324874517535, 4331.6318112960125, 4336.1978034063795, 4337.522872484024, 4349.456317960255, 4400.515943246241, 5091.745412729349, 5125.410577783528, 5126.53861152498, 5161.380634323905, 5166.715830629314, 3555.1112221944513, 3576.46353047045, 3644.8177591120602, 3654.086478380405, 3666.2667466506805, 5347.51872331492, 5355.866103347408, 5356.0, 5376.924615077, 5399.892002159974, 3676.411774116182, 3695.427208782643, 3717.70258379329, 3719.4420836874683, 3733.757305775116, 3727.6458736419995, 3780.981095094507, 3784.6215378461934, 3793.336166170964, 3795.7532760370486, 4083.3670781028986, 4320.740755554677, 4333.328334108218, 4360.672949528798, 4378.365137055109, 5162.819301324435, 5170.6814762236145, 5192.143296356135, 5213.817516386908, 5217.295665085165, 1299.753046921082, 1336.1515437696937, 1366.8586730080494, 1370.3627813066971, 1386.2791348498724, 882.8057827277988, 916.2303664921498, 919.0533750237266, 921.8571121476182, 936.9016253293443, 4792.400949881265, 4808.326834243208, 4810.350602668665, 4810.59109975649, 4829.5653391194965, 5612.859678507988, 5665.9716701417055, 5671.319441667027, 5672.574556908248, 5709.514691251207, 4693.084848454587, 4823.1800593898415, 4840.515948405131, 4848.684835485753, 4849.684770489977, 3014.7136022077866, 3039.589655396537, 3053.7098975597282, 3059.9694003059685, 3064.130880163099, 5335.199720042025, 5342.545883599938, 5343.95792820404, 5351.929614077122, 5375.0, 5532.5573954083575, 5759.366469688331, 5759.712014399263, 5777.45114214149, 5833.941660583425, 5383.246345511631, 5390.865228369322, 5396.595255355864, 5397.35231772182, 5406.432324606017, 5549.944500555104, 5698.230738850202, 5704.743286552198, 5706.885862282814, 5740.598158128891, 5476.452354764491, 5512.862178445571, 5526.253955715927, 5541.168824676331, 5543.89332053817, 5343.732813359395, 5351.759170837244, 5372.677639341652, 5392.110301800159, 5394.595405344537, 3851.094992676775, 3928.3125453046173, 3938.862139825207, 3940.645341919241, 3953.92092158161, 5033.446320904624, 5564.721763911869, 5594.244776955059, 5625.971870140786, 5629.8592535186945, 5060.291559181644, 5209.463208353469, 5220.921686174786, 5232.686038837682, 5240.528352448298, 5182.404023537341, 5189.351331083614, 5203.453637368173, 5209.322788037531, 5221.503957124067, 4800.495947925558, 5097.16502059251, 5124.256982737556, 5132.178851383761, 5134.640575159852, 5216.0, 5225.16397376418, 5246.76389562463, 5260.736963151904, 5270.920936185884, 5141.511556402285, 5144.202648589475, 5150.9227361588855, 5161.354830646169, 5179.093658609803], "value": 3979.3353475413114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3692633513816, 713.1121753416996, 717.3507975282369, 726.2048057377174, 745.0351794426217, 10471.476426178699, 10775.191860610455, 11108.500117494712, 11123.888761112376, 12908.225506469618, 12015.0, 12138.514459421634, 12194.390280485963, 12199.878001219986, 12228.266304021765, 798.4849771897123, 800.4596897094467, 802.7872613757359, 808.1030056637128, 809.8096947217399, 804.4127786715701, 807.5598798654718, 809.0210844877705, 810.092696180279, 810.6554714246452, 845.2519520224615, 848.0459483081534, 852.9019162796264, 854.1927878155146, 854.6154230596226, 849.452103393311, 849.8087930215714, 850.2262940723942, 852.1819053708448, 853.1298075962484, 575.8992176369161, 610.5664977865721, 611.8500967263004, 615.1080932647678, 615.2493957371998, 12439.75120497594, 12483.251004939733, 12528.0, 12598.874011259863, 12623.116381853273, 11482.425878706032, 12290.262584244885, 12307.384630768425, 12310.876891231062, 12603.684907877376, 10020.448875311855, 10076.345037572608, 10081.042300981395, 10159.441230732307, 10246.53890574926, 3024.4555979923607, 3027.8486075696346, 3046.8324242166673, 3091.8917837875565, 3133.388989147117, 46371.76814115942, 46528.53471465276, 47547.76226118882, 47579.28631070536, 47615.523844761454, 9634.277429192838, 9840.346016623165, 9851.310408271496, 10012.54943527543, 10123.848142277871, 16426.917865410596, 16927.069011204254, 16933.830661693224, 16948.74576881348, 17496.91251543734, 6688.799336019927, 6705.765298214539, 6818.318168183142, 6824.18109826814, 6836.623985680835, 3656.542932133483, 3690.9077273068388, 3744.0, 3756.4553139794575, 3777.112378591029, 2641.537730897085, 2715.3347429879805, 2922.897698580582, 3035.8178509289514, 3036.8481575921114, 563.1299642053037, 584.1967294969417, 584.4506164205633, 595.8916415467228, 596.6181643748005, 468.95310468952835, 582.8488734748837, 595.967221802805, 601.5398220361427, 661.1867403094221, 8132.878006829902, 8211.137830527829, 8231.176882311722, 8263.628136733862, 8360.331173506105, 530.8513616187473, 605.3976293587821, 611.0925275965188, 621.5959626242887, 653.8103949854584, 3513.9121521962156, 3606.495090687306, 3656.0859785053735, 3680.595134535199, 3850.249201405699, 47035.294470582965, 51525.7423712879, 58844.705776470844, 60137.0, 60169.39830601638, 41853.372199417034, 44834.55165448304, 44993.77503112529, 45179.32231016537, 45200.77399613047, 42748.145037099086, 43349.349759753626, 43396.69809905708, 44550.55449445529, 44552.55447445484, 7725.420593455401, 7879.881801773093, 8040.0, 8128.105908349959, 8190.7952301192945, 28706.83750856156, 30297.0, 30876.22809429782, 31122.844385778833, 31236.0, 39762.60237397589, 40365.1926961465, 40512.59487405088, 40558.594414056664, 41073.794631026656, 11017.889821101686, 11019.449027548751, 11099.5560177592, 11182.832257515982, 11332.433378331216, 12241.938790305992, 12349.567765128177, 12417.254964702146, 12473.93763031179, 12804.167729097579, 11106.222564420414, 11415.029722473682, 11673.299602023906, 11722.70693232676, 11933.46299416511, 10449.16406687448, 10509.159267258754, 10681.626143084955, 10935.45322733876, 11095.334279943228, 10394.428306443218, 10898.237123401286, 11538.596149135075, 11820.940895295469, 11824.054075674097, 8482.321414286718, 8767.167119123673, 8930.464172149692, 9136.95431522838, 9373.578188981375, 9120.133587309196, 9395.85906211421, 9468.479233642216, 9529.52352382392, 9534.713958581253], "value": 5960.504319983476, "unit": "score"}], "name": "dromaeo_css", "value": 6219.296726262483, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 112.0, 113.0, 126.0, 115.0, 114.0, 113.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 132.0, 161.0, 193.0, 135.0, 160.0, 174.0, 134.0, 197.0, 134.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 171.0, 166.0, 163.0, 165.0, 162.0, 166.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 169.0, 78.0, 75.0, 73.0, 75.0, 163.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 142.0, 95.0, 95.0, 94.0, 138.0, 95.0, 94.0, 137.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 151.0, 148.0, 147.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 100.0, 96.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 67.0, 68.0, 65.0, 65.0, 91.0, 63.0, 64.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 69.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 82.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 137.0, 134.0, 146.0, 137.0, 134.0, 151.0, 185.0, 138.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 234.0, 221.0, 219.0, 218.0, 221.0, 231.0, 223.0, 224.0, 221.0], "value": 223.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 75.0, 77.0, 73.0, 75.0, 74.0, 76.0, 77.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1656.8999999999999, "alertThreshold": 2.0}]} 10:27:13 INFO - Return code: 0 10:27:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:27:13 ERROR - # TBPL SUCCESS # 10:27:13 INFO - Running post-action listener: _resource_record_post_action 10:27:13 INFO - Running post-run listener: _resource_record_post_run 10:27:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389189632; Read time: 204; Write time: 263820 10:27:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78237696; Read time: 0; Write time: 62728 10:27:14 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294379520; Read time: 204; Write time: 165932 10:27:14 INFO - Running post-run listener: _upload_blobber_files 10:27:14 INFO - Blob upload gear active. 10:27:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27: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 10:27: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'] 10:27: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 10:27:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:16 INFO - (blobuploader) - INFO - Done attempting. 10:27:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:27:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:16 INFO - (blobuploader) - INFO - Done attempting. 10:27:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:16 INFO - Return code: 0 10:27:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a141a07a7fa3c048f821e93e608a34ed4737140e14215a309372e18d8ffe52e3f28e4ed5f7ffc5d91c285f27ef012c619bae16bcd495db3201cd11c2c40f313a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f23d6eb59aa1c19d7fde0c60ceec3e544d143c0f995ae0e37ec250996f96aeda3bd190c9e4605973eb9ec9784d36e56fb4205152737e34edadf59adfb64600c0"} 10:27:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:16 INFO - Contents: 10:27:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a141a07a7fa3c048f821e93e608a34ed4737140e14215a309372e18d8ffe52e3f28e4ed5f7ffc5d91c285f27ef012c619bae16bcd495db3201cd11c2c40f313a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f23d6eb59aa1c19d7fde0c60ceec3e544d143c0f995ae0e37ec250996f96aeda3bd190c9e4605973eb9ec9784d36e56fb4205152737e34edadf59adfb64600c0"} 10:27:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:16 INFO - Copying logs to upload dir... 10:27:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.802649 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-27 10:27:16.619175) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:27:16.622376) ========= 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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a141a07a7fa3c048f821e93e608a34ed4737140e14215a309372e18d8ffe52e3f28e4ed5f7ffc5d91c285f27ef012c619bae16bcd495db3201cd11c2c40f313a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f23d6eb59aa1c19d7fde0c60ceec3e544d143c0f995ae0e37ec250996f96aeda3bd190c9e4605973eb9ec9784d36e56fb4205152737e34edadf59adfb64600c0"} build_url:https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/EHdcqQHrT_-wbs363SOHWQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a141a07a7fa3c048f821e93e608a34ed4737140e14215a309372e18d8ffe52e3f28e4ed5f7ffc5d91c285f27ef012c619bae16bcd495db3201cd11c2c40f313a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f23d6eb59aa1c19d7fde0c60ceec3e544d143c0f995ae0e37ec250996f96aeda3bd190c9e4605973eb9ec9784d36e56fb4205152737e34edadf59adfb64600c0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:27:16.648636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:27:16.648969) ========= 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=0e2a256762fed810e2f0f810000001b3-1461776726.82740-1067918776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004775 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:27:16.730898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:27:16.731225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:27:16.731505) ========= ========= Total master_lag: 0.16 =========