builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1463281780.23 results: success (0) buildid: 20160514173010 builduid: c0ac523baf474938b02204cb6bff301d revision: 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.227187) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.227624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.228129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.469365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.472932) ========= 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-1463281487.485346-293618923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 20:09:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.8M=0s 2016-05-14 20:09:40 (30.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093030 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.593564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.594180) ========= 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-1463281487.485346-293618923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013895 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.650618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:40.651070) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a --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 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a --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-1463281487.485346-293618923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 20:09:40,944 truncating revision to first 12 chars 2016-05-14 20:09:40,944 Setting DEBUG logging. 2016-05-14 20:09:40,944 attempt 1/10 2016-05-14 20:09:40,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/091bc7c572db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 20:09:41,500 unpacking tar archive at: fx-team-091bc7c572db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:41.517210) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:41.517623) ========= script_repo_revision: 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:41.518067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:41.518387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 20:09:41.528619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-05-14 20:09:41.529000) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:41 INFO - MultiFileLogger online at 20160514 20:09:41 in /builds/slave/test 20:09:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:09:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:41 INFO - {'append_to_log': False, 20:09:41 INFO - 'base_work_dir': '/builds/slave/test', 20:09:41 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:41 INFO - 'branch': 'Fx-Team', 20:09:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:41 INFO - 'config_files': ('talos/linux_config.py',), 20:09:41 INFO - 'default_actions': ('clobber', 20:09:41 INFO - 'read-buildbot-config', 20:09:41 INFO - 'download-and-extract', 20:09:41 INFO - 'populate-webroot', 20:09:41 INFO - 'create-virtualenv', 20:09:41 INFO - 'install', 20:09:41 INFO - 'run-tests'), 20:09:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:41 INFO - 'download_minidump_stackwalk': True, 20:09:41 INFO - 'download_symbols': 'ondemand', 20:09:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:41 INFO - 'installer_path': 'installer.exe', 20:09:41 INFO - 'log_level': 'info', 20:09:41 INFO - 'log_name': 'talos', 20:09:41 INFO - 'log_to_console': True, 20:09:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:41 INFO - 'opt_config_files': (), 20:09:41 INFO - 'pip_index': False, 20:09:41 INFO - 'sps_profile': False, 20:09:41 INFO - 'sps_profile_interval': 0, 20:09:41 INFO - 'suite': 'dromaeojs-e10s', 20:09:41 INFO - 'system_bits': '32', 20:09:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:41 INFO - 'title': 'talos-linux64-ix-058', 20:09:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:41 INFO - 'use_talos_json': True, 20:09:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:41 INFO - 'work_dir': 'build'} 20:09:41 INFO - ##### 20:09:41 INFO - ##### Running clobber step. 20:09:41 INFO - ##### 20:09:41 INFO - Running pre-action listener: _resource_record_pre_action 20:09:41 INFO - Running main action method: clobber 20:09:41 INFO - rmtree: /builds/slave/test/build 20:09:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:42 INFO - Running post-action listener: _resource_record_post_action 20:09:42 INFO - ##### 20:09:42 INFO - ##### Finished clobber step (success) 20:09:42 INFO - ##### 20:09:42 INFO - ##### 20:09:42 INFO - ##### Running read-buildbot-config step. 20:09:42 INFO - ##### 20:09:42 INFO - Running pre-action listener: _resource_record_pre_action 20:09:42 INFO - Running main action method: read_buildbot_config 20:09:42 INFO - Using buildbot properties: 20:09:42 INFO - { 20:09:42 INFO - "project": "", 20:09:42 INFO - "product": "firefox", 20:09:42 INFO - "script_repo_revision": "production", 20:09:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:09:42 INFO - "repository": "", 20:09:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:09:42 INFO - "buildid": "20160514173010", 20:09:42 INFO - "pgo_build": "True", 20:09:42 INFO - "basedir": "/builds/slave/test", 20:09:42 INFO - "buildnumber": 328, 20:09:42 INFO - "slavename": "talos-linux64-ix-058", 20:09:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:09:42 INFO - "platform": "ubuntu64_hw", 20:09:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:42 INFO - "branch": "fx-team", 20:09:42 INFO - "repo_path": "integration/fx-team", 20:09:42 INFO - "revision": "091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a", 20:09:42 INFO - "stage_platform": "linux64-pgo", 20:09:42 INFO - "builduid": "c0ac523baf474938b02204cb6bff301d", 20:09:42 INFO - "slavebuilddir": "test" 20:09:42 INFO - } 20:09:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:09:42 INFO - Running post-action listener: _resource_record_post_action 20:09:42 INFO - ##### 20:09:42 INFO - ##### Finished read-buildbot-config step (success) 20:09:42 INFO - ##### 20:09:42 INFO - ##### 20:09:42 INFO - ##### Running download-and-extract step. 20:09:42 INFO - ##### 20:09:42 INFO - Running pre-action listener: _resource_record_pre_action 20:09:42 INFO - Running main action method: download_and_extract 20:09:42 INFO - mkdir: /builds/slave/test/build/tests 20:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:42 INFO - https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:46 INFO - Downloaded 1361 bytes. 20:09:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:46 INFO - Using the following test package requirements: 20:09:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'jsshell-linux-x86_64.zip'], 20:09:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09: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')]} 20:09:46 INFO - https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:47 INFO - Downloaded 24022619 bytes. 20:09:47 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'] 20:09:47 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 20:09:48 INFO - Return code: 0 20:09:48 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 20:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:48 INFO - https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:50 INFO - Downloaded 24022619 bytes. 20:09:50 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'] 20:09:50 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 20:09:51 INFO - Return code: 0 20:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:51 INFO - https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:53 INFO - Downloaded 10840194 bytes. 20:09:53 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'] 20:09:53 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 20:09:53 INFO - Return code: 0 20:09: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')]} 20:09:53 INFO - https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:09:56 INFO - Downloaded 58398130 bytes. 20:09:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:56 INFO - mkdir: /builds/slave/test/properties 20:09:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:56 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:56 INFO - Contents: 20:09:56 INFO - build_url:https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:57 INFO - Running post-action listener: _resource_record_post_action 20:09:57 INFO - Running post-action listener: set_extra_try_arguments 20:09:57 INFO - ##### 20:09:57 INFO - ##### Finished download-and-extract step (success) 20:09:57 INFO - ##### 20:09:57 INFO - ##### 20:09:57 INFO - ##### Running populate-webroot step. 20:09:57 INFO - ##### 20:09:57 INFO - Running pre-action listener: _resource_record_pre_action 20:09:57 INFO - Running main action method: populate_webroot 20:09:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:57 INFO - '--tppagecycles', 20:09:57 INFO - '7'], 20:09:57 INFO - 'tests': ['tsvgm']}}, 20:09:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['damp', 'tps']}, 20:09:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'tests': ['damp', 'tps']}, 20:09:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['dromaeo_dom']}, 20:09:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['a11yr', 20:09:57 INFO - 'ts_paint', 20:09:57 INFO - 'tpaint', 20:09:57 INFO - 'sessionrestore', 20:09:57 INFO - 'sessionrestore_no_auto_restore', 20:09:57 INFO - 'tabpaint']}, 20:09:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['tsvgx', 20:09:57 INFO - 'tsvgr_opacity', 20:09:57 INFO - 'tart', 20:09:57 INFO - 'tscrollx', 20:09:57 INFO - 'cart']}, 20:09:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:57 INFO - 'tsvgr_opacity', 20:09:57 INFO - 'tart', 20:09:57 INFO - 'tscrollx', 20:09:57 INFO - 'cart']}, 20:09:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'talos_options': ['--disable-e10s'], 20:09:57 INFO - 'tests': ['tp5o']}, 20:09:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'tests': ['tp5o']}, 20:09:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'talos_options': ['--disable-e10s', 20:09:57 INFO - '--xperf_path', 20:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:57 INFO - 'tests': ['tp5n']}, 20:09:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:57 INFO - 'talos_options': ['--xperf_path', 20:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:57 INFO - 'tests': ['tp5n']}}, 20:09:57 INFO - 'talos.zip': {'path': '', 20:09:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:57 INFO - Running post-action listener: _resource_record_post_action 20:09:57 INFO - ##### 20:09:57 INFO - ##### Finished populate-webroot step (success) 20:09:57 INFO - ##### 20:09:57 INFO - ##### 20:09:57 INFO - ##### Running create-virtualenv step. 20:09:57 INFO - ##### 20:09:57 INFO - Running pre-action listener: _resource_record_pre_action 20:09:57 INFO - Running main action method: create_virtualenv 20:09:57 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:57 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 20:09:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:57 INFO - Using real prefix '/usr' 20:09:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:00 INFO - Installing pip.................done. 20:10:00 INFO - Return code: 0 20:10:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:10:00 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')]} 20:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:00 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')]} 20:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:00 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:00 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 20:10:00 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 20:10:00 INFO - Using env: {'DISPLAY': ':0', 20:10:00 INFO - 'HOME': '/home/cltbld', 20:10:00 INFO - 'LANG': 'en_US.UTF-8', 20:10:00 INFO - 'LANGUAGE': 'en_US:en', 20:10:00 INFO - 'LOGNAME': 'cltbld', 20:10:00 INFO - 'MAIL': '/var/mail/cltbld', 20:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:00 INFO - 'MOZ_NO_REMOTE': '1', 20:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:00 INFO - 'NO_EM_RESTART': '1', 20:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:00 INFO - 'PWD': '/builds/slave/test', 20:10:00 INFO - 'SHELL': '/bin/bash', 20:10:00 INFO - 'SHLVL': '1', 20:10:00 INFO - 'TERM': 'linux', 20:10:00 INFO - 'TMOUT': '86400', 20:10:00 INFO - 'USER': 'cltbld', 20:10:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:00 INFO - '_': '/tools/buildbot/bin/python'} 20:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:00 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 20:10:00 INFO - Cleaning up... 20:10:00 INFO - Return code: 0 20:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:10:00 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')]} 20:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:00 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')]} 20:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:00 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:00 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>=3.1.1'] in /builds/slave/test/build 20:10:00 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>=3.1.1 20:10:00 INFO - Using env: {'DISPLAY': ':0', 20:10:00 INFO - 'HOME': '/home/cltbld', 20:10:00 INFO - 'LANG': 'en_US.UTF-8', 20:10:00 INFO - 'LANGUAGE': 'en_US:en', 20:10:00 INFO - 'LOGNAME': 'cltbld', 20:10:00 INFO - 'MAIL': '/var/mail/cltbld', 20:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:00 INFO - 'MOZ_NO_REMOTE': '1', 20:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:00 INFO - 'NO_EM_RESTART': '1', 20:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:00 INFO - 'PWD': '/builds/slave/test', 20:10:00 INFO - 'SHELL': '/bin/bash', 20:10:00 INFO - 'SHLVL': '1', 20:10:00 INFO - 'TERM': 'linux', 20:10:00 INFO - 'TMOUT': '86400', 20:10:00 INFO - 'USER': 'cltbld', 20:10:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:00 INFO - '_': '/tools/buildbot/bin/python'} 20:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:00 INFO - Downloading/unpacking psutil>=3.1.1 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:02 INFO - Installing collected packages: psutil 20:10:02 INFO - Running setup.py install for psutil 20:10:02 INFO - building 'psutil._psutil_linux' extension 20:10:02 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 20:10:02 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 20:10:02 INFO - building 'psutil._psutil_posix' extension 20:10:02 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 20:10:03 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 20:10:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:03 INFO - Successfully installed psutil 20:10:03 INFO - Cleaning up... 20:10:03 INFO - Return code: 0 20:10:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:03 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:03 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.3'] in /builds/slave/test/build 20:10:03 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.3 20:10:03 INFO - Using env: {'DISPLAY': ':0', 20:10:03 INFO - 'HOME': '/home/cltbld', 20:10:03 INFO - 'LANG': 'en_US.UTF-8', 20:10:03 INFO - 'LANGUAGE': 'en_US:en', 20:10:03 INFO - 'LOGNAME': 'cltbld', 20:10:03 INFO - 'MAIL': '/var/mail/cltbld', 20:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:03 INFO - 'MOZ_NO_REMOTE': '1', 20:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:03 INFO - 'NO_EM_RESTART': '1', 20:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:03 INFO - 'PWD': '/builds/slave/test', 20:10:03 INFO - 'SHELL': '/bin/bash', 20:10:03 INFO - 'SHLVL': '1', 20:10:03 INFO - 'TERM': 'linux', 20:10:03 INFO - 'TMOUT': '86400', 20:10:03 INFO - 'USER': 'cltbld', 20:10:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:03 INFO - '_': '/tools/buildbot/bin/python'} 20:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:10:03 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 20:10:03 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 20:10:03 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 20:10:03 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 20:10:03 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 20:10:03 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 20:10:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:10:05 INFO - Installing collected packages: mozsystemmonitor 20:10:05 INFO - Running setup.py install for mozsystemmonitor 20:10:05 INFO - Successfully installed mozsystemmonitor 20:10:05 INFO - Cleaning up... 20:10:05 INFO - Return code: 0 20:10:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:05 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:05 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 20:10:05 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 20:10:05 INFO - Using env: {'DISPLAY': ':0', 20:10:05 INFO - 'HOME': '/home/cltbld', 20:10:05 INFO - 'LANG': 'en_US.UTF-8', 20:10:05 INFO - 'LANGUAGE': 'en_US:en', 20:10:05 INFO - 'LOGNAME': 'cltbld', 20:10:05 INFO - 'MAIL': '/var/mail/cltbld', 20:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:05 INFO - 'MOZ_NO_REMOTE': '1', 20:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:05 INFO - 'NO_EM_RESTART': '1', 20:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:05 INFO - 'PWD': '/builds/slave/test', 20:10:05 INFO - 'SHELL': '/bin/bash', 20:10:05 INFO - 'SHLVL': '1', 20:10:05 INFO - 'TERM': 'linux', 20:10:05 INFO - 'TMOUT': '86400', 20:10:05 INFO - 'USER': 'cltbld', 20:10:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:05 INFO - '_': '/tools/buildbot/bin/python'} 20:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:05 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:05 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 20:10:05 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 20:10:05 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 20:10:05 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 20:10:05 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 20:10:05 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 20:10:07 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:08 INFO - Downloading docopt-0.6.1.tar.gz 20:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:08 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:08 INFO - Running setup.py install for blobuploader 20:10:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:10:08 INFO - Running setup.py install for requests 20:10:08 INFO - Running setup.py install for docopt 20:10:08 INFO - Successfully installed blobuploader requests docopt 20:10:08 INFO - Cleaning up... 20:10:09 INFO - Return code: 0 20:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:09 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:09 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 20:10:09 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 20:10:09 INFO - Using env: {'DISPLAY': ':0', 20:10:09 INFO - 'HOME': '/home/cltbld', 20:10:09 INFO - 'LANG': 'en_US.UTF-8', 20:10:09 INFO - 'LANGUAGE': 'en_US:en', 20:10:09 INFO - 'LOGNAME': 'cltbld', 20:10:09 INFO - 'MAIL': '/var/mail/cltbld', 20:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:09 INFO - 'MOZ_NO_REMOTE': '1', 20:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:09 INFO - 'NO_EM_RESTART': '1', 20:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:09 INFO - 'PWD': '/builds/slave/test', 20:10:09 INFO - 'SHELL': '/bin/bash', 20:10:09 INFO - 'SHLVL': '1', 20:10:09 INFO - 'TERM': 'linux', 20:10:09 INFO - 'TMOUT': '86400', 20:10:09 INFO - 'USER': 'cltbld', 20:10:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:09 INFO - '_': '/tools/buildbot/bin/python'} 20:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:09 INFO - Running setup.py (path:/tmp/pip-9BmoCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:09 INFO - Running setup.py (path:/tmp/pip-Q3UkcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:09 INFO - Running setup.py (path:/tmp/pip-IBxSIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:09 INFO - Running setup.py (path:/tmp/pip-18Mzq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:09 INFO - Running setup.py (path:/tmp/pip-7nlOfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:09 INFO - Running setup.py (path:/tmp/pip-ysr2rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:09 INFO - Running setup.py (path:/tmp/pip-LanCaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:09 INFO - Running setup.py (path:/tmp/pip-xqDsLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:09 INFO - Running setup.py (path:/tmp/pip-yXJSVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:09 INFO - Running setup.py (path:/tmp/pip-uPgQLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:09 INFO - Running setup.py (path:/tmp/pip-5Hij7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:10 INFO - Running setup.py (path:/tmp/pip-7nlt25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:10 INFO - Running setup.py (path:/tmp/pip-HuCEEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:10 INFO - Running setup.py (path:/tmp/pip-f3NfNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:10 INFO - Running setup.py (path:/tmp/pip-boipxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:10 INFO - Running setup.py (path:/tmp/pip-IN13P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:10 INFO - Running setup.py (path:/tmp/pip-uVyS1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:10 INFO - Running setup.py install for manifestparser 20:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:10:10 INFO - Running setup.py install for mozcrash 20:10:10 INFO - Running setup.py install for mozdebug 20:10:10 INFO - Running setup.py install for mozdevice 20:10:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:10:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:10:10 INFO - Running setup.py install for mozfile 20:10:11 INFO - Running setup.py install for mozhttpd 20:10:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozinfo 20:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozInstall 20:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozleak 20:10:11 INFO - Running setup.py install for mozlog 20:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for moznetwork 20:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozprocess 20:10:11 INFO - Running setup.py install for mozprofile 20:10:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozrunner 20:10:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:10:11 INFO - Running setup.py install for mozscreenshot 20:10:12 INFO - Running setup.py install for moztest 20:10:12 INFO - Running setup.py install for mozversion 20:10:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:10:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:12 INFO - Cleaning up... 20:10:12 INFO - Return code: 0 20:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:12 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 20:10:12 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 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:12 INFO - Running setup.py (path:/tmp/pip-shkIRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:12 INFO - Running setup.py (path:/tmp/pip-NqHKj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:12 INFO - Running setup.py (path:/tmp/pip-U9dehx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:12 INFO - Running setup.py (path:/tmp/pip-C9FoK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:12 INFO - Running setup.py (path:/tmp/pip-c7yIJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:12 INFO - Running setup.py (path:/tmp/pip-4USn5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:12 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)) 20:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:12 INFO - Running setup.py (path:/tmp/pip-yfF0CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:13 INFO - Running setup.py (path:/tmp/pip-PzaBPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:13 INFO - Running setup.py (path:/tmp/pip-d2hYrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:13 INFO - Running setup.py (path:/tmp/pip-zCzedi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:13 INFO - Running setup.py (path:/tmp/pip-IaWwXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:13 INFO - Running setup.py (path:/tmp/pip-jS2i5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:13 INFO - Running setup.py (path:/tmp/pip-pbUfYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:13 INFO - Running setup.py (path:/tmp/pip-wtgehE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:13 INFO - Running setup.py (path:/tmp/pip-kFWczR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:13 INFO - Running setup.py (path:/tmp/pip-XTiexN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:13 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)) 20:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:13 INFO - Running setup.py (path:/tmp/pip-e0UbX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:13 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)) 20:10:13 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)) 20:10:13 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)) 20:10:13 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)) 20:10:13 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)) 20:10:13 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)) 20:10:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:15 INFO - Downloading blessings-1.6.tar.gz 20:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:15 INFO - Installing collected packages: blessings 20:10:15 INFO - Running setup.py install for blessings 20:10:15 INFO - Successfully installed blessings 20:10:15 INFO - Cleaning up... 20:10:15 INFO - Return code: 0 20:10:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:16 INFO - Reading from file tmpfile_stdout 20:10:16 INFO - Current package versions: 20:10:16 INFO - argparse == 1.2.1 20:10:16 INFO - blessings == 1.6 20:10:16 INFO - blobuploader == 1.2.4 20:10:16 INFO - docopt == 0.6.1 20:10:16 INFO - manifestparser == 1.1 20:10:16 INFO - mozInstall == 1.12 20:10:16 INFO - mozcrash == 0.17 20:10:16 INFO - mozdebug == 0.1 20:10:16 INFO - mozdevice == 0.48 20:10:16 INFO - mozfile == 1.2 20:10:16 INFO - mozhttpd == 0.7 20:10:16 INFO - mozinfo == 0.9 20:10:16 INFO - mozleak == 0.1 20:10:16 INFO - mozlog == 3.2 20:10:16 INFO - moznetwork == 0.27 20:10:16 INFO - mozprocess == 0.22 20:10:16 INFO - mozprofile == 0.28 20:10:16 INFO - mozrunner == 6.11 20:10:16 INFO - mozscreenshot == 0.1 20:10:16 INFO - mozsystemmonitor == 0.3 20:10:16 INFO - moztest == 0.7 20:10:16 INFO - mozversion == 1.4 20:10:16 INFO - psutil == 3.1.1 20:10:16 INFO - requests == 1.2.3 20:10:16 INFO - wsgiref == 0.1.2 20:10:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:16 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:16 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 20:10:16 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 20:10:16 INFO - Using env: {'DISPLAY': ':0', 20:10:16 INFO - 'HOME': '/home/cltbld', 20:10:16 INFO - 'LANG': 'en_US.UTF-8', 20:10:16 INFO - 'LANGUAGE': 'en_US:en', 20:10:16 INFO - 'LOGNAME': 'cltbld', 20:10:16 INFO - 'MAIL': '/var/mail/cltbld', 20:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:16 INFO - 'MOZ_NO_REMOTE': '1', 20:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:16 INFO - 'NO_EM_RESTART': '1', 20:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:16 INFO - 'PWD': '/builds/slave/test', 20:10:16 INFO - 'SHELL': '/bin/bash', 20:10:16 INFO - 'SHLVL': '1', 20:10:16 INFO - 'TERM': 'linux', 20:10:16 INFO - 'TMOUT': '86400', 20:10:16 INFO - 'USER': 'cltbld', 20:10:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:16 INFO - '_': '/tools/buildbot/bin/python'} 20:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 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)) 20:10:16 INFO - Cleaning up... 20:10:16 INFO - Return code: 0 20:10:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:10:16 INFO - Using env: {'DISPLAY': ':0', 20:10:16 INFO - 'HOME': '/home/cltbld', 20:10:16 INFO - 'LANG': 'en_US.UTF-8', 20:10:16 INFO - 'LANGUAGE': 'en_US:en', 20:10:16 INFO - 'LOGNAME': 'cltbld', 20:10:16 INFO - 'MAIL': '/var/mail/cltbld', 20:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:16 INFO - 'MOZ_NO_REMOTE': '1', 20:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:16 INFO - 'NO_EM_RESTART': '1', 20:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:16 INFO - 'PWD': '/builds/slave/test', 20:10:16 INFO - 'SHELL': '/bin/bash', 20:10:16 INFO - 'SHLVL': '1', 20:10:16 INFO - 'TERM': 'linux', 20:10:16 INFO - 'TMOUT': '86400', 20:10:16 INFO - 'USER': 'cltbld', 20:10:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:16 INFO - '_': '/tools/buildbot/bin/python'} 20:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:16 INFO - Downloading/unpacking jsonschema 20:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:18 INFO - Downloading/unpacking functools32 (from jsonschema) 20:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:18 INFO - warning: no files found matching '*.txt' 20:10:18 INFO - no previously-included directories found matching 'build' 20:10:18 INFO - no previously-included directories found matching 'dist' 20:10:18 INFO - no previously-included directories found matching '.git*' 20:10:18 INFO - Installing collected packages: jsonschema, functools32 20:10:18 INFO - Running setup.py install for functools32 20:10:18 INFO - warning: no files found matching '*.txt' 20:10:18 INFO - no previously-included directories found matching 'build' 20:10:18 INFO - no previously-included directories found matching 'dist' 20:10:18 INFO - no previously-included directories found matching '.git*' 20:10:18 INFO - Successfully installed jsonschema functools32 20:10:18 INFO - Cleaning up... 20:10:18 INFO - Return code: 0 20:10:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:10:18 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')]} 20:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:18 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')]} 20:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:18 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 0x7f9dec733f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, '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-1463281487.485346-293618923', '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 20:10:18 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 20:10:18 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 20:10:18 INFO - Using env: {'DISPLAY': ':0', 20:10:18 INFO - 'HOME': '/home/cltbld', 20:10:18 INFO - 'LANG': 'en_US.UTF-8', 20:10:18 INFO - 'LANGUAGE': 'en_US:en', 20:10:18 INFO - 'LOGNAME': 'cltbld', 20:10:18 INFO - 'MAIL': '/var/mail/cltbld', 20:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:18 INFO - 'MOZ_NO_REMOTE': '1', 20:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:18 INFO - 'NO_EM_RESTART': '1', 20:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:18 INFO - 'PWD': '/builds/slave/test', 20:10:18 INFO - 'SHELL': '/bin/bash', 20:10:18 INFO - 'SHLVL': '1', 20:10:18 INFO - 'TERM': 'linux', 20:10:18 INFO - 'TMOUT': '86400', 20:10:18 INFO - 'USER': 'cltbld', 20:10:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:18 INFO - '_': '/tools/buildbot/bin/python'} 20:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:19 INFO - Downloading/unpacking flake8 20:10:19 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 20:10:19 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 20:10:19 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 20:10:19 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 20:10:19 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 20:10:19 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 20:10:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:10:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:10:20 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 20:10:20 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 20:10:20 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 20:10:20 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 20:10:21 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 20:10:21 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 20:10:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:10:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 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 20:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:21 INFO - no previously-included directories found matching 'docs/_build' 20:10:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:10:21 INFO - Running setup.py install for pep8 20:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:21 INFO - no previously-included directories found matching 'docs/_build' 20:10:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:10:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:10:21 INFO - Cleaning up... 20:10:21 INFO - Return code: 0 20:10:21 INFO - Running post-action listener: _resource_record_post_action 20:10:21 INFO - Running post-action listener: _start_resource_monitoring 20:10:21 INFO - Starting resource monitoring. 20:10:21 INFO - ##### 20:10:22 INFO - ##### Finished create-virtualenv step (success) 20:10:22 INFO - ##### 20:10:22 INFO - ##### 20:10:22 INFO - ##### Running install step. 20:10:22 INFO - ##### 20:10:22 INFO - Running pre-action listener: _resource_record_pre_action 20:10:22 INFO - Running main action method: install 20:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:22 INFO - Reading from file tmpfile_stdout 20:10:22 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:22 INFO - Reading from file tmpfile_stdout 20:10:22 INFO - Output received: 20:10:22 INFO - Usage: mozinstall [options] installer 20:10:22 INFO - Options: 20:10:22 INFO - -h, --help show this help message and exit 20:10:22 INFO - -d DEST, --destination=DEST 20:10:22 INFO - Directory to install application into. [default: 20:10:22 INFO - "/builds/slave/test"] 20:10:22 INFO - --app=APP Application being installed. [default: firefox] 20:10:22 INFO - mkdir: /builds/slave/test/build/application 20:10:22 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'] 20:10:22 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 20:10:38 INFO - Reading from file tmpfile_stdout 20:10:38 INFO - Output received: 20:10:38 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:38 INFO - Running post-action listener: _resource_record_post_action 20:10:38 INFO - ##### 20:10:38 INFO - ##### Finished install step (success) 20:10:38 INFO - ##### 20:10:38 INFO - ##### 20:10:38 INFO - ##### Running run-tests step. 20:10:38 INFO - ##### 20:10:38 INFO - Running pre-action listener: _resource_record_pre_action 20:10:38 INFO - Running main action method: run_tests 20:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:38 INFO - Python 2.7.3 20:10:38 INFO - Return code: 0 20:10:38 INFO - grabbing minidump binary from tooltool 20:10:38 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')]} 20:10:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11299c0>, '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 0x112a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:38 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 20:10:38 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 20:10:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:10:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:38 INFO - Return code: 0 20:10:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:10:39 INFO - Return code: 0 20:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:10:39 INFO - Using env: {'DISPLAY': ':0', 20:10:39 INFO - 'HOME': '/home/cltbld', 20:10:39 INFO - 'LANG': 'en_US.UTF-8', 20:10:39 INFO - 'LANGUAGE': 'en_US:en', 20:10:39 INFO - 'LOGNAME': 'cltbld', 20:10:39 INFO - 'MAIL': '/var/mail/cltbld', 20:10:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:39 INFO - 'MOZ_NO_REMOTE': '1', 20:10:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:39 INFO - 'NO_EM_RESTART': '1', 20:10:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:39 INFO - 'PWD': '/builds/slave/test', 20:10:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:39 INFO - 'SHELL': '/bin/bash', 20:10:39 INFO - 'SHLVL': '1', 20:10:39 INFO - 'TERM': 'linux', 20:10:39 INFO - 'TMOUT': '86400', 20:10:39 INFO - 'USER': 'cltbld', 20:10:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463281487.485346-293618923', 20:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:39 INFO - '_': '/tools/buildbot/bin/python'} 20:10:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/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 20:10:40 INFO - mozversion application_buildid: 20160514173010 20:10:40 INFO - mozversion application_changeset: 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a 20:10:40 INFO - mozversion application_display_name: Nightly 20:10:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:40 INFO - mozversion application_name: Firefox 20:10:40 INFO - mozversion application_remotingname: firefox 20:10:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:40 INFO - mozversion application_vendor: Mozilla 20:10:40 INFO - mozversion application_version: 49.0a1 20:10:40 INFO - mozversion platform_buildid: 20160514173010 20:10:40 INFO - mozversion platform_changeset: 091bc7c572dbbfcb751c8e0d9c37b36ff0a83a6a 20:10:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:40 INFO - mozversion platform_version: 49.0a1 20:10:40 INFO - using testdate: 1463281840 20:10:40 INFO - actual date: 1463281840 20:10:40 INFO - starting webserver on 'localhost:55143' 20:10:40 INFO - SUITE-START | Running 2 tests 20:10:40 INFO - TEST-START | dromaeo_css 20:10:40 INFO - operating with platform_type : linux_ 20:10:40 INFO - Initialising browser for dromaeo_css test... 20:10:40 INFO - TEST-INFO | started process 12481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96Tvzc/profile http://localhost:55143/getInfo.html) 20:10:43 INFO - PROCESS | 12481 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 20:10:43 INFO - PROCESS | 12481 | 20:10:43 INFO - PROCESS | 12481 | (process:12550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:44 INFO - PROCESS | 12481 | __metrics Screen width/height:1600/1200 20:10:44 INFO - PROCESS | 12481 | colorDepth:24 20:10:44 INFO - PROCESS | 12481 | Browser inner width/height: 1024/697 20:10:44 INFO - PROCESS | 12481 | __metrics 20:10:45 ERROR - PROCESS | 12481 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:10:46 INFO - TEST-INFO | 12481: exit 0 20:10:46 INFO - Browser initialized. 20:10:46 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:46 INFO - TEST-INFO | started process 12601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96Tvzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:48 INFO - PROCESS | 12601 | 20:10:48 INFO - PROCESS | 12601 | (process:12664): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:58 INFO - PROCESS | 12601 | RSS: Main: 163180544 20:10:58 INFO - PROCESS | 12601 | 20:11:47 INFO - PROCESS | 12601 | 1463281907719 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] 20:13:55 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55143/tests/dromaeo/cssquery-ext.html) 20:13:56 INFO - PROCESS | 12601 | RSS: Main: 166563840 20:13:56 INFO - PROCESS | 12601 | 20:16:58 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-ext.html (next: http://localhost:55143/tests/dromaeo/cssquery-jquery.html) 20:16:59 INFO - PROCESS | 12601 | RSS: Main: 166662144 20:16:59 INFO - PROCESS | 12601 | 20:20:00 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55143/tests/dromaeo/cssquery-mootools.html) 20:20:01 INFO - PROCESS | 12601 | RSS: Main: 167411712 20:20:01 INFO - PROCESS | 12601 | 20:23:03 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55143/tests/dromaeo/cssquery-prototype.html) 20:23:03 INFO - PROCESS | 12601 | RSS: Main: 165367808 20:23:03 INFO - PROCESS | 12601 | 20:26:06 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55143/tests/dromaeo/cssquery-yui.html) 20:26:06 INFO - PROCESS | 12601 | RSS: Main: 166350848 20:26:06 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | Cycle 1(1): loaded http://localhost:55143/tests/dromaeo/cssquery-yui.html (next: http://localhost:55143/tests/dromaeo/cssquery-dojo.html) 20:29:09 INFO - PROCESS | 12601 | RSS: Main: 168308736 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | __start_tp_report 20:29:09 INFO - PROCESS | 12601 | _x_x_mozilla_page_load 20:29:09 INFO - PROCESS | 12601 | _x_x_mozilla_page_load_details 20:29:09 INFO - PROCESS | 12601 | |i|pagename|runs| 20:29:09 INFO - PROCESS | 12601 | |0;dojo.html;3209.6148462184533;3220.694034066763;3264.2165880188754;3270.493073573595;3273.3453309338124;5379.89240215195;5495.725213739312;5525.613207075507;5564.248826408434;5579.13523403872;5309.41596424394;5384.542313903323;5436.809711660093;5475.616706830523;5520.641158324706;4892.902141957159;4920.70475771453;5038.59691224703;5071.568916642072;5123.333966584358;760.0577843994029;4889.071076495472;4916.385451818523;5044.243363495469;5064.822731204408;4960.107180707471;4961.330220420233;4993.775280112385;5004.074246264417;5014.8244811431605;5003.574696150795;5004.274380214885;5014.5737612303;5016.824411145592;5040.949590504121;4932.235503496928;4976.35307410038;4984.40187177541;4993;4994.475580064077;5460;5469.480399362054;5479.4520547944885;5525.640833345819;5552.333719953591;5800.622959507618;5983;6038.0942858571125;6057;6069.02895536712;6079.756809727605;6105.672036200918;6127.861529871586;6130.034976025718;6138.8562720164155;5698.34469036062;5699.031164702011;5699.430056994267;5700.030994730864;5732.570057245724;5964.552658550626;6085.36103709113;6114.877702445926;6227.844303892349;6234;5819.098039803837;5820.563457740686;5820.941790582125;5823.155642431823;5845.09401042839;5987.161797348374;5995.070764031495;6004.879902401927;6011.398860114041;6012.669303188367;5840.065589505659;5859.619124756962;5886.58793884424;5907.852303692442;5996.460318571262;5863.120531920161;5876.206712093898;5906.645601263938;5935.258092738408;5959.702014899324;4451.376807246988;4487.551244875552;4490.034642551867;4498.235299999008;4563.155816174019;3924.4701965234326;3969.4442778011103;3974.503187101612;4016.397540368968;4018.678505719535;5468.972655136698;5513.889722205534;5544.112941929272;5588.6646801192055;5619.606627536034;5830.416958304136;5856.180134781134;5864.120381942657;5885.882282354414;5893.469587737124;5532.75102620383;5553.444655534495;5589.0219211637805;5596.440355964371;5599.664020158803;4997.450280469146;5036.924446133311;5041.470645582234;5063.645544811828;5079.111155547765;6052.606580572248;6060.393960603904;6064.787732429344;6092.055731361646;6128.111423843607;5928.6146400484695;5960.701964901651;6032;6033.78881739137;6040.244969378828;6161.969190154021;6172.845678858064;6179.412955769195;6184.907226391698;6196.318404975359;5784.161296612052;5865.149553314831;5871.266091738533;5895.4399332063385;5905.793297234576;6006.429389208019;6032.788852390146;6035.426634469718;6047.304559975659;6087;5855.795047173328;5869.941300586939;5887.264091988502;5895.67573783446;5901.3213480450295;5654.547636189177;5835.008048631658;5875.764969401176;5886.587938844411;5906.173135761082;5784.768609255582;5813.94186058134;5834.824955251349;5843.918875008138;5848.093545500455;5910.113482977587;5936.13925980739;5990.341062483036;6001.279846418458;6020.638761674313;5616.269884914935;5632.295963004624;5672;5696.060150075191;5750.13747937796 20:29:09 INFO - PROCESS | 12601 | |1;ext.html;594.82155353394;643.9278601129121;653.7123665587142;664.9767258145964;685.7188552693397;40214.39678404823;41492.17015659689;45034.54965450345;45139.097218055664;45400;46102.76948615252;46140.30789538151;46415.767921160346;46663.066738665206;46732.76633616836;9005.36962412633;9109.498977556232;9120.08799120086;9124.406913550598;9138.77153071172;8865.379423440361;9010;9024.23294020009;9025.097490250955;9040.638374465014;8952.910470895273;9029.367944243906;9059.365844390895;9061.093890610951;9076.410033347844;8902;8942.239909607692;8948.597313120892;8997.820043599091;9029.322800789967;8940.195382415548;8975;9037;9042.23141033013;9074.63880417936;34084.6591534084;42714.35928461076;42853.78573107145;42942.57057429417;43260.13479730388;3556.893293201208;3607.9458808117897;3764.811759412046;4091.468109145822;4277.8288868445225;31644.525332120036;31786.682133178605;32280.677193228235;32302.515462268086;33359.6664033359;3998.4402183694306;4004.759714417144;4030.3954406838916;4052.6352628263303;4068.877933661995;307170;310053.99999999773;311767;312289;312526;34580;34829.65170348264;34864.825675871456;34931.82534087313;35097.1225719354;36606;37862.810685946395;38271.42592861054;38354.80822595925;38420.42369364462;15920.203989800464;16087.597810054842;16089.839101609068;16135.112568808829;16154.596135096717;12736.490540378467;12743.553975610808;12861;12876.742465150644;12882.742345153045;8693.565321733888;8711.390202685878;8717.953845538575;8761.123887611187;8795.780105497413;3304.9008529744146;3329.883454079096;3347.983260083684;3350.2294472271515;3378.831058447117;1085.4247248958065;1094.190299178618;1143.9885601143883;1176.8293597428326;1200.9699757506132;32730.345393092004;33258.3348333032;33830.32339353248;34066.98374161695;34429.82785086109;1122.5229277557005;1135.795556799784;1136.772645470909;1160.5473865192582;1161.372858656333;16416.67166656684;16426.01443913369;16511.669766604602;16557;16756.748648770277;500411;838901;857583;862222;862548;60449;60566.0915086274;61020.69489652523;61132;61364.693176534725;1381.281733498575;1382.7372799168127;1395.1210737235476;1415.5045733993227;1419.4393214680144;32451;32975;33162.17094572655;33345.33309333751;34154.658453416145;51592.74203628958;51880.221796672326;52015.73992130015;52325;52470;377025;378338;381998;383057;383530;29148.125556233346;29196.854015729787;29454;29520.704792951794;29546.556801647563;47998;48009;48544.271835923195;49182.75408622934;49259.75370123127;41275.58724412717;41306.380404293355;41464;41466.37800432936;42728;40298.59701402948;41103.56137535172;41792.96711196242;42049.579504204565;42231.577684223994;41952.160956780084;42335;42571.3614295792;42923.141537168456;42938.78530607327;35352.64647353494;37374.6262537382;37394;37652.246955061295;38105.80947095247;28727.71272287334;28804.855975719987;28902.42195156127;29005.854970725013;29058.7094129056 20:29:09 INFO - PROCESS | 12601 | |2;jquery.html;391.635778725785;401.94774679291686;407.1206194619621;412.86581860895217;413.1076873952264;14128.858711412882;18208.817911820894;18789.248430062817;19912.800871991276;20046.198152073917;18751.531211719714;18826;19142.52143696408;19406.805931940675;19453.805461945376;5749.8275051748515;5867.383924687911;6872.244053154149;7149.857002859966;7157.642117894085;6988.61562614056;7063.85872282554;7179.856402871939;7385.298396652336;7423.035005449284;7107;7349.889751653729;7361.447891408166;7368.66840992154;7429.034225550698;7401.740939067106;7454.180040195574;7456.142543607473;7464.477486575942;7471;6915.792526224222;7117.217106118323;7134.143902731706;7170;7170.92829071713;23375.41561460977;25237.49525009508;25770.871145644338;26852.865735671196;26861.194164175107;2553.6935567731807;2576.9949719609367;2609.686837579484;2643.788496920242;2781.2490627530456;14796.630084247872;15228.923855380652;15581.688366232725;15922.442714505052;16912.915435422867;2049.0314619376627;2053.747214199337;2088.885111318877;2094.277474271374;2094.8009939055764;98255.50872245592;99002;103033.48483257611;104276.47861760718;104581;18226.36207732723;18324.81675183258;18506.81493185078;19177.712334314998;19742.210311587376;33781.66218337834;33985;34141.317173656884;34211.65788342134;34264.48603270953;10089;10474.895251047392;10528.420936848546;10741.140708743282;10927.672169834917;8908.198262156437;8923.687670931617;9055.36612437123;9158.40470369424;9214.078592140731;8990.15639834113;9011.63953441868;9061;9077.364584479155;9104.681336153335;3419.794812311269;3513.402721537345;3564.376234159012;3687.391580389259;3748.8500459981296;936.5691781780321;957.683964291782;1052.321252791945;1082.0261764412091;1091.1434523898702;18764.624707506046;19298.4210473686;19460.610787784164;19518.219271229274;19833;1041.2711102228318;1049.8477720730605;1053.920955928293;1084.073117484555;1088.5264909764278;9056.822613060393;11141.777164456666;11145.72135696614;11166.497507612014;11191.832122518168;460212;474869;481502;483191;488133;89885.55057224672;90588.5470572656;90627.54686226527;90724;91462.54268728614;1019.7807471393834;1031.4275577054657;1050.858134151895;1051.4427353502656;1055.6199768083484;17517.21172547264;17586.736198957282;17641.73537396966;17707.38024169148;17743.11284435747;41590.37614435725;42113.57886421097;42539.57460425356;42562.78718606387;43451.130977380904;53596.732016339665;59134.70432647981;59147;59790.40209597848;60248.69875650594;8646.870296945424;8675.522846243517;8684.261837743863;8844.027157012595;9032.503212323385;10168.745781355525;11516.654500365003;13493.055486115878;14017.299135043411;14038.719225615227;11892.940535297268;11942.462589183682;12094.39528023613;12105.69735756613;12126.878731212575;11252.718682033015;11427.60003399877;11714.589989350332;11857.466414011562;11996.940015300217;8354.164583541597;8604.397692161489;8970.41692289999;12235.632931012084;12266.202696824677;12095.75808483843;12368.44342004594;12863.035272354424;13284.53504127351;13449.932750336186;13436.596902092953;13622.863771362556;13940;14044.438222470986;14073.155610663393 20:29:09 INFO - PROCESS | 12601 | |3;mootools.html;1508.841571634978;1547.4661241871554;1689.163863887376;1802.6574950759364;1831.4780287618023;8190.812332211825;8878.24534914533;8900.599473023713;9627.181689556388;9635.56639951203;9215.308851836122;9250.537473126351;9292.395994260369;9312.487813170274;9322.48726320052;2350.3536527454917;2373.1219448803968;2375.180562705864;2384.129792625688;2389.2473870730664;2354.352553047917;2369.7511761265077;2374.631932050535;2400.6399040143942;2403.399150212447;2336.264076815806;2351.012574718614;2352.282553821084;2352.835301528885;2368.6683864259016;2272.943176420586;2322.744498105207;2325.5348930214027;2339.391758142878;2339.6958395408574;2300.2869110575775;2303.4126297794123;2323.268170526279;2327.5461285049423;2345.144022431817;9310.953445232799;9378.343515953886;9399.483028433433;9419.105185007413;9455.621775128986;5420.810271640474;5543.334799824047;5560.916586251209;5581.358143813432;5603.355614104389;3357.84889679965;3441.7590768646205;3469.8265086745814;3472.9131771705656;3474.826258687081;1073.4793625091825;1077.3051381858656;1084.2843723142687;1088.820344643133;1122.2985633978763;12886.54897078607;12942.741145177044;13044.934775326063;13085.738285234242;13147.802782958262;4722.527747225318;4748.169070412733;4801.351817504662;4838.153323168432;4868.95131048692;10263;10309.896901031043;10335.94832025835;10343.793124137475;10396.324238924446;5502.257195278667;5575;5577.8047768327915;5583.748731307101;5588.1059030555725;4456.331550267486;4996.075725990703;5082.618803589746;5139.22911563261;5147.588192944556;3881.3013657541915;3898.571157172709;3939.153082087365;3989.860354887565;3993.0416699992375;1202.8676845546984;1207.3842340406457;1210.4008515784742;1213.5995121609847;1217.1540779158577;917.5962576466334;1054.5992522841425;1058.767071244325;1059.2902755154066;1063.3513556730388;6316;6361.936380636134;6431.807045788634;6542.21493420783;6570.342965703391;966.7003228999033;972.3873959405529;1032.948352582368;1060.528065011078;1084.8915108489246;4080.755154690728;4204.810783514749;4206.242876282298;4339.067100573392;4398.538153493901;11067;11339.206255562032;11410.828837567444;11434.085273178125;11434.371109588887;11173.608923687794;11218.439078046065;11230.943845280884;11237.157213209042;11266.324020558628;8605.397622166389;8683.869741953877;8803.515806630698;8840.469571825712;9018.909810901807;6174.66039367839;6261.7182226799;6267.561270711007;6275.592086514362;6295.842603934938;10584.518167456408;10883.782324353628;11035.503402346752;11042.723931901766;11051.502682379472;10982.725431863948;11186.608468703556;11209.943950280523;11232.438378081226;11241.437928103725;7912.762617121495;7953.177989278998;7997;7998.440109192301;7999.280064794197;8856.911430885608;8967.865482017905;8988.595513202052;9008.144226298491;9025.368224224241;8142.10436851934;8186.713465028695;8249.381296402913;8286.46138001028;8290.709825156091;7881.763547093597;8043.3967452442475;8091.352691784761;8200.589970501333;8286.088530261786;7060.682269297791;7206.135263768172;7207.063081799332;7378.5941773202985;7418.777436676908;5458.263134476795;5486.369067557282;5499.312585926759;5619.157126431068;5671.546276297804;5437.184422336682;5463.235147079492;5526.392096869261;5530.585206109638;5547.084731019498 20:29:09 INFO - PROCESS | 12601 | |4;prototype.html;338.6951743430912;342.5632318793538;347.37472549411063;351.4938488576451;353.51921386913807;5371.838844834651;5385.3268341457315;5559.805406810762;5563.805266815662;5569;5447.210154527591;5452.863678408042;5454.945450545493;5469.398366179717;5487.259220005298;4216.472940882382;4221.593691595792;4229.534751177368;4273.786310684469;4276.524599013351;4144.689148313889;4248;4264.402983582301;4268.317069268917;4286.171127056144;4202.201581699483;4205.873823785276;4219.915601687964;4231.714873968053;4241.257779888507;4213.925449010513;4231.132617813341;4252.255855225354;4266.125444283945;4281.871543853689;3745.138618117848;3799.9240015199543;3811.313963486599;3837.4435706822633;3853.2871418787613;5224.52979231871;5267.341582302212;5279.894402111975;5350.35795704514;5359.330083739533;4873.074115918;4908.239222920453;4912.94371710084;4919.163742163841;4977.228529577921;5624.662520248758;5798.42015798421;5827.737751801179;5848.97075514624;5853.912191317091;4205.507044999012;4211.957880421187;4212.789360531961;4219.789010549491;4237.8304867805255;5924.170616113747;6067.150598916155;6087.239095113111;6104.725287362079;6114.510839132903;3958.5843486434087;4206.600372964564;4321.178975994614;4327.459067616548;4332.35014747784;4301.806418711166;4307.052448461333;4308.418363520947;4311.741295522279;4316;4894.241392584155;4906.779194936236;4955.686743013104;4956.182229932093;4961.082199792978;5635.830925072254;5843.941560584425;5853.180554722342;5861.9706901465215;5878.911816322759;1460.9700161386197;1474.5207807462402;1477.6601381682274;1479.5117611188282;1498.086167437862;930.7905721212672;944.447498213539;950.3157726436955;957.6025949231131;958.755517343073;4982.6512144149565;5010.49895010496;5015.749212539358;5038.949610503922;5075.644704870698;5272.841814745564;5296.285001524745;5329.854081372523;5350.27771250884;5403.352357344873;4941.802327906916;4949.950500495021;5014.498550144956;5239.397469291081;5748.447919061829;3167.3506931079532;3182.554442378069;3186.4423725847882;3191.3457741163006;3213.9072715276916;6149.739303442783;6216.471599913967;6223.661912688794;6308.179936608303;6333.429991300805;6046.546509011841;6086.421789929949;6095.969520152459;6126.540509461808;6140.6929653517145;6105.32841387447;6130.693465326716;6177.938220617736;6188.9690551546955;6211.409916058057;5849.519535876147;5891.38140495259;5894.730528746378;5964.433378829004;5998.910016349845;5906.202662640489;5906.911396329145;5921.940780592139;5943.851403714942;5949.940500595112;5885.293764748258;6155.876882462415;6215.316315205414;6217.906731398942;6246.312905580474;4164.770937598461;4186.639342213732;4203.936940945827;4208.494980602225;4251.787410629394;5934.3175534814045;5986.610870293417;6063;6064.332923378513;6070.939290607037;5478.945210547843;5802.593818432669;5807.82576522705;5835.4748072673665;5883.764649413975;5721.456461636138;5786.855328616818;5819.738111784895;5831.504322132666;5871.236739223874;5676.801311954062;5742.483176514133;5754.194412782297;5802.216700745345;5806.5645076618575;5841.386654401396;5889.676067816311;5892.911606325994;5925.585209035326;5958.19564358806;5744.540436765133;5747.540196784331;5777.804434315101;5802.83943211351;5803.448672376117 20:29:09 INFO - PROCESS | 12601 | |5;yui.html;803.991960080399;816.7508909782514;817.7791996161037;845.2139510255462;889.9555022248886;13687.384067716952;15026.17356045417;15049.774253386207;15082.698346033072;15090.170040647774;14648.633784155401;14718.705625887476;14753.557393278219;14762.704745905075;14795.33420996055;688.9483288753338;814.604916615444;850.4472093139447;854.700854700856;862.0129951205865;856.8372009318209;857.9828403431927;866.4671227195261;867.9609417576193;871.7689812199773;899.4288626722014;902.9277657787394;903.3721563513361;903.3811838890348;903.8960519540271;880.5685214245038;891.3404080980093;894.5661354243186;895.7268033249857;896.8296023755531;649.8440374310179;650.6421468192475;653.1672118049478;654.4764188649109;656.0421784195081;14667.193304368255;14669.853301466956;14856.62858428548;14867.776983345258;14880.62798430048;14290.214038227894;14447.277636118151;14489;14756.557303280919;14846.331915063847;11263.324200547993;11346.602868899632;11461.083113350913;11499.080073594176;11759.58841440554;3727.329080765461;3802.296575133609;3843.1737176507186;3965.940510892339;3969.6030396960364;57281;57534;59297;59536.40463595352;59617.70191149016;10651.73370665724;10737;10828.675139745821;10867.945660271806;10948.288361256493;18145.7278140828;18254;18263.360782372554;18532.536686582942;20320.28878989228;8277.130901255401;8298.958505207434;8455.704050358208;8656.697015604424;8712.738617841474;4789.904201915942;4790.736509491941;4804.495527969582;4844.249141383091;4925.87685307863;3506.2461570762407;3587.4260118381458;3611.620779818134;3612.909677258037;3631.800250986168;625.3996163682824;631.2267472346339;644.262319644005;649.2630863969334;652.9771457998947;734.6583838515116;767.4474378447509;777.3237283563224;806.6571707024608;809.3039985612369;9141.862872056925;9492.193163581034;9539.618415263312;9577.090176433228;9600.423974561549;664.9468042556584;717.7021536062475;765.5215490318551;773.7756050745334;780.5667854340895;4591.95408045922;4606.539346065434;4688.976555117202;4791.808327666924;4835;65087.34912650813;66530.66734666296;66847;66917.66541167263;67025.66487167533;60989;62003.379966200664;62176.067358989654;62801.371986280465;63037.68481157565;42610.78694606445;57322;57383.713081434325;57914;58817.70591147017;8853;8996;9221.538923053686;9224.169824715807;9254.722358329262;33650.83174584111;34133;35826.10434739153;37322.06694832651;37425.6257437433;50090.499095008585;50169.49830501794;50699;50848.74575627098;51560.22659660033;11370.260933039326;11517.942410287895;11643.650690479299;12011.81982270284;13325.200487970753;12158.878411215775;12951.870481295444;13039.348032598142;13122.212667239995;13520.25638589887;12583.748325033264;12604.49582016709;12611.180273282207;12634.2419454833;12823.166494177849;11578.247413918069;11638.788684731438;11721.179517433698;11901;11934.22427542207;12063.577774777841;12069.336186509476;12129.272243665408;12209.450574724337;12527.812082818948;9552.474613896302;9707.029297070236;9950.950245248727;9955.904850466299;10018.749531261485;9892.653757118467;10230.590776368861;10299.897001029894;10754.40850753216;11659.76680466369 20:29:09 INFO - PROCESS | 12601 | __end_tp_report 20:29:09 INFO - PROCESS | 12601 | __start_cc_report 20:29:09 INFO - PROCESS | 12601 | _x_x_mozilla_cycle_collect,337 20:29:09 INFO - PROCESS | 12601 | __end_cc_report 20:29:09 INFO - PROCESS | 12601 | __startTimestamp1463282949484__endTimestamp 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | ------- Summary: start ------- 20:29:09 INFO - PROCESS | 12601 | Number of tests: 6 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#0] dojo.html Cycles:165 Average:5491.87 Median:5800.62 stddev:748.21 (12.9%) stddev-sans-first:728.77 20:29:09 INFO - PROCESS | 12601 | Values: 3209.6 3220.7 3264.2 3270.5 3273.3 5379.9 5495.7 5525.6 5564.2 5579.1 5309.4 5384.5 5436.8 5475.6 5520.6 4892.9 4920.7 5038.6 5071.6 5123.3 760.1 4889.1 4916.4 5044.2 5064.8 4960.1 4961.3 4993.8 5004.1 5014.8 5003.6 5004.3 5014.6 5016.8 5040.9 4932.2 4976.4 4984.4 4993.0 4994.5 5460.0 5469.5 5479.5 5525.6 5552.3 5800.6 5983.0 6038.1 6057.0 6069.0 6079.8 6105.7 6127.9 6130.0 6138.9 5698.3 5699.0 5699.4 5700.0 5732.6 5964.6 6085.4 6114.9 6227.8 6234.0 5819.1 5820.6 5820.9 5823.2 5845.1 5987.2 5995.1 6004.9 6011.4 6012.7 5840.1 5859.6 5886.6 5907.9 5996.5 5863.1 5876.2 5906.6 5935.3 5959.7 4451.4 4487.6 4490.0 4498.2 4563.2 3924.5 3969.4 3974.5 4016.4 4018.7 5469.0 5513.9 5544.1 5588.7 5619.6 5830.4 5856.2 5864.1 5885.9 5893.5 5532.8 5553.4 5589.0 5596.4 5599.7 4997.5 5036.9 5041.5 5063.6 5079.1 6052.6 6060.4 6064.8 6092.1 6128.1 5928.6 5960.7 6032.0 6033.8 6040.2 6162.0 6172.8 6179.4 6184.9 6196.3 5784.2 5865.1 5871.3 5895.4 5905.8 6006.4 6032.8 6035.4 6047.3 6087.0 5855.8 5869.9 5887.3 5895.7 5901.3 5654.5 5835.0 5875.8 5886.6 5906.2 5784.8 5813.9 5834.8 5843.9 5848.1 5910.1 5936.1 5990.3 6001.3 6020.6 5616.3 5632.3 5672.0 5696.1 5750.1 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#1] ext.html Cycles:180 Average:63232.71 Median:22109.58 stddev:145998.03 (660.3%) stddev-sans-first:146331.85 20:29:09 INFO - PROCESS | 12601 | Values: 594.8 643.9 653.7 665.0 685.7 40214.4 41492.2 45034.5 45139.1 45400.0 46102.8 46140.3 46415.8 46663.1 46732.8 9005.4 9109.5 9120.1 9124.4 9138.8 8865.4 9010.0 9024.2 9025.1 9040.6 8952.9 9029.4 9059.4 9061.1 9076.4 8902.0 8942.2 8948.6 8997.8 9029.3 8940.2 8975.0 9037.0 9042.2 9074.6 34084.7 42714.4 42853.8 42942.6 43260.1 3556.9 3607.9 3764.8 4091.5 4277.8 31644.5 31786.7 32280.7 32302.5 33359.7 3998.4 4004.8 4030.4 4052.6 4068.9 307170.0 310054.0 311767.0 312289.0 312526.0 34580.0 34829.7 34864.8 34931.8 35097.1 36606.0 37862.8 38271.4 38354.8 38420.4 15920.2 16087.6 16089.8 16135.1 16154.6 12736.5 12743.6 12861.0 12876.7 12882.7 8693.6 8711.4 8718.0 8761.1 8795.8 3304.9 3329.9 3348.0 3350.2 3378.8 1085.4 1094.2 1144.0 1176.8 1201.0 32730.3 33258.3 33830.3 34067.0 34429.8 1122.5 1135.8 1136.8 1160.5 1161.4 16416.7 16426.0 16511.7 16557.0 16756.7 500411.0 838901.0 857583.0 862222.0 862548.0 60449.0 60566.1 61020.7 61132.0 61364.7 1381.3 1382.7 1395.1 1415.5 1419.4 32451.0 32975.0 33162.2 33345.3 34154.7 51592.7 51880.2 52015.7 52325.0 52470.0 377025.0 378338.0 381998.0 383057.0 383530.0 29148.1 29196.9 29454.0 29520.7 29546.6 47998.0 48009.0 48544.3 49182.8 49259.8 41275.6 41306.4 41464.0 41466.4 42728.0 40298.6 41103.6 41793.0 42049.6 42231.6 41952.2 42335.0 42571.4 42923.1 42938.8 35352.6 37374.6 37394.0 37652.2 38105.8 28727.7 28804.9 28902.4 29005.9 29058.7 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#2] jquery.html Cycles:180 Average:30781.27 Median:14173.93 stddev:78985.01 (557.3%) stddev-sans-first:79173.62 20:29:09 INFO - PROCESS | 12601 | Values: 391.6 401.9 407.1 412.9 413.1 14128.9 18208.8 18789.2 19912.8 20046.2 18751.5 18826.0 19142.5 19406.8 19453.8 5749.8 5867.4 6872.2 7149.9 7157.6 6988.6 7063.9 7179.9 7385.3 7423.0 7107.0 7349.9 7361.4 7368.7 7429.0 7401.7 7454.2 7456.1 7464.5 7471.0 6915.8 7117.2 7134.1 7170.0 7170.9 23375.4 25237.5 25770.9 26852.9 26861.2 2553.7 2577.0 2609.7 2643.8 2781.2 14796.6 15228.9 15581.7 15922.4 16912.9 2049.0 2053.7 2088.9 2094.3 2094.8 98255.5 99002.0 103033.5 104276.5 104581.0 18226.4 18324.8 18506.8 19177.7 19742.2 33781.7 33985.0 34141.3 34211.7 34264.5 10089.0 10474.9 10528.4 10741.1 10927.7 8908.2 8923.7 9055.4 9158.4 9214.1 8990.2 9011.6 9061.0 9077.4 9104.7 3419.8 3513.4 3564.4 3687.4 3748.9 936.6 957.7 1052.3 1082.0 1091.1 18764.6 19298.4 19460.6 19518.2 19833.0 1041.3 1049.8 1053.9 1084.1 1088.5 9056.8 11141.8 11145.7 11166.5 11191.8 460212.0 474869.0 481502.0 483191.0 488133.0 89885.6 90588.5 90627.5 90724.0 91462.5 1019.8 1031.4 1050.9 1051.4 1055.6 17517.2 17586.7 17641.7 17707.4 17743.1 41590.4 42113.6 42539.6 42562.8 43451.1 53596.7 59134.7 59147.0 59790.4 60248.7 8646.9 8675.5 8684.3 8844.0 9032.5 10168.7 11516.7 13493.1 14017.3 14038.7 11892.9 11942.5 12094.4 12105.7 12126.9 11252.7 11427.6 11714.6 11857.5 11996.9 8354.2 8604.4 8970.4 12235.6 12266.2 12095.8 12368.4 12863.0 13284.5 13449.9 13436.6 13622.9 13940.0 14044.4 14073.2 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#3] mootools.html Cycles:180 Average:6085.03 Median:4368.80 stddev:3495.52 (80.0%) stddev-sans-first:3488.40 20:29:09 INFO - PROCESS | 12601 | Values: 1508.8 1547.5 1689.2 1802.7 1831.5 8190.8 8878.2 8900.6 9627.2 9635.6 9215.3 9250.5 9292.4 9312.5 9322.5 2350.4 2373.1 2375.2 2384.1 2389.2 2354.4 2369.8 2374.6 2400.6 2403.4 2336.3 2351.0 2352.3 2352.8 2368.7 2272.9 2322.7 2325.5 2339.4 2339.7 2300.3 2303.4 2323.3 2327.5 2345.1 9311.0 9378.3 9399.5 9419.1 9455.6 5420.8 5543.3 5560.9 5581.4 5603.4 3357.8 3441.8 3469.8 3472.9 3474.8 1073.5 1077.3 1084.3 1088.8 1122.3 12886.5 12942.7 13044.9 13085.7 13147.8 4722.5 4748.2 4801.4 4838.2 4869.0 10263.0 10309.9 10335.9 10343.8 10396.3 5502.3 5575.0 5577.8 5583.7 5588.1 4456.3 4996.1 5082.6 5139.2 5147.6 3881.3 3898.6 3939.2 3989.9 3993.0 1202.9 1207.4 1210.4 1213.6 1217.2 917.6 1054.6 1058.8 1059.3 1063.4 6316.0 6361.9 6431.8 6542.2 6570.3 966.7 972.4 1032.9 1060.5 1084.9 4080.8 4204.8 4206.2 4339.1 4398.5 11067.0 11339.2 11410.8 11434.1 11434.4 11173.6 11218.4 11230.9 11237.2 11266.3 8605.4 8683.9 8803.5 8840.5 9018.9 6174.7 6261.7 6267.6 6275.6 6295.8 10584.5 10883.8 11035.5 11042.7 11051.5 10982.7 11186.6 11209.9 11232.4 11241.4 7912.8 7953.2 7997.0 7998.4 7999.3 8856.9 8967.9 8988.6 9008.1 9025.4 8142.1 8186.7 8249.4 8286.5 8290.7 7881.8 8043.4 8091.4 8200.6 8286.1 7060.7 7206.1 7207.1 7378.6 7418.8 5458.3 5486.4 5499.3 5619.2 5671.5 5437.2 5463.2 5526.4 5530.6 5547.1 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#4] prototype.html Cycles:180 Average:4847.47 Median:5425.28 stddev:1434.63 (26.4%) stddev-sans-first:1398.17 20:29:09 INFO - PROCESS | 12601 | Values: 338.7 342.6 347.4 351.5 353.5 5371.8 5385.3 5559.8 5563.8 5569.0 5447.2 5452.9 5454.9 5469.4 5487.3 4216.5 4221.6 4229.5 4273.8 4276.5 4144.7 4248.0 4264.4 4268.3 4286.2 4202.2 4205.9 4219.9 4231.7 4241.3 4213.9 4231.1 4252.3 4266.1 4281.9 3745.1 3799.9 3811.3 3837.4 3853.3 5224.5 5267.3 5279.9 5350.4 5359.3 4873.1 4908.2 4912.9 4919.2 4977.2 5624.7 5798.4 5827.7 5849.0 5853.9 4205.5 4212.0 4212.8 4219.8 4237.8 5924.2 6067.2 6087.2 6104.7 6114.5 3958.6 4206.6 4321.2 4327.5 4332.4 4301.8 4307.1 4308.4 4311.7 4316.0 4894.2 4906.8 4955.7 4956.2 4961.1 5635.8 5843.9 5853.2 5862.0 5878.9 1461.0 1474.5 1477.7 1479.5 1498.1 930.8 944.4 950.3 957.6 958.8 4982.7 5010.5 5015.7 5038.9 5075.6 5272.8 5296.3 5329.9 5350.3 5403.4 4941.8 4950.0 5014.5 5239.4 5748.4 3167.4 3182.6 3186.4 3191.3 3213.9 6149.7 6216.5 6223.7 6308.2 6333.4 6046.5 6086.4 6096.0 6126.5 6140.7 6105.3 6130.7 6177.9 6189.0 6211.4 5849.5 5891.4 5894.7 5964.4 5998.9 5906.2 5906.9 5921.9 5943.9 5949.9 5885.3 6155.9 6215.3 6217.9 6246.3 4164.8 4186.6 4203.9 4208.5 4251.8 5934.3 5986.6 6063.0 6064.3 6070.9 5478.9 5802.6 5807.8 5835.5 5883.8 5721.5 5786.9 5819.7 5831.5 5871.2 5676.8 5742.5 5754.2 5802.2 5806.6 5841.4 5889.7 5892.9 5925.6 5958.2 5744.5 5747.5 5777.8 5802.8 5803.4 20:29:09 INFO - PROCESS | 12601 | 20:29:09 INFO - PROCESS | 12601 | [#5] yui.html Cycles:180 Average:15595.93 Median:27508.19 stddev:18772.94 (68.2%) stddev-sans-first:18792.74 20:29:09 INFO - PROCESS | 12601 | Values: 804.0 816.8 817.8 845.2 890.0 13687.4 15026.2 15049.8 15082.7 15090.2 14648.6 14718.7 14753.6 14762.7 14795.3 688.9 814.6 850.4 854.7 862.0 856.8 858.0 866.5 868.0 871.8 899.4 902.9 903.4 903.4 903.9 880.6 891.3 894.6 895.7 896.8 649.8 650.6 653.2 654.5 656.0 14667.2 14669.9 14856.6 14867.8 14880.6 14290.2 14447.3 14489.0 14756.6 14846.3 11263.3 11346.6 11461.1 11499.1 11759.6 3727.3 3802.3 3843.2 3965.9 3969.6 57281.0 57534.0 59297.0 59536.4 59617.7 10651.7 10737.0 10828.7 10867.9 10948.3 18145.7 18254.0 18263.4 18532.5 20320.3 8277.1 8299.0 8455.7 8656.7 8712.7 4789.9 4790.7 4804.5 4844.2 4925.9 3506.2 3587.4 3611.6 3612.9 3631.8 625.4 631.2 644.3 649.3 653.0 734.7 767.4 777.3 806.7 809.3 9141.9 9492.2 9539.6 9577.1 9600.4 664.9 717.7 765.5 773.8 780.6 4592.0 4606.5 4689.0 4791.8 4835.0 65087.3 66530.7 66847.0 66917.7 67025.7 60989.0 62003.4 62176.1 62801.4 63037.7 42610.8 57322.0 57383.7 57914.0 58817.7 8853.0 8996.0 9221.5 9224.2 9254.7 33650.8 34133.0 35826.1 37322.1 37425.6 50090.5 50169.5 50699.0 50848.7 51560.2 11370.3 11517.9 11643.7 12011.8 13325.2 12158.9 12951.9 13039.3 13122.2 13520.3 12583.7 12604.5 12611.2 12634.2 12823.2 11578.2 11638.8 11721.2 11901.0 11934.2 12063.6 12069.3 12129.3 12209.5 12527.8 9552.5 9707.0 9951.0 9955.9 10018.7 9892.7 10230.6 10299.9 10754.4 11659.8 20:29:09 INFO - PROCESS | 12601 | -------- Summary: end -------- 20:29:09 INFO - PROCESS | 12601 | 20:29:10 INFO - TEST-INFO | 12601: exit 0 20:29:10 INFO - TEST-OK | dromaeo_css | took 1110148ms 20:29:10 INFO - TEST-START | kraken 20:29:10 INFO - operating with platform_type : linux_ 20:29:10 INFO - Initialising browser for kraken test... 20:29:10 INFO - TEST-INFO | started process 12836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoJsK9/profile http://localhost:55143/getInfo.html) 20:29:13 INFO - PROCESS | 12836 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 20:29:13 INFO - PROCESS | 12836 | 20:29:13 INFO - PROCESS | 12836 | (process:12907): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:29:14 INFO - PROCESS | 12836 | __metrics Screen width/height:1600/1200 20:29:14 INFO - PROCESS | 12836 | colorDepth:24 20:29:14 INFO - PROCESS | 12836 | Browser inner width/height: 1024/697 20:29:14 INFO - PROCESS | 12836 | __metrics 20:29:15 ERROR - PROCESS | 12836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:29:15 INFO - TEST-INFO | 12836: exit 0 20:29:15 INFO - Browser initialized. 20:29:15 INFO - Running cycle 1/1 for kraken test... 20:29:16 INFO - TEST-INFO | started process 12958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoJsK9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:17 INFO - PROCESS | 12958 | 20:29:17 INFO - PROCESS | 12958 | (process:13019): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:29:27 INFO - PROCESS | 12958 | RSS: Main: 163315712 20:29:27 INFO - PROCESS | 12958 | 20:29:30 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55143/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:31 INFO - PROCESS | 12958 | RSS: Main: 168247296 20:29:31 INFO - PROCESS | 12958 | 20:29:34 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55143/tests/kraken/driver.html?testName=audio-dft) 20:29:34 INFO - PROCESS | 12958 | RSS: Main: 168296448 20:29:34 INFO - PROCESS | 12958 | 20:29:37 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55143/tests/kraken/driver.html?testName=audio-fft) 20:29:38 INFO - PROCESS | 12958 | RSS: Main: 162668544 20:29:38 INFO - PROCESS | 12958 | 20:29:40 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55143/tests/kraken/driver.html?testName=audio-oscillator) 20:29:41 INFO - PROCESS | 12958 | RSS: Main: 163090432 20:29:41 INFO - PROCESS | 12958 | 20:29:43 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:43 INFO - PROCESS | 12958 | RSS: Main: 163311616 20:29:43 INFO - PROCESS | 12958 | 20:29:47 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55143/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:47 INFO - PROCESS | 12958 | RSS: Main: 163704832 20:29:47 INFO - PROCESS | 12958 | 20:29:51 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55143/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:51 INFO - PROCESS | 12958 | RSS: Main: 163184640 20:29:51 INFO - PROCESS | 12958 | 20:29:54 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55143/tests/kraken/driver.html?testName=json-parse-financial) 20:29:55 INFO - PROCESS | 12958 | RSS: Main: 163098624 20:29:55 INFO - PROCESS | 12958 | 20:29:57 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:57 INFO - PROCESS | 12958 | RSS: Main: 163594240 20:29:57 INFO - PROCESS | 12958 | 20:29:59 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:00 INFO - PROCESS | 12958 | RSS: Main: 164179968 20:30:00 INFO - PROCESS | 12958 | 20:30:02 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:30:03 INFO - PROCESS | 12958 | RSS: Main: 164143104 20:30:03 INFO - PROCESS | 12958 | 20:30:05 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:06 INFO - PROCESS | 12958 | RSS: Main: 164581376 20:30:06 INFO - PROCESS | 12958 | 20:30:09 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:09 INFO - PROCESS | 12958 | RSS: Main: 164724736 20:30:09 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | Cycle 1(1): loaded http://localhost:55143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55143/tests/kraken/driver.html?testName=ai-astar) 20:30:11 INFO - PROCESS | 12958 | RSS: Main: 165621760 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | __start_tp_report 20:30:11 INFO - PROCESS | 12958 | _x_x_mozilla_page_load 20:30:11 INFO - PROCESS | 12958 | _x_x_mozilla_page_load_details 20:30:11 INFO - PROCESS | 12958 | |i|pagename|runs| 20:30:11 INFO - PROCESS | 12958 | |0;ai-astar;107;111;104;111;110;110;104;110;111;112 20:30:11 INFO - PROCESS | 12958 | |1;audio-beat-detection;156;124;150;202;125;154;153;124;182;124 20:30:11 INFO - PROCESS | 12958 | |2;audio-dft;160;162;163;160;166;173;164;164;161;162 20:30:11 INFO - PROCESS | 12958 | |3;audio-fft;76;75;75;169;75;74;74;77;187;75 20:30:11 INFO - PROCESS | 12958 | |4;audio-oscillator;92;92;173;92;92;93;151;92;93;146 20:30:11 INFO - PROCESS | 12958 | |5;imaging-gaussian-blur;117;117;117;118;117;120;118;117;118;119 20:30:11 INFO - PROCESS | 12958 | |6;imaging-darkroom;148;147;148;146;147;148;147;147;147;147 20:30:11 INFO - PROCESS | 12958 | |7;imaging-desaturate;96;96;96;94;95;95;96;95;96;95 20:30:11 INFO - PROCESS | 12958 | |8;json-parse-financial;54;58;55;55;57;55;55;59;55;57 20:30:11 INFO - PROCESS | 12958 | |9;json-stringify-tinderbox;60;60;60;60;62;59;60;60;60;61 20:30:11 INFO - PROCESS | 12958 | |10;stanford-crypto-aes;77;79;78;78;79;80;86;79;140;79 20:30:11 INFO - PROCESS | 12958 | |11;stanford-crypto-ccm;146;121;128;125;128;119;136;118;153;124 20:30:11 INFO - PROCESS | 12958 | |12;stanford-crypto-pbkdf2;159;161;164;161;160;158;159;159;169;157 20:30:11 INFO - PROCESS | 12958 | |13;stanford-crypto-sha256-iterative;62;66;63;65;63;62;64;63;65;63 20:30:11 INFO - PROCESS | 12958 | __end_tp_report 20:30:11 INFO - PROCESS | 12958 | __start_cc_report 20:30:11 INFO - PROCESS | 12958 | _x_x_mozilla_cycle_collect,855 20:30:11 INFO - PROCESS | 12958 | __end_cc_report 20:30:11 INFO - PROCESS | 12958 | __startTimestamp1463283011637__endTimestamp 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | ------- Summary: start ------- 20:30:11 INFO - PROCESS | 12958 | Number of tests: 14 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:2.94 (2.7%) stddev-sans-first:3.03 20:30:11 INFO - PROCESS | 12958 | Values: 107.0 111.0 104.0 111.0 110.0 110.0 104.0 110.0 111.0 112.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:153.50 stddev:26.75 (17.4%) stddev-sans-first:28.26 20:30:11 INFO - PROCESS | 12958 | Values: 156.0 124.0 150.0 202.0 125.0 154.0 153.0 124.0 182.0 124.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:3.84 (2.3%) stddev-sans-first:3.86 20:30:11 INFO - PROCESS | 12958 | Values: 160.0 162.0 163.0 160.0 166.0 173.0 164.0 164.0 161.0 162.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.00 stddev:43.59 (58.1%) stddev-sans-first:45.65 20:30:11 INFO - PROCESS | 12958 | Values: 76.0 75.0 75.0 169.0 75.0 74.0 74.0 77.0 187.0 75.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:92.00 stddev:31.83 (34.6%) stddev-sans-first:32.96 20:30:11 INFO - PROCESS | 12958 | Values: 92.0 92.0 173.0 92.0 92.0 93.0 151.0 92.0 93.0 146.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 20:30:11 INFO - PROCESS | 12958 | Values: 117.0 117.0 117.0 118.0 117.0 120.0 118.0 117.0 118.0 119.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 20:30:11 INFO - PROCESS | 12958 | Values: 148.0 147.0 148.0 146.0 147.0 148.0 147.0 147.0 147.0 147.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:30:11 INFO - PROCESS | 12958 | Values: 96.0 96.0 96.0 94.0 95.0 95.0 96.0 95.0 96.0 95.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.63 (2.9%) stddev-sans-first:1.56 20:30:11 INFO - PROCESS | 12958 | Values: 54.0 58.0 55.0 55.0 57.0 55.0 55.0 59.0 55.0 57.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 20:30:11 INFO - PROCESS | 12958 | Values: 60.0 60.0 60.0 60.0 62.0 59.0 60.0 60.0 60.0 61.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:79.00 stddev:19.31 (24.4%) stddev-sans-first:20.23 20:30:11 INFO - PROCESS | 12958 | Values: 77.0 79.0 78.0 78.0 79.0 80.0 86.0 79.0 140.0 79.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:128.00 stddev:11.72 (9.2%) stddev-sans-first:10.86 20:30:11 INFO - PROCESS | 12958 | Values: 146.0 121.0 128.0 125.0 128.0 119.0 136.0 118.0 153.0 124.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.50 stddev:3.50 (2.2%) stddev-sans-first:3.66 20:30:11 INFO - PROCESS | 12958 | Values: 159.0 161.0 164.0 161.0 160.0 158.0 159.0 159.0 169.0 157.0 20:30:11 INFO - PROCESS | 12958 | 20:30:11 INFO - PROCESS | 12958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 20:30:11 INFO - PROCESS | 12958 | Values: 62.0 66.0 63.0 65.0 63.0 62.0 64.0 63.0 65.0 63.0 20:30:11 INFO - PROCESS | 12958 | -------- Summary: end -------- 20:30:11 INFO - PROCESS | 12958 | 20:30:12 INFO - TEST-INFO | 12958: exit 0 20:30:12 INFO - TEST-OK | kraken | took 62292ms 20:30:12 INFO - SUITE-END | took 1172s 20:30:12 INFO - Completed test suite (00:19:32) 20:30:12 INFO - javascript benchmark 20:30:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.9199892639435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3209.6148462184533, 3220.694034066763, 3264.2165880188754, 3270.493073573595, 3273.3453309338124, 5379.89240215195, 5495.725213739312, 5525.613207075507, 5564.248826408434, 5579.13523403872, 5309.41596424394, 5384.542313903323, 5436.809711660093, 5475.616706830523, 5520.641158324706, 4892.902141957159, 4920.70475771453, 5038.59691224703, 5071.568916642072, 5123.333966584358, 760.0577843994029, 4889.071076495472, 4916.385451818523, 5044.243363495469, 5064.822731204408, 4960.107180707471, 4961.330220420233, 4993.775280112385, 5004.074246264417, 5014.8244811431605, 5003.574696150795, 5004.274380214885, 5014.5737612303, 5016.824411145592, 5040.949590504121, 4932.235503496928, 4976.35307410038, 4984.40187177541, 4993.0, 4994.475580064077, 5460.0, 5469.480399362054, 5479.4520547944885, 5525.640833345819, 5552.333719953591, 5800.622959507618, 5983.0, 6038.0942858571125, 6057.0, 6069.02895536712, 6079.756809727605, 6105.672036200918, 6127.861529871586, 6130.034976025718, 6138.8562720164155, 5698.34469036062, 5699.031164702011, 5699.430056994267, 5700.030994730864, 5732.570057245724, 5964.552658550626, 6085.36103709113, 6114.877702445926, 6227.844303892349, 6234.0, 5819.098039803837, 5820.563457740686, 5820.941790582125, 5823.155642431823, 5845.09401042839, 5987.161797348374, 5995.070764031495, 6004.879902401927, 6011.398860114041, 6012.669303188367, 5840.065589505659, 5859.619124756962, 5886.58793884424, 5907.852303692442, 5996.460318571262, 5863.120531920161, 5876.206712093898, 5906.645601263938, 5935.258092738408, 5959.702014899324, 4451.376807246988, 4487.551244875552, 4490.034642551867, 4498.235299999008, 4563.155816174019, 3924.4701965234326, 3969.4442778011103, 3974.503187101612, 4016.397540368968, 4018.678505719535, 5468.972655136698, 5513.889722205534, 5544.112941929272, 5588.6646801192055, 5619.606627536034, 5830.416958304136, 5856.180134781134, 5864.120381942657, 5885.882282354414, 5893.469587737124, 5532.75102620383, 5553.444655534495, 5589.0219211637805, 5596.440355964371, 5599.664020158803, 4997.450280469146, 5036.924446133311, 5041.470645582234, 5063.645544811828, 5079.111155547765, 6052.606580572248, 6060.393960603904, 6064.787732429344, 6092.055731361646, 6128.111423843607, 5928.6146400484695, 5960.701964901651, 6032.0, 6033.78881739137, 6040.244969378828, 6161.969190154021, 6172.845678858064, 6179.412955769195, 6184.907226391698, 6196.318404975359, 5784.161296612052, 5865.149553314831, 5871.266091738533, 5895.4399332063385, 5905.793297234576, 6006.429389208019, 6032.788852390146, 6035.426634469718, 6047.304559975659, 6087.0, 5855.795047173328, 5869.941300586939, 5887.264091988502, 5895.67573783446, 5901.3213480450295, 5654.547636189177, 5835.008048631658, 5875.764969401176, 5886.587938844411, 5906.173135761082, 5784.768609255582, 5813.94186058134, 5834.824955251349, 5843.918875008138, 5848.093545500455, 5910.113482977587, 5936.13925980739, 5990.341062483036, 6001.279846418458, 6020.638761674313, 5616.269884914935, 5632.295963004624, 5672.0, 5696.060150075191, 5750.13747937796], "value": 5441.576760215734, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.82155353394, 643.9278601129121, 653.7123665587142, 664.9767258145964, 685.7188552693397, 40214.39678404823, 41492.17015659689, 45034.54965450345, 45139.097218055664, 45400.0, 46102.76948615252, 46140.30789538151, 46415.767921160346, 46663.066738665206, 46732.76633616836, 9005.36962412633, 9109.498977556232, 9120.08799120086, 9124.406913550598, 9138.77153071172, 8865.379423440361, 9010.0, 9024.23294020009, 9025.097490250955, 9040.638374465014, 8952.910470895273, 9029.367944243906, 9059.365844390895, 9061.093890610951, 9076.410033347844, 8902.0, 8942.239909607692, 8948.597313120892, 8997.820043599091, 9029.322800789967, 8940.195382415548, 8975.0, 9037.0, 9042.23141033013, 9074.63880417936, 34084.6591534084, 42714.35928461076, 42853.78573107145, 42942.57057429417, 43260.13479730388, 3556.893293201208, 3607.9458808117897, 3764.811759412046, 4091.468109145822, 4277.8288868445225, 31644.525332120036, 31786.682133178605, 32280.677193228235, 32302.515462268086, 33359.6664033359, 3998.4402183694306, 4004.759714417144, 4030.3954406838916, 4052.6352628263303, 4068.877933661995, 307170.0, 310053.99999999773, 311767.0, 312289.0, 312526.0, 34580.0, 34829.65170348264, 34864.825675871456, 34931.82534087313, 35097.1225719354, 36606.0, 37862.810685946395, 38271.42592861054, 38354.80822595925, 38420.42369364462, 15920.203989800464, 16087.597810054842, 16089.839101609068, 16135.112568808829, 16154.596135096717, 12736.490540378467, 12743.553975610808, 12861.0, 12876.742465150644, 12882.742345153045, 8693.565321733888, 8711.390202685878, 8717.953845538575, 8761.123887611187, 8795.780105497413, 3304.9008529744146, 3329.883454079096, 3347.983260083684, 3350.2294472271515, 3378.831058447117, 1085.4247248958065, 1094.190299178618, 1143.9885601143883, 1176.8293597428326, 1200.9699757506132, 32730.345393092004, 33258.3348333032, 33830.32339353248, 34066.98374161695, 34429.82785086109, 1122.5229277557005, 1135.795556799784, 1136.772645470909, 1160.5473865192582, 1161.372858656333, 16416.67166656684, 16426.01443913369, 16511.669766604602, 16557.0, 16756.748648770277, 500411.0, 838901.0, 857583.0, 862222.0, 862548.0, 60449.0, 60566.0915086274, 61020.69489652523, 61132.0, 61364.693176534725, 1381.281733498575, 1382.7372799168127, 1395.1210737235476, 1415.5045733993227, 1419.4393214680144, 32451.0, 32975.0, 33162.17094572655, 33345.33309333751, 34154.658453416145, 51592.74203628958, 51880.221796672326, 52015.73992130015, 52325.0, 52470.0, 377025.0, 378338.0, 381998.0, 383057.0, 383530.0, 29148.125556233346, 29196.854015729787, 29454.0, 29520.704792951794, 29546.556801647563, 47998.0, 48009.0, 48544.271835923195, 49182.75408622934, 49259.75370123127, 41275.58724412717, 41306.380404293355, 41464.0, 41466.37800432936, 42728.0, 40298.59701402948, 41103.56137535172, 41792.96711196242, 42049.579504204565, 42231.577684223994, 41952.160956780084, 42335.0, 42571.3614295792, 42923.141537168456, 42938.78530607327, 35352.64647353494, 37374.6262537382, 37394.0, 37652.246955061295, 38105.80947095247, 28727.71272287334, 28804.855975719987, 28902.42195156127, 29005.854970725013, 29058.7094129056], "value": 19151.77587055475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.635778725785, 401.94774679291686, 407.1206194619621, 412.86581860895217, 413.1076873952264, 14128.858711412882, 18208.817911820894, 18789.248430062817, 19912.800871991276, 20046.198152073917, 18751.531211719714, 18826.0, 19142.52143696408, 19406.805931940675, 19453.805461945376, 5749.8275051748515, 5867.383924687911, 6872.244053154149, 7149.857002859966, 7157.642117894085, 6988.61562614056, 7063.85872282554, 7179.856402871939, 7385.298396652336, 7423.035005449284, 7107.0, 7349.889751653729, 7361.447891408166, 7368.66840992154, 7429.034225550698, 7401.740939067106, 7454.180040195574, 7456.142543607473, 7464.477486575942, 7471.0, 6915.792526224222, 7117.217106118323, 7134.143902731706, 7170.0, 7170.92829071713, 23375.41561460977, 25237.49525009508, 25770.871145644338, 26852.865735671196, 26861.194164175107, 2553.6935567731807, 2576.9949719609367, 2609.686837579484, 2643.788496920242, 2781.2490627530456, 14796.630084247872, 15228.923855380652, 15581.688366232725, 15922.442714505052, 16912.915435422867, 2049.0314619376627, 2053.747214199337, 2088.885111318877, 2094.277474271374, 2094.8009939055764, 98255.50872245592, 99002.0, 103033.48483257611, 104276.47861760718, 104581.0, 18226.36207732723, 18324.81675183258, 18506.81493185078, 19177.712334314998, 19742.210311587376, 33781.66218337834, 33985.0, 34141.317173656884, 34211.65788342134, 34264.48603270953, 10089.0, 10474.895251047392, 10528.420936848546, 10741.140708743282, 10927.672169834917, 8908.198262156437, 8923.687670931617, 9055.36612437123, 9158.40470369424, 9214.078592140731, 8990.15639834113, 9011.63953441868, 9061.0, 9077.364584479155, 9104.681336153335, 3419.794812311269, 3513.402721537345, 3564.376234159012, 3687.391580389259, 3748.8500459981296, 936.5691781780321, 957.683964291782, 1052.321252791945, 1082.0261764412091, 1091.1434523898702, 18764.624707506046, 19298.4210473686, 19460.610787784164, 19518.219271229274, 19833.0, 1041.2711102228318, 1049.8477720730605, 1053.920955928293, 1084.073117484555, 1088.5264909764278, 9056.822613060393, 11141.777164456666, 11145.72135696614, 11166.497507612014, 11191.832122518168, 460212.0, 474869.0, 481502.0, 483191.0, 488133.0, 89885.55057224672, 90588.5470572656, 90627.54686226527, 90724.0, 91462.54268728614, 1019.7807471393834, 1031.4275577054657, 1050.858134151895, 1051.4427353502656, 1055.6199768083484, 17517.21172547264, 17586.736198957282, 17641.73537396966, 17707.38024169148, 17743.11284435747, 41590.37614435725, 42113.57886421097, 42539.57460425356, 42562.78718606387, 43451.130977380904, 53596.732016339665, 59134.70432647981, 59147.0, 59790.40209597848, 60248.69875650594, 8646.870296945424, 8675.522846243517, 8684.261837743863, 8844.027157012595, 9032.503212323385, 10168.745781355525, 11516.654500365003, 13493.055486115878, 14017.299135043411, 14038.719225615227, 11892.940535297268, 11942.462589183682, 12094.39528023613, 12105.69735756613, 12126.878731212575, 11252.718682033015, 11427.60003399877, 11714.589989350332, 11857.466414011562, 11996.940015300217, 8354.164583541597, 8604.397692161489, 8970.41692289999, 12235.632931012084, 12266.202696824677, 12095.75808483843, 12368.44342004594, 12863.035272354424, 13284.53504127351, 13449.932750336186, 13436.596902092953, 13622.863771362556, 13940.0, 14044.438222470986, 14073.155610663393], "value": 10767.88570672702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.841571634978, 1547.4661241871554, 1689.163863887376, 1802.6574950759364, 1831.4780287618023, 8190.812332211825, 8878.24534914533, 8900.599473023713, 9627.181689556388, 9635.56639951203, 9215.308851836122, 9250.537473126351, 9292.395994260369, 9312.487813170274, 9322.48726320052, 2350.3536527454917, 2373.1219448803968, 2375.180562705864, 2384.129792625688, 2389.2473870730664, 2354.352553047917, 2369.7511761265077, 2374.631932050535, 2400.6399040143942, 2403.399150212447, 2336.264076815806, 2351.012574718614, 2352.282553821084, 2352.835301528885, 2368.6683864259016, 2272.943176420586, 2322.744498105207, 2325.5348930214027, 2339.391758142878, 2339.6958395408574, 2300.2869110575775, 2303.4126297794123, 2323.268170526279, 2327.5461285049423, 2345.144022431817, 9310.953445232799, 9378.343515953886, 9399.483028433433, 9419.105185007413, 9455.621775128986, 5420.810271640474, 5543.334799824047, 5560.916586251209, 5581.358143813432, 5603.355614104389, 3357.84889679965, 3441.7590768646205, 3469.8265086745814, 3472.9131771705656, 3474.826258687081, 1073.4793625091825, 1077.3051381858656, 1084.2843723142687, 1088.820344643133, 1122.2985633978763, 12886.54897078607, 12942.741145177044, 13044.934775326063, 13085.738285234242, 13147.802782958262, 4722.527747225318, 4748.169070412733, 4801.351817504662, 4838.153323168432, 4868.95131048692, 10263.0, 10309.896901031043, 10335.94832025835, 10343.793124137475, 10396.324238924446, 5502.257195278667, 5575.0, 5577.8047768327915, 5583.748731307101, 5588.1059030555725, 4456.331550267486, 4996.075725990703, 5082.618803589746, 5139.22911563261, 5147.588192944556, 3881.3013657541915, 3898.571157172709, 3939.153082087365, 3989.860354887565, 3993.0416699992375, 1202.8676845546984, 1207.3842340406457, 1210.4008515784742, 1213.5995121609847, 1217.1540779158577, 917.5962576466334, 1054.5992522841425, 1058.767071244325, 1059.2902755154066, 1063.3513556730388, 6316.0, 6361.936380636134, 6431.807045788634, 6542.21493420783, 6570.342965703391, 966.7003228999033, 972.3873959405529, 1032.948352582368, 1060.528065011078, 1084.8915108489246, 4080.755154690728, 4204.810783514749, 4206.242876282298, 4339.067100573392, 4398.538153493901, 11067.0, 11339.206255562032, 11410.828837567444, 11434.085273178125, 11434.371109588887, 11173.608923687794, 11218.439078046065, 11230.943845280884, 11237.157213209042, 11266.324020558628, 8605.397622166389, 8683.869741953877, 8803.515806630698, 8840.469571825712, 9018.909810901807, 6174.66039367839, 6261.7182226799, 6267.561270711007, 6275.592086514362, 6295.842603934938, 10584.518167456408, 10883.782324353628, 11035.503402346752, 11042.723931901766, 11051.502682379472, 10982.725431863948, 11186.608468703556, 11209.943950280523, 11232.438378081226, 11241.437928103725, 7912.762617121495, 7953.177989278998, 7997.0, 7998.440109192301, 7999.280064794197, 8856.911430885608, 8967.865482017905, 8988.595513202052, 9008.144226298491, 9025.368224224241, 8142.10436851934, 8186.713465028695, 8249.381296402913, 8286.46138001028, 8290.709825156091, 7881.763547093597, 8043.3967452442475, 8091.352691784761, 8200.589970501333, 8286.088530261786, 7060.682269297791, 7206.135263768172, 7207.063081799332, 7378.5941773202985, 7418.777436676908, 5458.263134476795, 5486.369067557282, 5499.312585926759, 5619.157126431068, 5671.546276297804, 5437.184422336682, 5463.235147079492, 5526.392096869261, 5530.585206109638, 5547.084731019498], "value": 4835.249810874836, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.6951743430912, 342.5632318793538, 347.37472549411063, 351.4938488576451, 353.51921386913807, 5371.838844834651, 5385.3268341457315, 5559.805406810762, 5563.805266815662, 5569.0, 5447.210154527591, 5452.863678408042, 5454.945450545493, 5469.398366179717, 5487.259220005298, 4216.472940882382, 4221.593691595792, 4229.534751177368, 4273.786310684469, 4276.524599013351, 4144.689148313889, 4248.0, 4264.402983582301, 4268.317069268917, 4286.171127056144, 4202.201581699483, 4205.873823785276, 4219.915601687964, 4231.714873968053, 4241.257779888507, 4213.925449010513, 4231.132617813341, 4252.255855225354, 4266.125444283945, 4281.871543853689, 3745.138618117848, 3799.9240015199543, 3811.313963486599, 3837.4435706822633, 3853.2871418787613, 5224.52979231871, 5267.341582302212, 5279.894402111975, 5350.35795704514, 5359.330083739533, 4873.074115918, 4908.239222920453, 4912.94371710084, 4919.163742163841, 4977.228529577921, 5624.662520248758, 5798.42015798421, 5827.737751801179, 5848.97075514624, 5853.912191317091, 4205.507044999012, 4211.957880421187, 4212.789360531961, 4219.789010549491, 4237.8304867805255, 5924.170616113747, 6067.150598916155, 6087.239095113111, 6104.725287362079, 6114.510839132903, 3958.5843486434087, 4206.600372964564, 4321.178975994614, 4327.459067616548, 4332.35014747784, 4301.806418711166, 4307.052448461333, 4308.418363520947, 4311.741295522279, 4316.0, 4894.241392584155, 4906.779194936236, 4955.686743013104, 4956.182229932093, 4961.082199792978, 5635.830925072254, 5843.941560584425, 5853.180554722342, 5861.9706901465215, 5878.911816322759, 1460.9700161386197, 1474.5207807462402, 1477.6601381682274, 1479.5117611188282, 1498.086167437862, 930.7905721212672, 944.447498213539, 950.3157726436955, 957.6025949231131, 958.755517343073, 4982.6512144149565, 5010.49895010496, 5015.749212539358, 5038.949610503922, 5075.644704870698, 5272.841814745564, 5296.285001524745, 5329.854081372523, 5350.27771250884, 5403.352357344873, 4941.802327906916, 4949.950500495021, 5014.498550144956, 5239.397469291081, 5748.447919061829, 3167.3506931079532, 3182.554442378069, 3186.4423725847882, 3191.3457741163006, 3213.9072715276916, 6149.739303442783, 6216.471599913967, 6223.661912688794, 6308.179936608303, 6333.429991300805, 6046.546509011841, 6086.421789929949, 6095.969520152459, 6126.540509461808, 6140.6929653517145, 6105.32841387447, 6130.693465326716, 6177.938220617736, 6188.9690551546955, 6211.409916058057, 5849.519535876147, 5891.38140495259, 5894.730528746378, 5964.433378829004, 5998.910016349845, 5906.202662640489, 5906.911396329145, 5921.940780592139, 5943.851403714942, 5949.940500595112, 5885.293764748258, 6155.876882462415, 6215.316315205414, 6217.906731398942, 6246.312905580474, 4164.770937598461, 4186.639342213732, 4203.936940945827, 4208.494980602225, 4251.787410629394, 5934.3175534814045, 5986.610870293417, 6063.0, 6064.332923378513, 6070.939290607037, 5478.945210547843, 5802.593818432669, 5807.82576522705, 5835.4748072673665, 5883.764649413975, 5721.456461636138, 5786.855328616818, 5819.738111784895, 5831.504322132666, 5871.236739223874, 5676.801311954062, 5742.483176514133, 5754.194412782297, 5802.216700745345, 5806.5645076618575, 5841.386654401396, 5889.676067816311, 5892.911606325994, 5925.585209035326, 5958.19564358806, 5744.540436765133, 5747.540196784331, 5777.804434315101, 5802.83943211351, 5803.448672376117], "value": 4390.254425422376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.991960080399, 816.7508909782514, 817.7791996161037, 845.2139510255462, 889.9555022248886, 13687.384067716952, 15026.17356045417, 15049.774253386207, 15082.698346033072, 15090.170040647774, 14648.633784155401, 14718.705625887476, 14753.557393278219, 14762.704745905075, 14795.33420996055, 688.9483288753338, 814.604916615444, 850.4472093139447, 854.700854700856, 862.0129951205865, 856.8372009318209, 857.9828403431927, 866.4671227195261, 867.9609417576193, 871.7689812199773, 899.4288626722014, 902.9277657787394, 903.3721563513361, 903.3811838890348, 903.8960519540271, 880.5685214245038, 891.3404080980093, 894.5661354243186, 895.7268033249857, 896.8296023755531, 649.8440374310179, 650.6421468192475, 653.1672118049478, 654.4764188649109, 656.0421784195081, 14667.193304368255, 14669.853301466956, 14856.62858428548, 14867.776983345258, 14880.62798430048, 14290.214038227894, 14447.277636118151, 14489.0, 14756.557303280919, 14846.331915063847, 11263.324200547993, 11346.602868899632, 11461.083113350913, 11499.080073594176, 11759.58841440554, 3727.329080765461, 3802.296575133609, 3843.1737176507186, 3965.940510892339, 3969.6030396960364, 57281.0, 57534.0, 59297.0, 59536.40463595352, 59617.70191149016, 10651.73370665724, 10737.0, 10828.675139745821, 10867.945660271806, 10948.288361256493, 18145.7278140828, 18254.0, 18263.360782372554, 18532.536686582942, 20320.28878989228, 8277.130901255401, 8298.958505207434, 8455.704050358208, 8656.697015604424, 8712.738617841474, 4789.904201915942, 4790.736509491941, 4804.495527969582, 4844.249141383091, 4925.87685307863, 3506.2461570762407, 3587.4260118381458, 3611.620779818134, 3612.909677258037, 3631.800250986168, 625.3996163682824, 631.2267472346339, 644.262319644005, 649.2630863969334, 652.9771457998947, 734.6583838515116, 767.4474378447509, 777.3237283563224, 806.6571707024608, 809.3039985612369, 9141.862872056925, 9492.193163581034, 9539.618415263312, 9577.090176433228, 9600.423974561549, 664.9468042556584, 717.7021536062475, 765.5215490318551, 773.7756050745334, 780.5667854340895, 4591.95408045922, 4606.539346065434, 4688.976555117202, 4791.808327666924, 4835.0, 65087.34912650813, 66530.66734666296, 66847.0, 66917.66541167263, 67025.66487167533, 60989.0, 62003.379966200664, 62176.067358989654, 62801.371986280465, 63037.68481157565, 42610.78694606445, 57322.0, 57383.713081434325, 57914.0, 58817.70591147017, 8853.0, 8996.0, 9221.538923053686, 9224.169824715807, 9254.722358329262, 33650.83174584111, 34133.0, 35826.10434739153, 37322.06694832651, 37425.6257437433, 50090.499095008585, 50169.49830501794, 50699.0, 50848.74575627098, 51560.22659660033, 11370.260933039326, 11517.942410287895, 11643.650690479299, 12011.81982270284, 13325.200487970753, 12158.878411215775, 12951.870481295444, 13039.348032598142, 13122.212667239995, 13520.25638589887, 12583.748325033264, 12604.49582016709, 12611.180273282207, 12634.2419454833, 12823.166494177849, 11578.247413918069, 11638.788684731438, 11721.179517433698, 11901.0, 11934.22427542207, 12063.577774777841, 12069.336186509476, 12129.272243665408, 12209.450574724337, 12527.812082818948, 9552.474613896302, 9707.029297070236, 9950.950245248727, 9955.904850466299, 10018.749531261485, 9892.653757118467, 10230.590776368861, 10299.897001029894, 10754.40850753216, 11659.76680466369], "value": 6948.09683745472, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 104.0, 111.0, 110.0, 110.0, 104.0, 110.0, 111.0, 112.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 150.0, 202.0, 125.0, 154.0, 153.0, 124.0, 182.0, 124.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 160.0, 166.0, 173.0, 164.0, 164.0, 161.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 169.0, 75.0, 74.0, 74.0, 77.0, 187.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 173.0, 92.0, 92.0, 93.0, 151.0, 92.0, 93.0, 146.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 118.0, 117.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 94.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 55.0, 57.0, 55.0, 55.0, 59.0, 55.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 62.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 78.0, 78.0, 79.0, 80.0, 86.0, 79.0, 140.0, 79.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 128.0, 125.0, 128.0, 119.0, 136.0, 118.0, 153.0, 124.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 164.0, 161.0, 160.0, 158.0, 159.0, 159.0, 169.0, 157.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 63.0, 65.0, 63.0, 62.0, 64.0, 63.0, 65.0, 63.0], "value": 63.6, "unit": "score"}]}]} 20:30:12 INFO - Return code: 0 20:30:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:30:12 ERROR - # TBPL SUCCESS # 20:30:12 INFO - Running post-action listener: _resource_record_post_action 20:30:12 INFO - ##### 20:30:12 INFO - ##### Finished run-tests step (success) 20:30:12 INFO - ##### 20:30:12 INFO - Running post-run listener: _resource_record_post_run 20:30:13 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 472522752; Read time: 12; Write time: 319704 20:30:13 INFO - TinderboxPrint: CPU usage
13.4% 20:30:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:30:13 INFO - TinderboxPrint: I/O write bytes / time
472,522,752 / 319,704 20:30:13 INFO - TinderboxPrint: CPU idle
8,223.3 (86.6%) 20:30:13 INFO - TinderboxPrint: CPU user
1,217.2 (12.8%) 20:30:13 INFO - TinderboxPrint: Swap in / out
0 / 0 20:30:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 181420032; Read time: 0; Write time: 161892 20:30:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291102720; Read time: 12; Write time: 157812 20:30:13 INFO - Running post-run listener: _upload_blobber_files 20:30:13 INFO - Blob upload gear active. 20:30:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:30:13 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 20:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:30:14 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:17 INFO - (blobuploader) - INFO - Done attempting. 20:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:18 INFO - (blobuploader) - INFO - Done attempting. 20:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:19 INFO - (blobuploader) - INFO - Done attempting. 20:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:19 INFO - Return code: 0 20:30:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb8b6b200ebb37be1406519afbe124a03811d239aef348a7ea246458d6d502d3bc57b5326313ecc32c9a01171ab5511c3ba4048a2545ab79ffe745e1ce1152a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f251e5a25e17d05233580d20d2d832aa082633c746aab8de4c594ead762d6060a309a4440120be31d332367b7dd0fa3bde5cd0aede112d64248d78df27e3fb93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/950a95cdc2a3d9dbf6798353fe6981df6c40b3ac1fbd40a1a842ceebfdec04d1082252b386ee97eb55b4fd8367e95a09dad5179db816d8820329205794eb0bfe"} 20:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:30:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:30:19 INFO - Contents: 20:30:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb8b6b200ebb37be1406519afbe124a03811d239aef348a7ea246458d6d502d3bc57b5326313ecc32c9a01171ab5511c3ba4048a2545ab79ffe745e1ce1152a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f251e5a25e17d05233580d20d2d832aa082633c746aab8de4c594ead762d6060a309a4440120be31d332367b7dd0fa3bde5cd0aede112d64248d78df27e3fb93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/950a95cdc2a3d9dbf6798353fe6981df6c40b3ac1fbd40a1a842ceebfdec04d1082252b386ee97eb55b4fd8367e95a09dad5179db816d8820329205794eb0bfe"} 20:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:19 INFO - Copying logs to upload dir... 20:30:19 INFO - mkdir: /builds/slave/test/build/upload/logs 20:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.957828 ========= master_lag: 39.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-05-14 20:30:59.112826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 20:30:59.116147) ========= 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-1463281487.485346-293618923 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/sha512/eb8b6b200ebb37be1406519afbe124a03811d239aef348a7ea246458d6d502d3bc57b5326313ecc32c9a01171ab5511c3ba4048a2545ab79ffe745e1ce1152a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f251e5a25e17d05233580d20d2d832aa082633c746aab8de4c594ead762d6060a309a4440120be31d332367b7dd0fa3bde5cd0aede112d64248d78df27e3fb93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/950a95cdc2a3d9dbf6798353fe6981df6c40b3ac1fbd40a1a842ceebfdec04d1082252b386ee97eb55b4fd8367e95a09dad5179db816d8820329205794eb0bfe"} build_url:https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/LMM4aMymSoiMH08uXZZhhQ/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/sha512/eb8b6b200ebb37be1406519afbe124a03811d239aef348a7ea246458d6d502d3bc57b5326313ecc32c9a01171ab5511c3ba4048a2545ab79ffe745e1ce1152a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f251e5a25e17d05233580d20d2d832aa082633c746aab8de4c594ead762d6060a309a4440120be31d332367b7dd0fa3bde5cd0aede112d64248d78df27e3fb93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/950a95cdc2a3d9dbf6798353fe6981df6c40b3ac1fbd40a1a842ceebfdec04d1082252b386ee97eb55b4fd8367e95a09dad5179db816d8820329205794eb0bfe"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 20:30:59.452388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:30:59.452754) ========= 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-1463281487.485346-293618923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:30:59.743702) ========= ========= Started reboot skipped (results: 3, elapsed: 9 secs) (at 2016-05-14 20:30:59.744019) ========= ========= Finished reboot skipped (results: 3, elapsed: 9 secs) (at 2016-05-14 20:31:08.755940) ========= ========= Total master_lag: 40.33 =========