builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464177558.34 results: success (0) buildid: 20160525023005 builduid: 59a4bf95e9594166b31cf10b5c09b01f revision: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.335809) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.336293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.336644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.371883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.372175) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 04:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2016-05-25 04:59:18 (69.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181041 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.583601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.584105) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018838 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.642607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.642978) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 --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 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 --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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 04:59:18,406 truncating revision to first 12 chars 2016-05-25 04:59:18,406 Setting DEBUG logging. 2016-05-25 04:59:18,406 attempt 1/10 2016-05-25 04:59:18,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c599aa289d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 04:59:18,648 unpacking tar archive at: fx-team-3c599aa289d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.187118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.187899) ========= script_repo_revision: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.188545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.188903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.199897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-25 04:59:19.200446) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:19 INFO - MultiFileLogger online at 20160525 04:59:19 in /builds/slave/test 04:59:19 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 04:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:59:19 INFO - {'append_to_log': False, 04:59:19 INFO - 'base_work_dir': '/builds/slave/test', 04:59:19 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:59:19 INFO - 'branch': 'Fx-Team', 04:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:19 INFO - 'config_files': ('talos/linux_config.py',), 04:59:19 INFO - 'default_actions': ('clobber', 04:59:19 INFO - 'read-buildbot-config', 04:59:19 INFO - 'download-and-extract', 04:59:19 INFO - 'populate-webroot', 04:59:19 INFO - 'create-virtualenv', 04:59:19 INFO - 'install', 04:59:19 INFO - 'run-tests'), 04:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:19 INFO - 'download_minidump_stackwalk': True, 04:59:19 INFO - 'download_symbols': 'ondemand', 04:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:19 INFO - 'installer_path': 'installer.exe', 04:59:19 INFO - 'log_level': 'info', 04:59:19 INFO - 'log_name': 'talos', 04:59:19 INFO - 'log_to_console': True, 04:59:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:19 INFO - 'opt_config_files': (), 04:59:19 INFO - 'pip_index': False, 04:59:19 INFO - 'sps_profile': False, 04:59:19 INFO - 'sps_profile_interval': 0, 04:59:19 INFO - 'suite': 'dromaeojs-e10s', 04:59:19 INFO - 'system_bits': '32', 04:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:19 INFO - 'title': 'talos-linux64-ix-064', 04:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:19 INFO - 'use_talos_json': True, 04:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:19 INFO - 'work_dir': 'build'} 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running clobber step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: clobber 04:59:19 INFO - rmtree: /builds/slave/test/build 04:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - ##### 04:59:19 INFO - ##### Finished clobber step (success) 04:59:19 INFO - ##### 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running read-buildbot-config step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: read_buildbot_config 04:59:19 INFO - Using buildbot properties: 04:59:19 INFO - { 04:59:19 INFO - "project": "", 04:59:19 INFO - "product": "firefox", 04:59:19 INFO - "script_repo_revision": "production", 04:59:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:59:19 INFO - "repository": "", 04:59:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:59:19 INFO - "buildid": "20160525023005", 04:59:19 INFO - "pgo_build": "True", 04:59:19 INFO - "basedir": "/builds/slave/test", 04:59:19 INFO - "buildnumber": 376, 04:59:19 INFO - "slavename": "talos-linux64-ix-064", 04:59:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:59:19 INFO - "platform": "ubuntu64_hw", 04:59:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:59:19 INFO - "branch": "fx-team", 04:59:19 INFO - "repo_path": "integration/fx-team", 04:59:19 INFO - "revision": "3c599aa289d8df66c7959dd65fd58cb1067c7fa9", 04:59:19 INFO - "stage_platform": "linux64-pgo", 04:59:19 INFO - "builduid": "59a4bf95e9594166b31cf10b5c09b01f", 04:59:19 INFO - "slavebuilddir": "test" 04:59:19 INFO - } 04:59:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - ##### 04:59:19 INFO - ##### Finished read-buildbot-config step (success) 04:59:19 INFO - ##### 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running download-and-extract step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: download_and_extract 04:59:19 INFO - mkdir: /builds/slave/test/build/tests 04:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:19 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:59:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:26 INFO - Downloaded 1361 bytes. 04:59:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:26 INFO - Using the following test package requirements: 04:59:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:59:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'jsshell-linux-x86_64.zip'], 04:59:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:59:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:59:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:26 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:27 INFO - Downloaded 24417171 bytes. 04:59:27 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'] 04:59:27 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 04:59:28 INFO - Return code: 0 04:59:28 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 04:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:28 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:36 INFO - Downloaded 24417171 bytes. 04:59:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:59:38 INFO - Return code: 0 04:59: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')]} 04:59:38 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:41 INFO - Downloaded 10840359 bytes. 04:59:41 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'] 04:59:41 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 04:59:41 INFO - Return code: 0 04:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:41 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/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 04:59:43 INFO - Downloaded 58632985 bytes. 04:59:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:43 INFO - mkdir: /builds/slave/test/properties 04:59:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:59:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:59:43 INFO - Contents: 04:59:43 INFO - build_url:https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:44 INFO - Running post-action listener: _resource_record_post_action 04:59:44 INFO - Running post-action listener: set_extra_try_arguments 04:59:44 INFO - ##### 04:59:44 INFO - ##### Finished download-and-extract step (success) 04:59:44 INFO - ##### 04:59:44 INFO - ##### 04:59:44 INFO - ##### Running populate-webroot step. 04:59:44 INFO - ##### 04:59:44 INFO - Running pre-action listener: _resource_record_pre_action 04:59:44 INFO - Running main action method: populate_webroot 04:59:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:44 INFO - '--tppagecycles', 04:59:44 INFO - '7'], 04:59:44 INFO - 'tests': ['tsvgm']}}, 04:59:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:59:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:59:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['damp', 'tps']}, 04:59:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'tests': ['damp', 'tps']}, 04:59:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['dromaeo_dom']}, 04:59:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['a11yr', 04:59:44 INFO - 'ts_paint', 04:59:44 INFO - 'tpaint', 04:59:44 INFO - 'sessionrestore', 04:59:44 INFO - 'sessionrestore_no_auto_restore', 04:59:44 INFO - 'tabpaint']}, 04:59:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['tsvgx', 04:59:44 INFO - 'tsvgr_opacity', 04:59:44 INFO - 'tart', 04:59:44 INFO - 'tscrollx', 04:59:44 INFO - 'cart']}, 04:59:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:59:44 INFO - 'tsvgr_opacity', 04:59:44 INFO - 'tart', 04:59:44 INFO - 'tscrollx', 04:59:44 INFO - 'cart']}, 04:59:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'talos_options': ['--disable-e10s'], 04:59:44 INFO - 'tests': ['tp5o']}, 04:59:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'tests': ['tp5o']}, 04:59:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'talos_options': ['--disable-e10s', 04:59:44 INFO - '--xperf_path', 04:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:44 INFO - 'tests': ['tp5n']}, 04:59:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:44 INFO - 'talos_options': ['--xperf_path', 04:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:44 INFO - 'tests': ['tp5n']}}, 04:59:44 INFO - 'talos.zip': {'path': '', 04:59:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:44 INFO - Running post-action listener: _resource_record_post_action 04:59:44 INFO - ##### 04:59:44 INFO - ##### Finished populate-webroot step (success) 04:59:44 INFO - ##### 04:59:44 INFO - ##### 04:59:44 INFO - ##### Running create-virtualenv step. 04:59:44 INFO - ##### 04:59:44 INFO - Running pre-action listener: _resource_record_pre_action 04:59:44 INFO - Running main action method: create_virtualenv 04:59:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:59:44 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 04:59:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:59:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:44 INFO - Using real prefix '/usr' 04:59:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:59:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:47 INFO - Installing pip.................done. 04:59:47 INFO - Return code: 0 04:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:59:47 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')]} 04:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 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')]} 04:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', '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 04:59:47 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 04:59:47 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 04:59:47 INFO - Using env: {'DISPLAY': ':0', 04:59:47 INFO - 'HOME': '/home/cltbld', 04:59:47 INFO - 'LANG': 'en_US.UTF-8', 04:59:47 INFO - 'LANGUAGE': 'en_US:en', 04:59:47 INFO - 'LOGNAME': 'cltbld', 04:59:47 INFO - 'MAIL': '/var/mail/cltbld', 04:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:47 INFO - 'MOZ_NO_REMOTE': '1', 04:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:47 INFO - 'NO_EM_RESTART': '1', 04:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:47 INFO - 'PWD': '/builds/slave/test', 04:59:47 INFO - 'SHELL': '/bin/bash', 04:59:47 INFO - 'SHLVL': '1', 04:59:47 INFO - 'TERM': 'linux', 04:59:47 INFO - 'TMOUT': '86400', 04:59:47 INFO - 'USER': 'cltbld', 04:59:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 04:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:47 INFO - '_': '/tools/buildbot/bin/python'} 04:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:47 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 04:59:47 INFO - Cleaning up... 04:59:47 INFO - Return code: 0 04:59:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:59:47 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')]} 04:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 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')]} 04:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', '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 04:59:47 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 04:59:47 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 04:59:47 INFO - Using env: {'DISPLAY': ':0', 04:59:47 INFO - 'HOME': '/home/cltbld', 04:59:47 INFO - 'LANG': 'en_US.UTF-8', 04:59:47 INFO - 'LANGUAGE': 'en_US:en', 04:59:47 INFO - 'LOGNAME': 'cltbld', 04:59:47 INFO - 'MAIL': '/var/mail/cltbld', 04:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:47 INFO - 'MOZ_NO_REMOTE': '1', 04:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:47 INFO - 'NO_EM_RESTART': '1', 04:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:47 INFO - 'PWD': '/builds/slave/test', 04:59:47 INFO - 'SHELL': '/bin/bash', 04:59:47 INFO - 'SHLVL': '1', 04:59:47 INFO - 'TERM': 'linux', 04:59:47 INFO - 'TMOUT': '86400', 04:59:47 INFO - 'USER': 'cltbld', 04:59:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 04:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:47 INFO - '_': '/tools/buildbot/bin/python'} 04:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:47 INFO - Downloading/unpacking psutil>=3.1.1 04:59:47 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 04:59:47 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 04:59:47 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 04:59:47 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 04:59:47 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 04:59:47 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 04:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:49 INFO - Installing collected packages: psutil 04:59:49 INFO - Running setup.py install for psutil 04:59:49 INFO - building 'psutil._psutil_linux' extension 04:59:49 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 04:59:50 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 04:59:51 INFO - building 'psutil._psutil_posix' extension 04:59:51 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 04:59:51 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 04:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:51 INFO - Successfully installed psutil 04:59:51 INFO - Cleaning up... 04:59:51 INFO - Return code: 0 04:59:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', '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 04:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:59:51 INFO - Using env: {'DISPLAY': ':0', 04:59:51 INFO - 'HOME': '/home/cltbld', 04:59:51 INFO - 'LANG': 'en_US.UTF-8', 04:59:51 INFO - 'LANGUAGE': 'en_US:en', 04:59:51 INFO - 'LOGNAME': 'cltbld', 04:59:51 INFO - 'MAIL': '/var/mail/cltbld', 04:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:51 INFO - 'MOZ_NO_REMOTE': '1', 04:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:51 INFO - 'NO_EM_RESTART': '1', 04:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:51 INFO - 'PWD': '/builds/slave/test', 04:59:51 INFO - 'SHELL': '/bin/bash', 04:59:51 INFO - 'SHLVL': '1', 04:59:51 INFO - 'TERM': 'linux', 04:59:51 INFO - 'TMOUT': '86400', 04:59:51 INFO - 'USER': 'cltbld', 04:59:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 04:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:51 INFO - '_': '/tools/buildbot/bin/python'} 04:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:59:53 INFO - Installing collected packages: mozsystemmonitor 04:59:53 INFO - Running setup.py install for mozsystemmonitor 04:59:53 INFO - Successfully installed mozsystemmonitor 04:59:53 INFO - Cleaning up... 04:59:53 INFO - Return code: 0 04:59:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', '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 04:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:59:53 INFO - Using env: {'DISPLAY': ':0', 04:59:53 INFO - 'HOME': '/home/cltbld', 04:59:53 INFO - 'LANG': 'en_US.UTF-8', 04:59:53 INFO - 'LANGUAGE': 'en_US:en', 04:59:53 INFO - 'LOGNAME': 'cltbld', 04:59:53 INFO - 'MAIL': '/var/mail/cltbld', 04:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:53 INFO - 'MOZ_NO_REMOTE': '1', 04:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:53 INFO - 'NO_EM_RESTART': '1', 04:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:53 INFO - 'PWD': '/builds/slave/test', 04:59:53 INFO - 'SHELL': '/bin/bash', 04:59:53 INFO - 'SHLVL': '1', 04:59:53 INFO - 'TERM': 'linux', 04:59:53 INFO - 'TMOUT': '86400', 04:59:53 INFO - 'USER': 'cltbld', 04:59:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 04:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:53 INFO - '_': '/tools/buildbot/bin/python'} 04:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:56 INFO - Downloading docopt-0.6.1.tar.gz 04:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:56 INFO - Running setup.py install for blobuploader 04:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:56 INFO - Running setup.py install for requests 04:59:56 INFO - Running setup.py install for docopt 04:59:57 INFO - Successfully installed blobuploader requests docopt 04:59:57 INFO - Cleaning up... 04:59:57 INFO - Return code: 0 04:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:57 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')]} 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:57 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')]} 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:57 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', '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 04:59:57 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 04:59:57 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 04:59:57 INFO - Using env: {'DISPLAY': ':0', 04:59:57 INFO - 'HOME': '/home/cltbld', 04:59:57 INFO - 'LANG': 'en_US.UTF-8', 04:59:57 INFO - 'LANGUAGE': 'en_US:en', 04:59:57 INFO - 'LOGNAME': 'cltbld', 04:59:57 INFO - 'MAIL': '/var/mail/cltbld', 04:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:57 INFO - 'MOZ_NO_REMOTE': '1', 04:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:57 INFO - 'NO_EM_RESTART': '1', 04:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:57 INFO - 'PWD': '/builds/slave/test', 04:59:57 INFO - 'SHELL': '/bin/bash', 04:59:57 INFO - 'SHLVL': '1', 04:59:57 INFO - 'TERM': 'linux', 04:59:57 INFO - 'TMOUT': '86400', 04:59:57 INFO - 'USER': 'cltbld', 04:59:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 04:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:57 INFO - '_': '/tools/buildbot/bin/python'} 04:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:57 INFO - Running setup.py (path:/tmp/pip-3lvxRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:57 INFO - Running setup.py (path:/tmp/pip-8Bc9j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:57 INFO - Running setup.py (path:/tmp/pip-6o5EP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:57 INFO - Running setup.py (path:/tmp/pip-1M9Zdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:57 INFO - Running setup.py (path:/tmp/pip-mW7602-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:57 INFO - Running setup.py (path:/tmp/pip-g2fCst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:57 INFO - Running setup.py (path:/tmp/pip-lPYpLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:57 INFO - Running setup.py (path:/tmp/pip-dsVI_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:57 INFO - Running setup.py (path:/tmp/pip-ZWCz1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:57 INFO - Running setup.py (path:/tmp/pip-GjblWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:57 INFO - Running setup.py (path:/tmp/pip-QUeLiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:58 INFO - Running setup.py (path:/tmp/pip-92D7Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:58 INFO - Running setup.py (path:/tmp/pip-9YRc2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:58 INFO - Running setup.py (path:/tmp/pip-YN391E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:58 INFO - Running setup.py (path:/tmp/pip-vlD2l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:58 INFO - Running setup.py (path:/tmp/pip-RkELsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:58 INFO - Running setup.py (path:/tmp/pip-5ie0Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:58 INFO - Running setup.py install for manifestparser 04:59:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:58 INFO - Running setup.py install for mozcrash 04:59:58 INFO - Running setup.py install for mozdebug 04:59:58 INFO - Running setup.py install for mozdevice 04:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:58 INFO - Running setup.py install for mozfile 04:59:59 INFO - Running setup.py install for mozhttpd 04:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozinfo 04:59:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozInstall 04:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozleak 04:59:59 INFO - Running setup.py install for mozlog 04:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for moznetwork 04:59:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozprocess 04:59:59 INFO - Running setup.py install for mozprofile 04:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozrunner 04:59:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozscreenshot 05:00:00 INFO - Running setup.py install for moztest 05:00:00 INFO - Running setup.py install for mozversion 05:00:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:00 INFO - Cleaning up... 05:00:00 INFO - Return code: 0 05:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:00 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:00 INFO - Using env: {'DISPLAY': ':0', 05:00:00 INFO - 'HOME': '/home/cltbld', 05:00:00 INFO - 'LANG': 'en_US.UTF-8', 05:00:00 INFO - 'LANGUAGE': 'en_US:en', 05:00:00 INFO - 'LOGNAME': 'cltbld', 05:00:00 INFO - 'MAIL': '/var/mail/cltbld', 05:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:00 INFO - 'MOZ_NO_REMOTE': '1', 05:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:00 INFO - 'NO_EM_RESTART': '1', 05:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:00 INFO - 'PWD': '/builds/slave/test', 05:00:00 INFO - 'SHELL': '/bin/bash', 05:00:00 INFO - 'SHLVL': '1', 05:00:00 INFO - 'TERM': 'linux', 05:00:00 INFO - 'TMOUT': '86400', 05:00:00 INFO - 'USER': 'cltbld', 05:00:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 05:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:00 INFO - '_': '/tools/buildbot/bin/python'} 05:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:00 INFO - Running setup.py (path:/tmp/pip-QO8B6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:00 INFO - Running setup.py (path:/tmp/pip-w2CvQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:00 INFO - Running setup.py (path:/tmp/pip-Ra02VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:00 INFO - Running setup.py (path:/tmp/pip-V6iX8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:00 INFO - Running setup.py (path:/tmp/pip-d1UPiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:00 INFO - Running setup.py (path:/tmp/pip-dB0Sug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:00 INFO - Running setup.py (path:/tmp/pip-6PkwCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:01 INFO - Running setup.py (path:/tmp/pip-rakHK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:01 INFO - Running setup.py (path:/tmp/pip-WUpAte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:01 INFO - Running setup.py (path:/tmp/pip-haPpX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:01 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)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:01 INFO - Running setup.py (path:/tmp/pip-oPa_6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:01 INFO - Running setup.py (path:/tmp/pip-T1yIIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:01 INFO - Running setup.py (path:/tmp/pip-YnRL1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:01 INFO - Running setup.py (path:/tmp/pip-XuBWLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:01 INFO - Running setup.py (path:/tmp/pip-agT9Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:01 INFO - Running setup.py (path:/tmp/pip-lAetOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:01 INFO - Running setup.py (path:/tmp/pip-9DNVu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:03 INFO - Downloading blessings-1.6.tar.gz 05:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:03 INFO - Installing collected packages: blessings 05:00:03 INFO - Running setup.py install for blessings 05:00:03 INFO - Successfully installed blessings 05:00:03 INFO - Cleaning up... 05:00:03 INFO - Return code: 0 05:00:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:04 INFO - Reading from file tmpfile_stdout 05:00:04 INFO - Current package versions: 05:00:04 INFO - argparse == 1.2.1 05:00:04 INFO - blessings == 1.6 05:00:04 INFO - blobuploader == 1.2.4 05:00:04 INFO - docopt == 0.6.1 05:00:04 INFO - manifestparser == 1.1 05:00:04 INFO - mozInstall == 1.12 05:00:04 INFO - mozcrash == 0.17 05:00:04 INFO - mozdebug == 0.1 05:00:04 INFO - mozdevice == 0.48 05:00:04 INFO - mozfile == 1.2 05:00:04 INFO - mozhttpd == 0.7 05:00:04 INFO - mozinfo == 0.9 05:00:04 INFO - mozleak == 0.1 05:00:04 INFO - mozlog == 3.2 05:00:04 INFO - moznetwork == 0.27 05:00:04 INFO - mozprocess == 0.22 05:00:04 INFO - mozprofile == 0.28 05:00:04 INFO - mozrunner == 6.11 05:00:04 INFO - mozscreenshot == 0.1 05:00:04 INFO - mozsystemmonitor == 0.3 05:00:04 INFO - moztest == 0.7 05:00:04 INFO - mozversion == 1.4 05:00:04 INFO - psutil == 3.1.1 05:00:04 INFO - requests == 1.2.3 05:00:04 INFO - wsgiref == 0.1.2 05:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:04 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:04 INFO - Using env: {'DISPLAY': ':0', 05:00:04 INFO - 'HOME': '/home/cltbld', 05:00:04 INFO - 'LANG': 'en_US.UTF-8', 05:00:04 INFO - 'LANGUAGE': 'en_US:en', 05:00:04 INFO - 'LOGNAME': 'cltbld', 05:00:04 INFO - 'MAIL': '/var/mail/cltbld', 05:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:04 INFO - 'MOZ_NO_REMOTE': '1', 05:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:04 INFO - 'NO_EM_RESTART': '1', 05:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:04 INFO - 'PWD': '/builds/slave/test', 05:00:04 INFO - 'SHELL': '/bin/bash', 05:00:04 INFO - 'SHLVL': '1', 05:00:04 INFO - 'TERM': 'linux', 05:00:04 INFO - 'TMOUT': '86400', 05:00:04 INFO - 'USER': 'cltbld', 05:00:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 05:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:04 INFO - '_': '/tools/buildbot/bin/python'} 05:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:04 INFO - Cleaning up... 05:00:04 INFO - Return code: 0 05:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:04 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 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:00:04 INFO - Using env: {'DISPLAY': ':0', 05:00:04 INFO - 'HOME': '/home/cltbld', 05:00:04 INFO - 'LANG': 'en_US.UTF-8', 05:00:04 INFO - 'LANGUAGE': 'en_US:en', 05:00:04 INFO - 'LOGNAME': 'cltbld', 05:00:04 INFO - 'MAIL': '/var/mail/cltbld', 05:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:04 INFO - 'MOZ_NO_REMOTE': '1', 05:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:04 INFO - 'NO_EM_RESTART': '1', 05:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:04 INFO - 'PWD': '/builds/slave/test', 05:00:04 INFO - 'SHELL': '/bin/bash', 05:00:04 INFO - 'SHLVL': '1', 05:00:04 INFO - 'TERM': 'linux', 05:00:04 INFO - 'TMOUT': '86400', 05:00:04 INFO - 'USER': 'cltbld', 05:00:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 05:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:04 INFO - '_': '/tools/buildbot/bin/python'} 05:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:04 INFO - Downloading/unpacking jsonschema 05:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:06 INFO - warning: no files found matching '*.txt' 05:00:06 INFO - no previously-included directories found matching 'build' 05:00:06 INFO - no previously-included directories found matching 'dist' 05:00:06 INFO - no previously-included directories found matching '.git*' 05:00:06 INFO - Installing collected packages: jsonschema, functools32 05:00:06 INFO - Running setup.py install for functools32 05:00:06 INFO - warning: no files found matching '*.txt' 05:00:06 INFO - no previously-included directories found matching 'build' 05:00:06 INFO - no previously-included directories found matching 'dist' 05:00:06 INFO - no previously-included directories found matching '.git*' 05:00:06 INFO - Successfully installed jsonschema functools32 05:00:06 INFO - Cleaning up... 05:00:06 INFO - Return code: 0 05:00:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2155bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:00:06 INFO - Using env: {'DISPLAY': ':0', 05:00:06 INFO - 'HOME': '/home/cltbld', 05:00:06 INFO - 'LANG': 'en_US.UTF-8', 05:00:06 INFO - 'LANGUAGE': 'en_US:en', 05:00:06 INFO - 'LOGNAME': 'cltbld', 05:00:06 INFO - 'MAIL': '/var/mail/cltbld', 05:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:06 INFO - 'MOZ_NO_REMOTE': '1', 05:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:06 INFO - 'NO_EM_RESTART': '1', 05:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:06 INFO - 'PWD': '/builds/slave/test', 05:00:06 INFO - 'SHELL': '/bin/bash', 05:00:06 INFO - 'SHLVL': '1', 05:00:06 INFO - 'TERM': 'linux', 05:00:06 INFO - 'TMOUT': '86400', 05:00:06 INFO - 'USER': 'cltbld', 05:00:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 05:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:06 INFO - '_': '/tools/buildbot/bin/python'} 05:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:07 INFO - Downloading/unpacking flake8 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:09 INFO - no previously-included directories found matching 'docs/_build' 05:00:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:09 INFO - Running setup.py install for pep8 05:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:09 INFO - no previously-included directories found matching 'docs/_build' 05:00:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:10 INFO - Cleaning up... 05:00:10 INFO - Return code: 0 05:00:10 INFO - Running post-action listener: _resource_record_post_action 05:00:10 INFO - Running post-action listener: _start_resource_monitoring 05:00:10 INFO - Starting resource monitoring. 05:00:10 INFO - ##### 05:00:10 INFO - ##### Finished create-virtualenv step (success) 05:00:10 INFO - ##### 05:00:10 INFO - ##### 05:00:10 INFO - ##### Running install step. 05:00:10 INFO - ##### 05:00:10 INFO - Running pre-action listener: _resource_record_pre_action 05:00:10 INFO - Running main action method: install 05:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:10 INFO - Reading from file tmpfile_stdout 05:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:10 INFO - Reading from file tmpfile_stdout 05:00:10 INFO - Output received: 05:00:10 INFO - Usage: mozinstall [options] installer 05:00:10 INFO - Options: 05:00:10 INFO - -h, --help show this help message and exit 05:00:10 INFO - -d DEST, --destination=DEST 05:00:10 INFO - Directory to install application into. [default: 05:00:10 INFO - "/builds/slave/test"] 05:00:10 INFO - --app=APP Application being installed. [default: firefox] 05:00:10 INFO - mkdir: /builds/slave/test/build/application 05:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:00:27 INFO - Reading from file tmpfile_stdout 05:00:27 INFO - Output received: 05:00:27 INFO - /builds/slave/test/build/application/firefox/firefox 05:00:27 INFO - Running post-action listener: _resource_record_post_action 05:00:27 INFO - ##### 05:00:27 INFO - ##### Finished install step (success) 05:00:27 INFO - ##### 05:00:27 INFO - ##### 05:00:27 INFO - ##### Running run-tests step. 05:00:27 INFO - ##### 05:00:27 INFO - Running pre-action listener: _resource_record_pre_action 05:00:27 INFO - Running main action method: run_tests 05:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:27 INFO - Python 2.7.3 05:00:27 INFO - Return code: 0 05:00:27 INFO - grabbing minidump binary from tooltool 05:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:27 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 0x1fb09c0>, '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 0x1fb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:00:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:00:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:27 INFO - Return code: 0 05:00:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:00:28 INFO - Return code: 0 05:00:28 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/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:00:28 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/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 05:00:28 INFO - Using env: {'DISPLAY': ':0', 05:00:28 INFO - 'HOME': '/home/cltbld', 05:00:28 INFO - 'LANG': 'en_US.UTF-8', 05:00:28 INFO - 'LANGUAGE': 'en_US:en', 05:00:28 INFO - 'LOGNAME': 'cltbld', 05:00:28 INFO - 'MAIL': '/var/mail/cltbld', 05:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:28 INFO - 'MOZ_NO_REMOTE': '1', 05:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:28 INFO - 'NO_EM_RESTART': '1', 05:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:28 INFO - 'PWD': '/builds/slave/test', 05:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:28 INFO - 'SHELL': '/bin/bash', 05:00:28 INFO - 'SHLVL': '1', 05:00:28 INFO - 'TERM': 'linux', 05:00:28 INFO - 'TMOUT': '86400', 05:00:28 INFO - 'USER': 'cltbld', 05:00:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373', 05:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:28 INFO - '_': '/tools/buildbot/bin/python'} 05:00:28 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/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:00:28 INFO - mozversion application_buildid: 20160525023005 05:00:28 INFO - mozversion application_changeset: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 05:00:28 INFO - mozversion application_display_name: Nightly 05:00:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:28 INFO - mozversion application_name: Firefox 05:00:28 INFO - mozversion application_remotingname: firefox 05:00:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:28 INFO - mozversion application_vendor: Mozilla 05:00:28 INFO - mozversion application_version: 49.0a1 05:00:28 INFO - mozversion platform_buildid: 20160525023005 05:00:28 INFO - mozversion platform_changeset: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 05:00:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:28 INFO - mozversion platform_version: 49.0a1 05:00:28 INFO - using testdate: 1464177628 05:00:28 INFO - actual date: 1464177628 05:00:28 INFO - starting webserver on 'localhost:59251' 05:00:28 INFO - SUITE-START | Running 2 tests 05:00:28 INFO - TEST-START | dromaeo_css 05:00:28 INFO - operating with platform_type : linux_ 05:00:28 INFO - Initialising browser for dromaeo_css test... 05:00:28 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg8S9n8/profile http://localhost:59251/getInfo.html) 05:00:33 INFO - PROCESS | 3310 | 05:00:33 INFO - PROCESS | 3310 | (process:3382): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:36 INFO - PROCESS | 3310 | __metrics Screen width/height:1600/1200 05:00:36 INFO - PROCESS | 3310 | colorDepth:24 05:00:36 INFO - PROCESS | 3310 | Browser inner width/height: 1024/697 05:00:36 INFO - PROCESS | 3310 | __metrics 05:00:36 ERROR - PROCESS | 3310 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:00:37 INFO - TEST-INFO | 3310: exit 0 05:00:37 INFO - Browser initialized. 05:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:37 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg8S9n8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:39 INFO - PROCESS | 3433 | 05:00:39 INFO - PROCESS | 3433 | (process:3497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:49 INFO - PROCESS | 3433 | RSS: Main: 164147200 05:00:49 INFO - PROCESS | 3433 | 05:01:38 INFO - PROCESS | 3433 | 1464177698938 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:03:46 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59251/tests/dromaeo/cssquery-ext.html) 05:03:47 INFO - PROCESS | 3433 | RSS: Main: 168169472 05:03:47 INFO - PROCESS | 3433 | 05:06:49 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-ext.html (next: http://localhost:59251/tests/dromaeo/cssquery-jquery.html) 05:06:50 INFO - PROCESS | 3433 | RSS: Main: 166842368 05:06:50 INFO - PROCESS | 3433 | 05:09:52 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59251/tests/dromaeo/cssquery-mootools.html) 05:09:52 INFO - PROCESS | 3433 | RSS: Main: 168620032 05:09:52 INFO - PROCESS | 3433 | 05:12:54 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59251/tests/dromaeo/cssquery-prototype.html) 05:12:55 INFO - PROCESS | 3433 | RSS: Main: 166055936 05:12:55 INFO - PROCESS | 3433 | 05:15:57 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59251/tests/dromaeo/cssquery-yui.html) 05:15:58 INFO - PROCESS | 3433 | RSS: Main: 166916096 05:15:58 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-yui.html (next: http://localhost:59251/tests/dromaeo/cssquery-dojo.html) 05:19:01 INFO - PROCESS | 3433 | RSS: Main: 169447424 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | __start_tp_report 05:19:01 INFO - PROCESS | 3433 | _x_x_mozilla_page_load 05:19:01 INFO - PROCESS | 3433 | _x_x_mozilla_page_load_details 05:19:01 INFO - PROCESS | 3433 | |i|pagename|runs| 05:19:01 INFO - PROCESS | 3433 | |0;dojo.html;3115.906522804316;3118.0489950565084;3138.1683853778736;3145.9685403145963;3158.7157155855975;5377.085895397782;5414.8917021659545;5423.918641220384;5450.618456708032;5464.672119672822;5268.920966185501;5377.193420986854;5484.8354549363585;5501.037318469272;5532.3637781655125;4907.460179380265;4942.87642808929;4982.775775090112;5089.821856235032;5123.615728820353;4906.239532872411;5134.717590532519;5137.2037334213255;5140.485951404867;5167.9483205168035;4882.731449770261;4914.3611330527165;4940.086084074458;4965.155923493015;4972.105021096201;4947.455779864212;4954.826581069681;4956.330895329156;4957.801687932479;4988.401391832967;4911.926321105187;4912.70523768575;4928.088303663833;4943.406791185081;4972.602191824645;5088.847334579968;5191.935653191087;5196.142636464979;5243.161094224944;5301.655392399521;5783.942160578383;5811.012127938261;5821.50517206038;5824.446677565625;5835.241418615596;5857.26784151981;5859.472647461706;5860.853478663025;5867.618604790718;5868.149118377854;5228.137357336035;5382.2464854920345;5420.376656684492;5433.1850222466555;5451.781928722847;5946.345901950782;5961;5973.133895585116;5983.940160598426;5986.640801551921;5716.828495145152;5733.1113677379235;5744.052231381859;5747.109198074305;5770.394108618619;5548;5719.28508936383;5741.25363702716;5801.042827933428;5824.883502330014;5542.722863856791;5742.6554406734895;5774.047282198474;5775.162601422854;5810.041343178413;5886.117082437583;5905.940940590625;5935.198748168942;5950.761969521257;5951.3751056139345;4277.657787377065;4358.694891357638;4369.300911854151;4404.405405270248;4472.351509031172;3882.990422490173;3926.371780515104;3933.6263055009726;3960.3069462843887;3964.0882597002274;5500.1749737538885;5528;5535.114381698909;5547.889042219133;5556.305461817273;5638.267025286768;5846.093855452412;5846.889091072682;5849.093390524476;5874.471297583238;5557.694326811983;5563.7774489019985;5581.330240371181;5586.245856809279;5587.38538760736;4813.614910807127;5070.4929507049;5075.9340538486595;5090.2364645303505;5127.102757017507;5995;6010.038393856962;6023.789167379121;6073.119397687311;6084.5436592255755;5830;5872.823815285548;5875.089361149029;5905.704714764331;5912.201852749824;5840.415958404295;5972.970135149297;6045.879082418415;6056.606320589148;6067.332593414809;5709.7430615623225;5770.596058276048;5778.913316300343;5799.362070172362;5823.097419899922;5779.133130030361;5833.212516310244;5874.911876321944;5894.823155305347;5910;5461.972690136524;5615.691136987505;5655.151727240782;5678.063119585222;5717.628354156966;5521.641093328921;5527.972360138174;5572.582056345709;5704.543636508986;5767.480926716616;5488.69812160319;5496.31296087989;5501.257330260363;5504.889902202013;5566.582506312124;5522.6134170607675;5577.944220557904;5614.85962850932;5615.522680572197;5622.297212848394;5519.724013799374;5529.198266251291;5535.892821435648;5538.529225015919;5587.385387607279 05:19:01 INFO - PROCESS | 3433 | |1;ext.html;587.5152998776011;624.2508989212945;639.8176519691889;660.9669516524174;674.372833265064;36716.816415917914;40558.39162412559;40609.390859137064;40692.1861562769;40724.796376018116;42190.57809421905;42452.57547424525;42507.14985700284;42804.35793463101;42978.57021429785;8620.267277281422;8736.126387361277;8824;8828.42615230008;8844.38089333747;8640.740777776646;8640.740777776677;8679.869801952977;8693.869591956125;8743.868841967376;8692.217700406994;8779.297656187522;8805.911940880605;8806.20744133028;8815.426997245191;8636.39545231834;8644.222020018196;8678.218960293572;8712.69505567302;8733.825323493558;8659.653613855438;8778.209961103468;8785.38502304839;8792.912070879338;8809.603567839462;31412.37175256482;38957.22085558273;39407;39416.21167576661;39529.80235098806;3368;3534.91162720934;3556.8399422026073;3615.94576081359;3678.6505281998166;30664.8466757667;30734.538981915288;31093;31185.376292474022;31903.202419939687;3984.2629113613784;3987.9202415951518;4007.6593489553425;4174.666026717855;4182.205380977604;286660;288307;289891;291785.9999999979;291856;33952.83023584916;34190.829045855106;34497.482537761956;34686.306273874885;35542.46686299708;34885.476717849255;35124.82437587796;35179.120521987155;35343.646563534036;35488.40302186408;14292.571222863331;14401.78397324041;14417.567472975827;14418.495352662607;14446.638834029234;11710.76578468426;11799.410029498491;11841.940790296167;11885.16803823724;11902.571691396915;8366.79083022917;8437.282830959315;8441.113683063313;8512.191341822518;8518.87221691675;3235.142687187897;3267.18320419895;3289.161263877696;3289.1777055736065;3301.273719781644;1031.4533297352416;1060.173065009294;1068.3269540189785;1125.4654039331251;1139.5043156226902;33033.339333213204;33236.335273294884;33489;33681.66318336834;36003.63996360003;1124.3197865291545;1152.809786385237;1182.8107502799683;1203.7351782607811;1222.5598784437595;16622.168891555615;16643.667126657398;16715.16424178786;16874.325026998784;17030.403935862185;501432;503213;508555;508597;510783;55061;55560.44439555633;55641.44358556443;55748.44251557514;55810;1407.92960351982;1412.1244828206577;1426.179946530749;1442.898997070195;1449.5506393018197;30051.248718782204;31585.8420707895;31767.205819854687;31916.49736184011;32082.679173208904;49433;49991.50008500014;50564.73588160326;50608.493915060375;50715;395519;399108;402277;404473;404604;27389.86305068462;27403.04089356863;27546;27601.925297266756;27618.309542260802;45221.32168017548;46286.30570541512;46688.29967550422;46863;47862.76068619634;39460.40809387919;39703.60296396999;40099.599004009586;40597;40720.185596287316;39570.208595828495;39667;39803;39910;40810.38784418296;39177.80411097926;39710.42606165459;42131;42286;44523.55476445194;34058.82970585131;37625.811870941565;37790.43314350232;37860.81069594635;38147.61852381441;28950.855245723636;29059.273518161368;29106.56340154857;29258.41483170282;29475 05:19:01 INFO - PROCESS | 3433 | |2;jquery.html;390.141688285771;394.42807928503674;402.31606269342126;406.6157481180284;422.8477399087487;17791.822081779195;18772.62454750904;19386.70919936202;19412.708809367872;19415.320463783733;18144.637107257848;18180.90909545454;18399.54001149972;18995.90502047488;19054.33309834156;5233.8953220935555;5303.867403314909;5477.780888764445;5698.743556539945;5711.685857277848;5567.638103523278;5579.804706835262;5590.888182236373;5595.524380427669;5612.7754889804355;5446.782128714866;5480.808171713991;5577.944220557803;5595.4124816894255;5619.269494965649;5550.389457159709;5560.36055853578;5591.496765291144;5618.241537392461;5623.80316688916;4800.879978000543;4994.675346102492;5008;5023.146065168893;5028.220625803006;22176.334709958726;22415.215467458725;23009.079636814506;23250.65124023141;23274;2308.699869017034;2376.619740841474;2389.2473870730837;2533.987330063338;2683.8658067096762;14579.562613121623;14644.560663180122;14701.411943522246;14739.115653060851;14814.333354999051;1900.6388786130592;1998.7601487821555;2033.30867505049;2048.1193086972594;2054.219396629286;58107.41892581105;74658;76097;76321;77917;10314.896851031544;10411.271211015308;10703.1437485001;10813.91860813928;10909.618163364245;14823.77764333536;14868.182249976355;14877.702445951238;14892.478763243234;15002.24988750558;7729.5748733819055;8018.919810801817;8044.4368894178015;8151.225633564802;8221.917780822236;7665.425093118039;7716.4212684048925;7767.339776119094;7829.64766585505;7895.171007044292;6556.901646475307;6571;6581.440577550866;6647.401733843977;6661.767572999011;1896.8767030142997;1941.1944043222188;1950.7073938908993;1976.8023197680118;1977.960440791176;877.4954401219325;1028.8662473878348;1044.1385856668278;1060.183658582887;1092.814221582333;19365.4190374289;19783.10976006083;19788.604227915363;19818.60362792736;19934.800651993293;1038.4288641247435;1078.336822853939;1118.9720256993478;1128.1707944660668;1133.739239974794;10919.181061420426;11409.42952852354;11421.086313094933;11427.200095993201;11469.025132863633;401035;405924;406275;407750;409650;65865.34134658592;81428.59285703534;81544.59227703942;81585.18414815776;83070.58464707638;1039.1063685230695;1048.0567489259727;1081.5727787523883;1090.2150451674781;1098.8516550265613;17244;17307.913460432617;17607.20767565437;17693.469195924143;17775.288988440316;41018.79490602647;41843.581564183965;42286.15427691367;42346.364804527344;42440.57559424366;57741.4225857736;59925.40074599198;60071.69964150151;60079.399206009126;60508.394916050274;7923.643436045277;8126.5936703163425;8359.164083591835;8393.916060839314;8473.915260847312;11417.257878237888;11760.529578816751;12333.93833030829;12414;12991.35043247815;11233.269837460539;11265.63491627228;11271;11455.59905403307;11549.133814963743;11301.09591232683;11327.830082548604;11365.715857103307;11470.369129697947;11578.189526733047;11416.600418985628;11592.478338474957;11650.184487085822;11680.76638467209;11721.648350549498;8143.633536490991;8213.876791848008;8222.301104405953;8409.117042710672;8514.148585141436;10683.732906677084;10714.410707411167;11253.15601329887;11262.436878155895;11429.714257143638 05:19:01 INFO - PROCESS | 3433 | |3;mootools.html;1494.7832564278176;1541.6916616676665;1720.277483456948;1835.6971099768539;1848.4454663600916;7996.92003079969;8823;8841.734747957555;9365.67220147295;9408.81182376353;8884.73345799627;9083.091690830914;9183;9192.770180745485;9201.17189452949;2352.4236562042324;2371.312319427364;2371.7865392114704;2376.738558758535;2388.2357645553343;2309.168699268262;2322.6167682332393;2379.8453100548495;2382.65451509531;2383.809295256375;2371.027878569787;2378.262738551046;2383.6901202843605;2399.992003358585;2400.3039118655656;2287.63397856343;2290.942726431836;2317.15423870287;2321.0599707118645;2322.222055611372;2320.164740693349;2326.8022218111482;2347.3779448446176;2350.424146084203;2352.364861487406;8945.59744811485;9035.186833185046;9038.096190380975;9041.276697864156;9056;5257.631965762398;5411.621186516945;5451.918221226685;5490.258815059956;5502.642328248651;3368.854589439578;3400.1159698478327;3473.7915725056578;3477.8434970426138;3478.2174010847357;1142.9714257143555;1182.5506307603055;1184.6209213051827;1188.6671731915078;1193.224404137309;12888.548900788428;12969.87030129696;13012.479500819956;13055.86944130556;13075.084744067919;4488.775561221926;4509.751963642031;4596.609288210473;4610.308453731967;4630.120277147331;10063.245256605784;10149.594016239416;10187.54156062979;10190.031946965026;10191.490425478845;5259.368875734936;5284.5772338212855;5413.296271484682;5444.101723215705;5483.75323110461;4400.317950717644;4889.633277504201;5007.474215207423;5049.545540901337;5061.9746901266;3837.5394952605307;3882.5729169791302;3913.099987002948;3936.606339366098;4031.1937612477623;1200.4837919694442;1204.9698757531132;1206.6621346023128;1207.0343725020125;1217.6955761059735;840.7435732101645;878.1832895407205;889.9288056955428;963.0562049191831;966.2608104799833;6228.159198508234;6246.625202487865;6282.591631544026;6423.582467139714;6618.338166183343;1006.6677996261217;1038.7506998320348;1041.094248004226;1060.941648209356;1064.6539874540806;4104.938425923614;4148.274052040881;4182.205380977604;4201.70588058833;4316.805743741539;11178.161637877192;11450.312981221154;11510.424478776027;11616.361100139573;11620.53517859293;10811.135109191246;11117;11139.220254582102;11503.712407189887;11530.827037594443;8247;8345.582720863933;8391.118932511998;8391.538465384463;8431.494110353398;6231.470325022424;6345.619262844059;6373.74505019794;6430.839229019312;6479.935200647933;9938.751531211778;10345.068943795095;10456.215783816093;10534.894651053391;10566.577336906437;10339.431331276852;10372.533236004247;10439.843402348819;10460.738481538023;10585.259031867696;7071.222165561681;7716.189800070912;7781.455298129303;7958.403119765925;8013.799655008672;8837.91162088371;8882.555872206492;8920.776980575538;8946.507942063248;8977.23693486061;7662.961685191538;7923.484973476706;7966;8011.6394762237005;8100.149484304063;7854.136045035156;7961.482503637245;7974.122846486998;7986.962502242614;8057.355411567178;7087.043249161504;7185.461090418344;7195.496315257882;7201.027861238876;7202.855942881009;5030.170021946485;5113.872153196051;5301.946980530145;5376.462353764592;5415.377231618414;5239.502247286502;5318.228856815817;5386.622936394571;5500.614956953135;5505.284313039279 05:19:01 INFO - PROCESS | 3433 | |4;prototype.html;310.2182500099747;319.59251953758957;321.1521583020824;323.32909213382237;326.08533064753374;5449.128139497681;5456.290682211317;5584.804531841386;5652.802151924683;5661.829375549695;5304.336957880265;5435.456454354563;5441.646292990963;5460.836174914759;5469.917951230735;4288.356746488036;4296.97851510742;4310.59049390309;4323.697341186118;4329.870103896872;4165.146145040259;4287.249731297026;4297.59172878576;4307.6769242306955;4360.542143074979;4223.831046758126;4247.25673007224;4258.5308068716395;4259.978700106495;4288.206681763868;4255.87232383029;4271.124419494012;4281.207976524353;4306.892327691801;4327.0913108247305;3566.8216589170697;3683.594804571495;3687.59436461989;3688.7602305850032;3694.780722361614;5307.469253074701;5334.786608535693;5349.491798279158;5351.759170837322;5365.7585408656705;4846.7818948147415;4855.757212139414;4900.926486102711;4910.558049775537;4915.655904086715;5631.794155779371;5785.913211301834;5800.651960882361;5804.796832110856;5852.424933029453;4023.2355852387955;4056.8235211788547;4062.6749860011128;4082.7346222495444;4107.958920410817;5807.992485185208;6131.87736245277;6140.969295153541;6176.197094377747;6181.3509581493745;4114.938275925863;4138.937915931203;4149.211649786591;4159.147374788161;4173.686973476941;4224.556421575752;4248.640435060751;4270.996315865769;4274.5939135782055;4279.544954715412;4888.877778055577;4889.8216159496615;4902.1176188285735;4929.408470983433;4960.454350021495;5724.284464441945;5765.769369225184;5797.652140871562;5825.79609713658;5898.764049437975;1446.2118145610668;1456.155429850684;1467.449706360115;1472.49935022093;1472.5582325302366;895.471671713679;905.5970093308546;917.2799352508382;922.9538523073819;930.7580029192324;4996.275540046746;4998.850034498898;5001.499850015042;5005.74971251436;5045.772940217699;5334.946650533445;5339.492748188916;5342.759575819097;5353.598480114007;5359.196120581944;5011.248312753116;5046.596272298208;5096.745162741848;5277.706961794308;5719.542436605062;3220.5169224616025;3232.3858466891215;3248.951265731016;3270.394976929276;3278.4098862204555;6039.184710064085;6212.409821066992;6227.750889964351;6270.561060725797;6316.683741035993;6050.273967123973;6092.750986047849;6123.285480065589;6130.969345153246;6140.140380346755;6196.504279657616;6216.316205217422;6223.875522489525;6240.344763799736;6247.906281405873;5864.9413505864395;6094.268687757498;6100.847478813065;6108.328083910677;6124.663143527148;5950.940490595039;5958.582899197015;6000.789972350947;6024.216851809237;6049.122877182872;6041.214642096499;6247.875042499216;6308.52686048539;6316.589421687576;6362.6818659067785;4054.614811592894;4097;4119.485064366954;4123.422720819028;4153.584641535822;5848.4151584841175;5894.997850365534;6076.65254575988;6080.878382432238;6092.603980741238;5762.481376676119;5832.475077243069;5846.503047240862;5847.210626565359;5911.733971971185;5793.8551536211935;5805.564582656233;5806.2451881255165;5832.300123985149;5842.415758424124;5579.442055794388;5744.281964754406;5777.508911742549;5785.615414982282;5797.884042319046;5864.472197502245;5883.94116058834;5919.408059194218;5945.286565612154;5949.494292985145;5532.557395408277;5771.134329850556;5774.354309021908;5803.332616748959;5833.737481813413 05:19:01 INFO - PROCESS | 3433 | |5;yui.html;752.2928447259576;761.649641165064;773.9767806965793;818.153211426174;841.6465084664441;12389.876101238984;13105.934470327647;13663.521776737816;14192;14270.215138167398;14090.71818563628;14757.335919883604;14761.630959226024;14765;14802.111873287584;833.8874251975997;834.649447232164;837.9790505237387;841.2680967558202;845.0999685335098;823.3783493462428;826.6982551368767;829.5520418973747;830.6926437218237;833.3708050421953;866.2982983783156;868.9522076285801;872.9869051964225;873.4104479476359;875.1642181716445;854.3933806997039;870.5647176411794;871.6077765005709;874.5802015032788;879.0418443896184;623.8689875126229;626.7312329367672;628.3308276685361;629.232336549409;634.1565717595587;13047.151935124186;13095;13140.60578182656;13188.934055329757;13237;13134.671633209151;13851.16892986414;13895.444182232799;13954.232517211549;14189.716205675932;10612.950841670481;10871.945640271828;11162.776744465065;11214.158938079676;11391.487383067783;3741.120836603396;3775.8300876460626;3850.4224366344993;3968.3650615901606;3997.740146890472;57516;57714.71142644302;57891.71054144744;58012.419875801126;58098.12852807211;9829.705108846745;10023.599056037823;10136.797264054678;10143.442110683984;10257.33327333721;20777.896110519654;20792.688109678365;21073.26243581498;21084.156633734787;21132.894335528224;7977.242161994717;8068.435209535393;8094.959525202454;8167.795805104801;8323.375746819012;4509.833208862335;4605.976970115195;4612.192866248393;4622.329762184464;4624.052069325848;3429.8628054878022;3451.7928924264625;3486.1458942559234;3503.4569641705575;3530.435130379178;624.5628060357768;629.2511910826103;632.3992207402894;636.9649319855235;645.3643161485933;589.4076453164628;614.2199406753488;741.1958025542347;743.9367653749492;767.1484652036236;9331.813363732688;9468.715938521855;9623.422594644344;9703.12671859536;9885;657.4346062386344;665.6438805239173;716.2228981555071;734.775893352522;754.3889449545885;4094.28350038742;4285.678574106954;4357.607815296638;4369.75966321849;4393.714408563497;70445.29554704388;71160.64419677868;72671;74598;75341.24658753452;61737.691311544055;63633.68183159055;63688.68155659285;63697.363026369145;64547.67726161339;58447.41552584505;58505;59072.40927590755;59590;60097.699511502164;8974.326925480484;9011.2790976723;9016.90983090187;9094.454332740057;9098.727038188865;36401.817990909876;37857;38159.23681526409;39179.804100979316;39477.40783888302;48791.5120848787;50227.74886125546;50730;51072.744636276584;51651.23518378104;12397.442115105023;12481.93759031199;12498.687532811753;12717.427715752998;13203.735925281248;12559.37203139821;12972.870271297545;13106.868931310946;13779.517716879862;13811.654708632364;12554.560590379293;12780.872191277967;12984.220946743226;13087.280199589113;13183.604491865259;12009.519619215134;12152.878471215176;12165.695857603278;12431.31627760482;12793.8080928788;11248.493817778382;11713.472893719974;11715;12028.63914082579;12161.513539458323;9871.50642467888;9893.901060989298;9981.700548983543;10026.64906728261;10038.849417258893;10028.949855250678;10212.642557510451;10216.897831021595;10245.693137949253;10323.94838025835 05:19:01 INFO - PROCESS | 3433 | __end_tp_report 05:19:01 INFO - PROCESS | 3433 | __start_cc_report 05:19:01 INFO - PROCESS | 3433 | _x_x_mozilla_cycle_collect,350 05:19:01 INFO - PROCESS | 3433 | __end_cc_report 05:19:01 INFO - PROCESS | 3433 | __startTimestamp1464178741371__endTimestamp 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | ------- Summary: start ------- 05:19:01 INFO - PROCESS | 3433 | Number of tests: 6 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#0] dojo.html Cycles:165 Average:5393.70 Median:5548.00 stddev:618.27 (11.1%) stddev-sans-first:593.78 05:19:01 INFO - PROCESS | 3433 | Values: 3115.9 3118.0 3138.2 3146.0 3158.7 5377.1 5414.9 5423.9 5450.6 5464.7 5268.9 5377.2 5484.8 5501.0 5532.4 4907.5 4942.9 4982.8 5089.8 5123.6 4906.2 5134.7 5137.2 5140.5 5167.9 4882.7 4914.4 4940.1 4965.2 4972.1 4947.5 4954.8 4956.3 4957.8 4988.4 4911.9 4912.7 4928.1 4943.4 4972.6 5088.8 5191.9 5196.1 5243.2 5301.7 5783.9 5811.0 5821.5 5824.4 5835.2 5857.3 5859.5 5860.9 5867.6 5868.1 5228.1 5382.2 5420.4 5433.2 5451.8 5946.3 5961.0 5973.1 5983.9 5986.6 5716.8 5733.1 5744.1 5747.1 5770.4 5548.0 5719.3 5741.3 5801.0 5824.9 5542.7 5742.7 5774.0 5775.2 5810.0 5886.1 5905.9 5935.2 5950.8 5951.4 4277.7 4358.7 4369.3 4404.4 4472.4 3883.0 3926.4 3933.6 3960.3 3964.1 5500.2 5528.0 5535.1 5547.9 5556.3 5638.3 5846.1 5846.9 5849.1 5874.5 5557.7 5563.8 5581.3 5586.2 5587.4 4813.6 5070.5 5075.9 5090.2 5127.1 5995.0 6010.0 6023.8 6073.1 6084.5 5830.0 5872.8 5875.1 5905.7 5912.2 5840.4 5973.0 6045.9 6056.6 6067.3 5709.7 5770.6 5778.9 5799.4 5823.1 5779.1 5833.2 5874.9 5894.8 5910.0 5462.0 5615.7 5655.2 5678.1 5717.6 5521.6 5528.0 5572.6 5704.5 5767.5 5488.7 5496.3 5501.3 5504.9 5566.6 5522.6 5577.9 5614.9 5615.5 5622.3 5519.7 5529.2 5535.9 5538.5 5587.4 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#1] ext.html Cycles:180 Average:54501.27 Median:39438.31 stddev:108539.99 (275.2%) stddev-sans-first:108768.99 05:19:01 INFO - PROCESS | 3433 | Values: 587.5 624.3 639.8 661.0 674.4 36716.8 40558.4 40609.4 40692.2 40724.8 42190.6 42452.6 42507.1 42804.4 42978.6 8620.3 8736.1 8824.0 8828.4 8844.4 8640.7 8640.7 8679.9 8693.9 8743.9 8692.2 8779.3 8805.9 8806.2 8815.4 8636.4 8644.2 8678.2 8712.7 8733.8 8659.7 8778.2 8785.4 8792.9 8809.6 31412.4 38957.2 39407.0 39416.2 39529.8 3368.0 3534.9 3556.8 3615.9 3678.7 30664.8 30734.5 31093.0 31185.4 31903.2 3984.3 3987.9 4007.7 4174.7 4182.2 286660.0 288307.0 289891.0 291786.0 291856.0 33952.8 34190.8 34497.5 34686.3 35542.5 34885.5 35124.8 35179.1 35343.6 35488.4 14292.6 14401.8 14417.6 14418.5 14446.6 11710.8 11799.4 11841.9 11885.2 11902.6 8366.8 8437.3 8441.1 8512.2 8518.9 3235.1 3267.2 3289.2 3289.2 3301.3 1031.5 1060.2 1068.3 1125.5 1139.5 33033.3 33236.3 33489.0 33681.7 36003.6 1124.3 1152.8 1182.8 1203.7 1222.6 16622.2 16643.7 16715.2 16874.3 17030.4 501432.0 503213.0 508555.0 508597.0 510783.0 55061.0 55560.4 55641.4 55748.4 55810.0 1407.9 1412.1 1426.2 1442.9 1449.6 30051.2 31585.8 31767.2 31916.5 32082.7 49433.0 49991.5 50564.7 50608.5 50715.0 395519.0 399108.0 402277.0 404473.0 404604.0 27389.9 27403.0 27546.0 27601.9 27618.3 45221.3 46286.3 46688.3 46863.0 47862.8 39460.4 39703.6 40099.6 40597.0 40720.2 39570.2 39667.0 39803.0 39910.0 40810.4 39177.8 39710.4 42131.0 42286.0 44523.6 34058.8 37625.8 37790.4 37860.8 38147.6 28950.9 29059.3 29106.6 29258.4 29475.0 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#2] jquery.html Cycles:180 Average:26167.49 Median:22712.15 stddev:67044.80 (295.2%) stddev-sans-first:67204.94 05:19:01 INFO - PROCESS | 3433 | Values: 390.1 394.4 402.3 406.6 422.8 17791.8 18772.6 19386.7 19412.7 19415.3 18144.6 18180.9 18399.5 18995.9 19054.3 5233.9 5303.9 5477.8 5698.7 5711.7 5567.6 5579.8 5590.9 5595.5 5612.8 5446.8 5480.8 5577.9 5595.4 5619.3 5550.4 5560.4 5591.5 5618.2 5623.8 4800.9 4994.7 5008.0 5023.1 5028.2 22176.3 22415.2 23009.1 23250.7 23274.0 2308.7 2376.6 2389.2 2534.0 2683.9 14579.6 14644.6 14701.4 14739.1 14814.3 1900.6 1998.8 2033.3 2048.1 2054.2 58107.4 74658.0 76097.0 76321.0 77917.0 10314.9 10411.3 10703.1 10813.9 10909.6 14823.8 14868.2 14877.7 14892.5 15002.2 7729.6 8018.9 8044.4 8151.2 8221.9 7665.4 7716.4 7767.3 7829.6 7895.2 6556.9 6571.0 6581.4 6647.4 6661.8 1896.9 1941.2 1950.7 1976.8 1978.0 877.5 1028.9 1044.1 1060.2 1092.8 19365.4 19783.1 19788.6 19818.6 19934.8 1038.4 1078.3 1119.0 1128.2 1133.7 10919.2 11409.4 11421.1 11427.2 11469.0 401035.0 405924.0 406275.0 407750.0 409650.0 65865.3 81428.6 81544.6 81585.2 83070.6 1039.1 1048.1 1081.6 1090.2 1098.9 17244.0 17307.9 17607.2 17693.5 17775.3 41018.8 41843.6 42286.2 42346.4 42440.6 57741.4 59925.4 60071.7 60079.4 60508.4 7923.6 8126.6 8359.2 8393.9 8473.9 11417.3 11760.5 12333.9 12414.0 12991.4 11233.3 11265.6 11271.0 11455.6 11549.1 11301.1 11327.8 11365.7 11470.4 11578.2 11416.6 11592.5 11650.2 11680.8 11721.6 8143.6 8213.9 8222.3 8409.1 8514.1 10683.7 10714.4 11253.2 11262.4 11429.7 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#3] mootools.html Cycles:180 Average:5963.64 Median:4499.26 stddev:3414.41 (75.9%) stddev-sans-first:3407.47 05:19:01 INFO - PROCESS | 3433 | Values: 1494.8 1541.7 1720.3 1835.7 1848.4 7996.9 8823.0 8841.7 9365.7 9408.8 8884.7 9083.1 9183.0 9192.8 9201.2 2352.4 2371.3 2371.8 2376.7 2388.2 2309.2 2322.6 2379.8 2382.7 2383.8 2371.0 2378.3 2383.7 2400.0 2400.3 2287.6 2290.9 2317.2 2321.1 2322.2 2320.2 2326.8 2347.4 2350.4 2352.4 8945.6 9035.2 9038.1 9041.3 9056.0 5257.6 5411.6 5451.9 5490.3 5502.6 3368.9 3400.1 3473.8 3477.8 3478.2 1143.0 1182.6 1184.6 1188.7 1193.2 12888.5 12969.9 13012.5 13055.9 13075.1 4488.8 4509.8 4596.6 4610.3 4630.1 10063.2 10149.6 10187.5 10190.0 10191.5 5259.4 5284.6 5413.3 5444.1 5483.8 4400.3 4889.6 5007.5 5049.5 5062.0 3837.5 3882.6 3913.1 3936.6 4031.2 1200.5 1205.0 1206.7 1207.0 1217.7 840.7 878.2 889.9 963.1 966.3 6228.2 6246.6 6282.6 6423.6 6618.3 1006.7 1038.8 1041.1 1060.9 1064.7 4104.9 4148.3 4182.2 4201.7 4316.8 11178.2 11450.3 11510.4 11616.4 11620.5 10811.1 11117.0 11139.2 11503.7 11530.8 8247.0 8345.6 8391.1 8391.5 8431.5 6231.5 6345.6 6373.7 6430.8 6479.9 9938.8 10345.1 10456.2 10534.9 10566.6 10339.4 10372.5 10439.8 10460.7 10585.3 7071.2 7716.2 7781.5 7958.4 8013.8 8837.9 8882.6 8920.8 8946.5 8977.2 7663.0 7923.5 7966.0 8011.6 8100.1 7854.1 7961.5 7974.1 7987.0 8057.4 7087.0 7185.5 7195.5 7201.0 7202.9 5030.2 5113.9 5301.9 5376.5 5415.4 5239.5 5318.2 5386.6 5500.6 5505.3 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#4] prototype.html Cycles:180 Average:4850.36 Median:5438.55 stddev:1454.53 (26.7%) stddev-sans-first:1418.13 05:19:01 INFO - PROCESS | 3433 | Values: 310.2 319.6 321.2 323.3 326.1 5449.1 5456.3 5584.8 5652.8 5661.8 5304.3 5435.5 5441.6 5460.8 5469.9 4288.4 4297.0 4310.6 4323.7 4329.9 4165.1 4287.2 4297.6 4307.7 4360.5 4223.8 4247.3 4258.5 4260.0 4288.2 4255.9 4271.1 4281.2 4306.9 4327.1 3566.8 3683.6 3687.6 3688.8 3694.8 5307.5 5334.8 5349.5 5351.8 5365.8 4846.8 4855.8 4900.9 4910.6 4915.7 5631.8 5785.9 5800.7 5804.8 5852.4 4023.2 4056.8 4062.7 4082.7 4108.0 5808.0 6131.9 6141.0 6176.2 6181.4 4114.9 4138.9 4149.2 4159.1 4173.7 4224.6 4248.6 4271.0 4274.6 4279.5 4888.9 4889.8 4902.1 4929.4 4960.5 5724.3 5765.8 5797.7 5825.8 5898.8 1446.2 1456.2 1467.4 1472.5 1472.6 895.5 905.6 917.3 923.0 930.8 4996.3 4998.9 5001.5 5005.7 5045.8 5334.9 5339.5 5342.8 5353.6 5359.2 5011.2 5046.6 5096.7 5277.7 5719.5 3220.5 3232.4 3249.0 3270.4 3278.4 6039.2 6212.4 6227.8 6270.6 6316.7 6050.3 6092.8 6123.3 6131.0 6140.1 6196.5 6216.3 6223.9 6240.3 6247.9 5864.9 6094.3 6100.8 6108.3 6124.7 5950.9 5958.6 6000.8 6024.2 6049.1 6041.2 6247.9 6308.5 6316.6 6362.7 4054.6 4097.0 4119.5 4123.4 4153.6 5848.4 5895.0 6076.7 6080.9 6092.6 5762.5 5832.5 5846.5 5847.2 5911.7 5793.9 5805.6 5806.2 5832.3 5842.4 5579.4 5744.3 5777.5 5785.6 5797.9 5864.5 5883.9 5919.4 5945.3 5949.5 5532.6 5771.1 5774.4 5803.3 5833.7 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [#5] yui.html Cycles:180 Average:15893.17 Median:26707.78 stddev:19658.22 (73.6%) stddev-sans-first:19680.49 05:19:01 INFO - PROCESS | 3433 | Values: 752.3 761.6 774.0 818.2 841.6 12389.9 13105.9 13663.5 14192.0 14270.2 14090.7 14757.3 14761.6 14765.0 14802.1 833.9 834.6 838.0 841.3 845.1 823.4 826.7 829.6 830.7 833.4 866.3 869.0 873.0 873.4 875.2 854.4 870.6 871.6 874.6 879.0 623.9 626.7 628.3 629.2 634.2 13047.2 13095.0 13140.6 13188.9 13237.0 13134.7 13851.2 13895.4 13954.2 14189.7 10613.0 10871.9 11162.8 11214.2 11391.5 3741.1 3775.8 3850.4 3968.4 3997.7 57516.0 57714.7 57891.7 58012.4 58098.1 9829.7 10023.6 10136.8 10143.4 10257.3 20777.9 20792.7 21073.3 21084.2 21132.9 7977.2 8068.4 8095.0 8167.8 8323.4 4509.8 4606.0 4612.2 4622.3 4624.1 3429.9 3451.8 3486.1 3503.5 3530.4 624.6 629.3 632.4 637.0 645.4 589.4 614.2 741.2 743.9 767.1 9331.8 9468.7 9623.4 9703.1 9885.0 657.4 665.6 716.2 734.8 754.4 4094.3 4285.7 4357.6 4369.8 4393.7 70445.3 71160.6 72671.0 74598.0 75341.2 61737.7 63633.7 63688.7 63697.4 64547.7 58447.4 58505.0 59072.4 59590.0 60097.7 8974.3 9011.3 9016.9 9094.5 9098.7 36401.8 37857.0 38159.2 39179.8 39477.4 48791.5 50227.7 50730.0 51072.7 51651.2 12397.4 12481.9 12498.7 12717.4 13203.7 12559.4 12972.9 13106.9 13779.5 13811.7 12554.6 12780.9 12984.2 13087.3 13183.6 12009.5 12152.9 12165.7 12431.3 12793.8 11248.5 11713.5 11715.0 12028.6 12161.5 9871.5 9893.9 9981.7 10026.6 10038.8 10028.9 10212.6 10216.9 10245.7 10323.9 05:19:01 INFO - PROCESS | 3433 | -------- Summary: end -------- 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | [Child 3497] WARNING: pipe error (3): Connection reset by peer: file /builds/slave/fx-team-l64-pgo-00000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 315 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | ###!!! [Child][MessageChannel] Error: (msgtype=0x46010F,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | 05:19:01 INFO - PROCESS | 3433 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 05:19:01 INFO - PROCESS | 3433 | 05:19:02 INFO - TEST-INFO | 3433: exit 0 05:19:02 INFO - TEST-OK | dromaeo_css | took 1113226ms 05:19:02 INFO - TEST-START | kraken 05:19:02 INFO - operating with platform_type : linux_ 05:19:02 INFO - Initialising browser for kraken test... 05:19:02 INFO - TEST-INFO | started process 3674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzQ6077/profile http://localhost:59251/getInfo.html) 05:19:06 INFO - PROCESS | 3674 | 05:19:06 INFO - PROCESS | 3674 | (process:3742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:06 INFO - PROCESS | 3674 | __metrics Screen width/height:1600/1200 05:19:06 INFO - PROCESS | 3674 | colorDepth:24 05:19:06 INFO - PROCESS | 3674 | Browser inner width/height: 1024/697 05:19:06 INFO - PROCESS | 3674 | __metrics 05:19:07 ERROR - PROCESS | 3674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:19:08 INFO - TEST-INFO | 3674: exit 0 05:19:08 INFO - Browser initialized. 05:19:08 INFO - Running cycle 1/1 for kraken test... 05:19:08 INFO - TEST-INFO | started process 3793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzQ6077/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:10 INFO - PROCESS | 3793 | 05:19:10 INFO - PROCESS | 3793 | (process:3856): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:20 INFO - PROCESS | 3793 | RSS: Main: 164409344 05:19:20 INFO - PROCESS | 3793 | 05:19:22 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:23 INFO - PROCESS | 3793 | RSS: Main: 168943616 05:19:23 INFO - PROCESS | 3793 | 05:19:26 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-dft) 05:19:27 INFO - PROCESS | 3793 | RSS: Main: 169644032 05:19:27 INFO - PROCESS | 3793 | 05:19:29 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-fft) 05:19:30 INFO - PROCESS | 3793 | RSS: Main: 163962880 05:19:30 INFO - PROCESS | 3793 | 05:19:32 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-oscillator) 05:19:33 INFO - PROCESS | 3793 | RSS: Main: 164085760 05:19:33 INFO - PROCESS | 3793 | 05:19:35 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:36 INFO - PROCESS | 3793 | RSS: Main: 164442112 05:19:36 INFO - PROCESS | 3793 | 05:19:39 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:39 INFO - PROCESS | 3793 | RSS: Main: 164847616 05:19:39 INFO - PROCESS | 3793 | 05:19:43 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:43 INFO - PROCESS | 3793 | RSS: Main: 164474880 05:19:43 INFO - PROCESS | 3793 | 05:19:46 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59251/tests/kraken/driver.html?testName=json-parse-financial) 05:19:47 INFO - PROCESS | 3793 | RSS: Main: 164810752 05:19:47 INFO - PROCESS | 3793 | 05:19:48 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:49 INFO - PROCESS | 3793 | RSS: Main: 164577280 05:19:49 INFO - PROCESS | 3793 | 05:19:51 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:51 INFO - PROCESS | 3793 | RSS: Main: 164704256 05:19:51 INFO - PROCESS | 3793 | 05:19:53 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:54 INFO - PROCESS | 3793 | RSS: Main: 165650432 05:19:54 INFO - PROCESS | 3793 | 05:19:57 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:57 INFO - PROCESS | 3793 | RSS: Main: 165146624 05:19:57 INFO - PROCESS | 3793 | 05:20:00 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:01 INFO - PROCESS | 3793 | RSS: Main: 165273600 05:20:01 INFO - PROCESS | 3793 | 05:20:02 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59251/tests/kraken/driver.html?testName=ai-astar) 05:20:02 INFO - PROCESS | 3793 | RSS: Main: 166801408 05:20:02 INFO - PROCESS | 3793 | 05:20:02 INFO - PROCESS | 3793 | __start_tp_report 05:20:02 INFO - PROCESS | 3793 | _x_x_mozilla_page_load 05:20:02 INFO - PROCESS | 3793 | _x_x_mozilla_page_load_details 05:20:02 INFO - PROCESS | 3793 | |i|pagename|runs| 05:20:02 INFO - PROCESS | 3793 | |0;ai-astar;114;105;111;110;112;112;112;111;112;112 05:20:02 INFO - PROCESS | 3793 | |1;audio-beat-detection;155;133;160;193;126;160;157;128;185;128 05:20:02 INFO - PROCESS | 3793 | |2;audio-dft;163;160;162;161;161;164;173;163;162;165 05:20:02 INFO - PROCESS | 3793 | |3;audio-fft;74;74;74;165;75;77;74;75;167;78 05:20:02 INFO - PROCESS | 3793 | |4;audio-oscillator;84;86;144;83;84;84;139;84;84;135 05:20:02 INFO - PROCESS | 3793 | |5;imaging-gaussian-blur;117;117;117;120;118;118;117;118;118;117 05:20:02 INFO - PROCESS | 3793 | |6;imaging-darkroom;147;148;146;147;146;149;147;148;147;146 05:20:02 INFO - PROCESS | 3793 | |7;imaging-desaturate;96;95;97;95;96;95;96;96;94;96 05:20:02 INFO - PROCESS | 3793 | |8;json-parse-financial;58;55;61;56;56;56;57;82;53;62 05:20:02 INFO - PROCESS | 3793 | |9;json-stringify-tinderbox;63;62;61;63;62;61;61;61;62;62 05:20:02 INFO - PROCESS | 3793 | |10;stanford-crypto-aes;79;80;79;79;81;81;87;80;82;79 05:20:02 INFO - PROCESS | 3793 | |11;stanford-crypto-ccm;125;124;130;133;124;129;135;131;170;123 05:20:02 INFO - PROCESS | 3793 | |12;stanford-crypto-pbkdf2;162;163;157;164;164;158;159;164;169;156 05:20:02 INFO - PROCESS | 3793 | |13;stanford-crypto-sha256-iterative;62;65;67;64;63;63;63;65;67;62 05:20:02 INFO - PROCESS | 3793 | __end_tp_report 05:20:02 INFO - PROCESS | 3793 | __start_cc_report 05:20:02 INFO - PROCESS | 3793 | _x_x_mozilla_cycle_collect,845 05:20:02 INFO - PROCESS | 3793 | __end_cc_report 05:20:02 INFO - PROCESS | 3793 | __startTimestamp1464178802988__endTimestamp 05:20:02 INFO - PROCESS | 3793 | 05:20:02 INFO - PROCESS | 3793 | ------- Summary: start ------- 05:20:03 INFO - PROCESS | 3793 | Number of tests: 14 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.38 (2.1%) stddev-sans-first:2.28 05:20:03 INFO - PROCESS | 3793 | Values: 114.0 105.0 111.0 110.0 112.0 112.0 112.0 111.0 112.0 112.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:158.50 stddev:23.85 (15.0%) stddev-sans-first:25.28 05:20:03 INFO - PROCESS | 3793 | Values: 155.0 133.0 160.0 193.0 126.0 160.0 157.0 128.0 185.0 128.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.69 (2.3%) stddev-sans-first:3.91 05:20:03 INFO - PROCESS | 3793 | Values: 163.0 160.0 162.0 161.0 161.0 164.0 173.0 163.0 162.0 165.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#3] audio-fft Cycles:10 Average:93.30 Median:74.50 stddev:38.34 (51.5%) stddev-sans-first:40.03 05:20:03 INFO - PROCESS | 3793 | Values: 74.0 74.0 74.0 165.0 75.0 77.0 74.0 75.0 167.0 78.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.00 stddev:26.75 (31.9%) stddev-sans-first:27.69 05:20:03 INFO - PROCESS | 3793 | Values: 84.0 86.0 144.0 83.0 84.0 84.0 139.0 84.0 84.0 135.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 05:20:03 INFO - PROCESS | 3793 | Values: 117.0 117.0 117.0 120.0 118.0 118.0 117.0 118.0 118.0 117.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 05:20:03 INFO - PROCESS | 3793 | Values: 147.0 148.0 146.0 147.0 146.0 149.0 147.0 148.0 147.0 146.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 05:20:03 INFO - PROCESS | 3793 | Values: 96.0 95.0 97.0 95.0 96.0 95.0 96.0 96.0 94.0 96.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:57.50 stddev:8.32 (14.5%) stddev-sans-first:8.80 05:20:03 INFO - PROCESS | 3793 | Values: 58.0 55.0 61.0 56.0 56.0 56.0 57.0 82.0 53.0 62.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 05:20:03 INFO - PROCESS | 3793 | Values: 63.0 62.0 61.0 63.0 62.0 61.0 61.0 61.0 62.0 62.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.45 (3.0%) stddev-sans-first:2.52 05:20:03 INFO - PROCESS | 3793 | Values: 79.0 80.0 79.0 79.0 81.0 81.0 87.0 80.0 82.0 79.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:130.50 stddev:13.84 (10.6%) stddev-sans-first:14.42 05:20:03 INFO - PROCESS | 3793 | Values: 125.0 124.0 130.0 133.0 124.0 129.0 135.0 131.0 170.0 123.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:163.50 stddev:4.03 (2.5%) stddev-sans-first:4.28 05:20:03 INFO - PROCESS | 3793 | Values: 162.0 163.0 157.0 164.0 164.0 158.0 159.0 164.0 169.0 156.0 05:20:03 INFO - PROCESS | 3793 | 05:20:03 INFO - PROCESS | 3793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.85 (2.9%) stddev-sans-first:1.80 05:20:03 INFO - PROCESS | 3793 | Values: 62.0 65.0 67.0 64.0 63.0 63.0 63.0 65.0 67.0 62.0 05:20:03 INFO - PROCESS | 3793 | -------- Summary: end -------- 05:20:03 INFO - PROCESS | 3793 | 05:20:04 INFO - TEST-INFO | 3793: exit 0 05:20:04 INFO - TEST-OK | kraken | took 61984ms 05:20:04 INFO - SUITE-END | took 1175s 05:20:04 INFO - Completed test suite (00:19:35) 05:20:04 INFO - javascript benchmark 05:20:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7105.543449306072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.906522804316, 3118.0489950565084, 3138.1683853778736, 3145.9685403145963, 3158.7157155855975, 5377.085895397782, 5414.8917021659545, 5423.918641220384, 5450.618456708032, 5464.672119672822, 5268.920966185501, 5377.193420986854, 5484.8354549363585, 5501.037318469272, 5532.3637781655125, 4907.460179380265, 4942.87642808929, 4982.775775090112, 5089.821856235032, 5123.615728820353, 4906.239532872411, 5134.717590532519, 5137.2037334213255, 5140.485951404867, 5167.9483205168035, 4882.731449770261, 4914.3611330527165, 4940.086084074458, 4965.155923493015, 4972.105021096201, 4947.455779864212, 4954.826581069681, 4956.330895329156, 4957.801687932479, 4988.401391832967, 4911.926321105187, 4912.70523768575, 4928.088303663833, 4943.406791185081, 4972.602191824645, 5088.847334579968, 5191.935653191087, 5196.142636464979, 5243.161094224944, 5301.655392399521, 5783.942160578383, 5811.012127938261, 5821.50517206038, 5824.446677565625, 5835.241418615596, 5857.26784151981, 5859.472647461706, 5860.853478663025, 5867.618604790718, 5868.149118377854, 5228.137357336035, 5382.2464854920345, 5420.376656684492, 5433.1850222466555, 5451.781928722847, 5946.345901950782, 5961.0, 5973.133895585116, 5983.940160598426, 5986.640801551921, 5716.828495145152, 5733.1113677379235, 5744.052231381859, 5747.109198074305, 5770.394108618619, 5548.0, 5719.28508936383, 5741.25363702716, 5801.042827933428, 5824.883502330014, 5542.722863856791, 5742.6554406734895, 5774.047282198474, 5775.162601422854, 5810.041343178413, 5886.117082437583, 5905.940940590625, 5935.198748168942, 5950.761969521257, 5951.3751056139345, 4277.657787377065, 4358.694891357638, 4369.300911854151, 4404.405405270248, 4472.351509031172, 3882.990422490173, 3926.371780515104, 3933.6263055009726, 3960.3069462843887, 3964.0882597002274, 5500.1749737538885, 5528.0, 5535.114381698909, 5547.889042219133, 5556.305461817273, 5638.267025286768, 5846.093855452412, 5846.889091072682, 5849.093390524476, 5874.471297583238, 5557.694326811983, 5563.7774489019985, 5581.330240371181, 5586.245856809279, 5587.38538760736, 4813.614910807127, 5070.4929507049, 5075.9340538486595, 5090.2364645303505, 5127.102757017507, 5995.0, 6010.038393856962, 6023.789167379121, 6073.119397687311, 6084.5436592255755, 5830.0, 5872.823815285548, 5875.089361149029, 5905.704714764331, 5912.201852749824, 5840.415958404295, 5972.970135149297, 6045.879082418415, 6056.606320589148, 6067.332593414809, 5709.7430615623225, 5770.596058276048, 5778.913316300343, 5799.362070172362, 5823.097419899922, 5779.133130030361, 5833.212516310244, 5874.911876321944, 5894.823155305347, 5910.0, 5461.972690136524, 5615.691136987505, 5655.151727240782, 5678.063119585222, 5717.628354156966, 5521.641093328921, 5527.972360138174, 5572.582056345709, 5704.543636508986, 5767.480926716616, 5488.69812160319, 5496.31296087989, 5501.257330260363, 5504.889902202013, 5566.582506312124, 5522.6134170607675, 5577.944220557904, 5614.85962850932, 5615.522680572197, 5622.297212848394, 5519.724013799374, 5529.198266251291, 5535.892821435648, 5538.529225015919, 5587.385387607279], "value": 5351.637645135787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5152998776011, 624.2508989212945, 639.8176519691889, 660.9669516524174, 674.372833265064, 36716.816415917914, 40558.39162412559, 40609.390859137064, 40692.1861562769, 40724.796376018116, 42190.57809421905, 42452.57547424525, 42507.14985700284, 42804.35793463101, 42978.57021429785, 8620.267277281422, 8736.126387361277, 8824.0, 8828.42615230008, 8844.38089333747, 8640.740777776646, 8640.740777776677, 8679.869801952977, 8693.869591956125, 8743.868841967376, 8692.217700406994, 8779.297656187522, 8805.911940880605, 8806.20744133028, 8815.426997245191, 8636.39545231834, 8644.222020018196, 8678.218960293572, 8712.69505567302, 8733.825323493558, 8659.653613855438, 8778.209961103468, 8785.38502304839, 8792.912070879338, 8809.603567839462, 31412.37175256482, 38957.22085558273, 39407.0, 39416.21167576661, 39529.80235098806, 3368.0, 3534.91162720934, 3556.8399422026073, 3615.94576081359, 3678.6505281998166, 30664.8466757667, 30734.538981915288, 31093.0, 31185.376292474022, 31903.202419939687, 3984.2629113613784, 3987.9202415951518, 4007.6593489553425, 4174.666026717855, 4182.205380977604, 286660.0, 288307.0, 289891.0, 291785.9999999979, 291856.0, 33952.83023584916, 34190.829045855106, 34497.482537761956, 34686.306273874885, 35542.46686299708, 34885.476717849255, 35124.82437587796, 35179.120521987155, 35343.646563534036, 35488.40302186408, 14292.571222863331, 14401.78397324041, 14417.567472975827, 14418.495352662607, 14446.638834029234, 11710.76578468426, 11799.410029498491, 11841.940790296167, 11885.16803823724, 11902.571691396915, 8366.79083022917, 8437.282830959315, 8441.113683063313, 8512.191341822518, 8518.87221691675, 3235.142687187897, 3267.18320419895, 3289.161263877696, 3289.1777055736065, 3301.273719781644, 1031.4533297352416, 1060.173065009294, 1068.3269540189785, 1125.4654039331251, 1139.5043156226902, 33033.339333213204, 33236.335273294884, 33489.0, 33681.66318336834, 36003.63996360003, 1124.3197865291545, 1152.809786385237, 1182.8107502799683, 1203.7351782607811, 1222.5598784437595, 16622.168891555615, 16643.667126657398, 16715.16424178786, 16874.325026998784, 17030.403935862185, 501432.0, 503213.0, 508555.0, 508597.0, 510783.0, 55061.0, 55560.44439555633, 55641.44358556443, 55748.44251557514, 55810.0, 1407.92960351982, 1412.1244828206577, 1426.179946530749, 1442.898997070195, 1449.5506393018197, 30051.248718782204, 31585.8420707895, 31767.205819854687, 31916.49736184011, 32082.679173208904, 49433.0, 49991.50008500014, 50564.73588160326, 50608.493915060375, 50715.0, 395519.0, 399108.0, 402277.0, 404473.0, 404604.0, 27389.86305068462, 27403.04089356863, 27546.0, 27601.925297266756, 27618.309542260802, 45221.32168017548, 46286.30570541512, 46688.29967550422, 46863.0, 47862.76068619634, 39460.40809387919, 39703.60296396999, 40099.599004009586, 40597.0, 40720.185596287316, 39570.208595828495, 39667.0, 39803.0, 39910.0, 40810.38784418296, 39177.80411097926, 39710.42606165459, 42131.0, 42286.0, 44523.55476445194, 34058.82970585131, 37625.811870941565, 37790.43314350232, 37860.81069594635, 38147.61852381441, 28950.855245723636, 29059.273518161368, 29106.56340154857, 29258.41483170282, 29475.0], "value": 18274.268200503222, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.141688285771, 394.42807928503674, 402.31606269342126, 406.6157481180284, 422.8477399087487, 17791.822081779195, 18772.62454750904, 19386.70919936202, 19412.708809367872, 19415.320463783733, 18144.637107257848, 18180.90909545454, 18399.54001149972, 18995.90502047488, 19054.33309834156, 5233.8953220935555, 5303.867403314909, 5477.780888764445, 5698.743556539945, 5711.685857277848, 5567.638103523278, 5579.804706835262, 5590.888182236373, 5595.524380427669, 5612.7754889804355, 5446.782128714866, 5480.808171713991, 5577.944220557803, 5595.4124816894255, 5619.269494965649, 5550.389457159709, 5560.36055853578, 5591.496765291144, 5618.241537392461, 5623.80316688916, 4800.879978000543, 4994.675346102492, 5008.0, 5023.146065168893, 5028.220625803006, 22176.334709958726, 22415.215467458725, 23009.079636814506, 23250.65124023141, 23274.0, 2308.699869017034, 2376.619740841474, 2389.2473870730837, 2533.987330063338, 2683.8658067096762, 14579.562613121623, 14644.560663180122, 14701.411943522246, 14739.115653060851, 14814.333354999051, 1900.6388786130592, 1998.7601487821555, 2033.30867505049, 2048.1193086972594, 2054.219396629286, 58107.41892581105, 74658.0, 76097.0, 76321.0, 77917.0, 10314.896851031544, 10411.271211015308, 10703.1437485001, 10813.91860813928, 10909.618163364245, 14823.77764333536, 14868.182249976355, 14877.702445951238, 14892.478763243234, 15002.24988750558, 7729.5748733819055, 8018.919810801817, 8044.4368894178015, 8151.225633564802, 8221.917780822236, 7665.425093118039, 7716.4212684048925, 7767.339776119094, 7829.64766585505, 7895.171007044292, 6556.901646475307, 6571.0, 6581.440577550866, 6647.401733843977, 6661.767572999011, 1896.8767030142997, 1941.1944043222188, 1950.7073938908993, 1976.8023197680118, 1977.960440791176, 877.4954401219325, 1028.8662473878348, 1044.1385856668278, 1060.183658582887, 1092.814221582333, 19365.4190374289, 19783.10976006083, 19788.604227915363, 19818.60362792736, 19934.800651993293, 1038.4288641247435, 1078.336822853939, 1118.9720256993478, 1128.1707944660668, 1133.739239974794, 10919.181061420426, 11409.42952852354, 11421.086313094933, 11427.200095993201, 11469.025132863633, 401035.0, 405924.0, 406275.0, 407750.0, 409650.0, 65865.34134658592, 81428.59285703534, 81544.59227703942, 81585.18414815776, 83070.58464707638, 1039.1063685230695, 1048.0567489259727, 1081.5727787523883, 1090.2150451674781, 1098.8516550265613, 17244.0, 17307.913460432617, 17607.20767565437, 17693.469195924143, 17775.288988440316, 41018.79490602647, 41843.581564183965, 42286.15427691367, 42346.364804527344, 42440.57559424366, 57741.4225857736, 59925.40074599198, 60071.69964150151, 60079.399206009126, 60508.394916050274, 7923.643436045277, 8126.5936703163425, 8359.164083591835, 8393.916060839314, 8473.915260847312, 11417.257878237888, 11760.529578816751, 12333.93833030829, 12414.0, 12991.35043247815, 11233.269837460539, 11265.63491627228, 11271.0, 11455.59905403307, 11549.133814963743, 11301.09591232683, 11327.830082548604, 11365.715857103307, 11470.369129697947, 11578.189526733047, 11416.600418985628, 11592.478338474957, 11650.184487085822, 11680.76638467209, 11721.648350549498, 8143.633536490991, 8213.876791848008, 8222.301104405953, 8409.117042710672, 8514.148585141436, 10683.732906677084, 10714.410707411167, 11253.15601329887, 11262.436878155895, 11429.714257143638], "value": 9221.385104884896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7832564278176, 1541.6916616676665, 1720.277483456948, 1835.6971099768539, 1848.4454663600916, 7996.92003079969, 8823.0, 8841.734747957555, 9365.67220147295, 9408.81182376353, 8884.73345799627, 9083.091690830914, 9183.0, 9192.770180745485, 9201.17189452949, 2352.4236562042324, 2371.312319427364, 2371.7865392114704, 2376.738558758535, 2388.2357645553343, 2309.168699268262, 2322.6167682332393, 2379.8453100548495, 2382.65451509531, 2383.809295256375, 2371.027878569787, 2378.262738551046, 2383.6901202843605, 2399.992003358585, 2400.3039118655656, 2287.63397856343, 2290.942726431836, 2317.15423870287, 2321.0599707118645, 2322.222055611372, 2320.164740693349, 2326.8022218111482, 2347.3779448446176, 2350.424146084203, 2352.364861487406, 8945.59744811485, 9035.186833185046, 9038.096190380975, 9041.276697864156, 9056.0, 5257.631965762398, 5411.621186516945, 5451.918221226685, 5490.258815059956, 5502.642328248651, 3368.854589439578, 3400.1159698478327, 3473.7915725056578, 3477.8434970426138, 3478.2174010847357, 1142.9714257143555, 1182.5506307603055, 1184.6209213051827, 1188.6671731915078, 1193.224404137309, 12888.548900788428, 12969.87030129696, 13012.479500819956, 13055.86944130556, 13075.084744067919, 4488.775561221926, 4509.751963642031, 4596.609288210473, 4610.308453731967, 4630.120277147331, 10063.245256605784, 10149.594016239416, 10187.54156062979, 10190.031946965026, 10191.490425478845, 5259.368875734936, 5284.5772338212855, 5413.296271484682, 5444.101723215705, 5483.75323110461, 4400.317950717644, 4889.633277504201, 5007.474215207423, 5049.545540901337, 5061.9746901266, 3837.5394952605307, 3882.5729169791302, 3913.099987002948, 3936.606339366098, 4031.1937612477623, 1200.4837919694442, 1204.9698757531132, 1206.6621346023128, 1207.0343725020125, 1217.6955761059735, 840.7435732101645, 878.1832895407205, 889.9288056955428, 963.0562049191831, 966.2608104799833, 6228.159198508234, 6246.625202487865, 6282.591631544026, 6423.582467139714, 6618.338166183343, 1006.6677996261217, 1038.7506998320348, 1041.094248004226, 1060.941648209356, 1064.6539874540806, 4104.938425923614, 4148.274052040881, 4182.205380977604, 4201.70588058833, 4316.805743741539, 11178.161637877192, 11450.312981221154, 11510.424478776027, 11616.361100139573, 11620.53517859293, 10811.135109191246, 11117.0, 11139.220254582102, 11503.712407189887, 11530.827037594443, 8247.0, 8345.582720863933, 8391.118932511998, 8391.538465384463, 8431.494110353398, 6231.470325022424, 6345.619262844059, 6373.74505019794, 6430.839229019312, 6479.935200647933, 9938.751531211778, 10345.068943795095, 10456.215783816093, 10534.894651053391, 10566.577336906437, 10339.431331276852, 10372.533236004247, 10439.843402348819, 10460.738481538023, 10585.259031867696, 7071.222165561681, 7716.189800070912, 7781.455298129303, 7958.403119765925, 8013.799655008672, 8837.91162088371, 8882.555872206492, 8920.776980575538, 8946.507942063248, 8977.23693486061, 7662.961685191538, 7923.484973476706, 7966.0, 8011.6394762237005, 8100.149484304063, 7854.136045035156, 7961.482503637245, 7974.122846486998, 7986.962502242614, 8057.355411567178, 7087.043249161504, 7185.461090418344, 7195.496315257882, 7201.027861238876, 7202.855942881009, 5030.170021946485, 5113.872153196051, 5301.946980530145, 5376.462353764592, 5415.377231618414, 5239.502247286502, 5318.228856815817, 5386.622936394571, 5500.614956953135, 5505.284313039279], "value": 4756.901126431168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.2182500099747, 319.59251953758957, 321.1521583020824, 323.32909213382237, 326.08533064753374, 5449.128139497681, 5456.290682211317, 5584.804531841386, 5652.802151924683, 5661.829375549695, 5304.336957880265, 5435.456454354563, 5441.646292990963, 5460.836174914759, 5469.917951230735, 4288.356746488036, 4296.97851510742, 4310.59049390309, 4323.697341186118, 4329.870103896872, 4165.146145040259, 4287.249731297026, 4297.59172878576, 4307.6769242306955, 4360.542143074979, 4223.831046758126, 4247.25673007224, 4258.5308068716395, 4259.978700106495, 4288.206681763868, 4255.87232383029, 4271.124419494012, 4281.207976524353, 4306.892327691801, 4327.0913108247305, 3566.8216589170697, 3683.594804571495, 3687.59436461989, 3688.7602305850032, 3694.780722361614, 5307.469253074701, 5334.786608535693, 5349.491798279158, 5351.759170837322, 5365.7585408656705, 4846.7818948147415, 4855.757212139414, 4900.926486102711, 4910.558049775537, 4915.655904086715, 5631.794155779371, 5785.913211301834, 5800.651960882361, 5804.796832110856, 5852.424933029453, 4023.2355852387955, 4056.8235211788547, 4062.6749860011128, 4082.7346222495444, 4107.958920410817, 5807.992485185208, 6131.87736245277, 6140.969295153541, 6176.197094377747, 6181.3509581493745, 4114.938275925863, 4138.937915931203, 4149.211649786591, 4159.147374788161, 4173.686973476941, 4224.556421575752, 4248.640435060751, 4270.996315865769, 4274.5939135782055, 4279.544954715412, 4888.877778055577, 4889.8216159496615, 4902.1176188285735, 4929.408470983433, 4960.454350021495, 5724.284464441945, 5765.769369225184, 5797.652140871562, 5825.79609713658, 5898.764049437975, 1446.2118145610668, 1456.155429850684, 1467.449706360115, 1472.49935022093, 1472.5582325302366, 895.471671713679, 905.5970093308546, 917.2799352508382, 922.9538523073819, 930.7580029192324, 4996.275540046746, 4998.850034498898, 5001.499850015042, 5005.74971251436, 5045.772940217699, 5334.946650533445, 5339.492748188916, 5342.759575819097, 5353.598480114007, 5359.196120581944, 5011.248312753116, 5046.596272298208, 5096.745162741848, 5277.706961794308, 5719.542436605062, 3220.5169224616025, 3232.3858466891215, 3248.951265731016, 3270.394976929276, 3278.4098862204555, 6039.184710064085, 6212.409821066992, 6227.750889964351, 6270.561060725797, 6316.683741035993, 6050.273967123973, 6092.750986047849, 6123.285480065589, 6130.969345153246, 6140.140380346755, 6196.504279657616, 6216.316205217422, 6223.875522489525, 6240.344763799736, 6247.906281405873, 5864.9413505864395, 6094.268687757498, 6100.847478813065, 6108.328083910677, 6124.663143527148, 5950.940490595039, 5958.582899197015, 6000.789972350947, 6024.216851809237, 6049.122877182872, 6041.214642096499, 6247.875042499216, 6308.52686048539, 6316.589421687576, 6362.6818659067785, 4054.614811592894, 4097.0, 4119.485064366954, 4123.422720819028, 4153.584641535822, 5848.4151584841175, 5894.997850365534, 6076.65254575988, 6080.878382432238, 6092.603980741238, 5762.481376676119, 5832.475077243069, 5846.503047240862, 5847.210626565359, 5911.733971971185, 5793.8551536211935, 5805.564582656233, 5806.2451881255165, 5832.300123985149, 5842.415758424124, 5579.442055794388, 5744.281964754406, 5777.508911742549, 5785.615414982282, 5797.884042319046, 5864.472197502245, 5883.94116058834, 5919.408059194218, 5945.286565612154, 5949.494292985145, 5532.557395408277, 5771.134329850556, 5774.354309021908, 5803.332616748959, 5833.737481813413], "value": 4375.95176646774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2928447259576, 761.649641165064, 773.9767806965793, 818.153211426174, 841.6465084664441, 12389.876101238984, 13105.934470327647, 13663.521776737816, 14192.0, 14270.215138167398, 14090.71818563628, 14757.335919883604, 14761.630959226024, 14765.0, 14802.111873287584, 833.8874251975997, 834.649447232164, 837.9790505237387, 841.2680967558202, 845.0999685335098, 823.3783493462428, 826.6982551368767, 829.5520418973747, 830.6926437218237, 833.3708050421953, 866.2982983783156, 868.9522076285801, 872.9869051964225, 873.4104479476359, 875.1642181716445, 854.3933806997039, 870.5647176411794, 871.6077765005709, 874.5802015032788, 879.0418443896184, 623.8689875126229, 626.7312329367672, 628.3308276685361, 629.232336549409, 634.1565717595587, 13047.151935124186, 13095.0, 13140.60578182656, 13188.934055329757, 13237.0, 13134.671633209151, 13851.16892986414, 13895.444182232799, 13954.232517211549, 14189.716205675932, 10612.950841670481, 10871.945640271828, 11162.776744465065, 11214.158938079676, 11391.487383067783, 3741.120836603396, 3775.8300876460626, 3850.4224366344993, 3968.3650615901606, 3997.740146890472, 57516.0, 57714.71142644302, 57891.71054144744, 58012.419875801126, 58098.12852807211, 9829.705108846745, 10023.599056037823, 10136.797264054678, 10143.442110683984, 10257.33327333721, 20777.896110519654, 20792.688109678365, 21073.26243581498, 21084.156633734787, 21132.894335528224, 7977.242161994717, 8068.435209535393, 8094.959525202454, 8167.795805104801, 8323.375746819012, 4509.833208862335, 4605.976970115195, 4612.192866248393, 4622.329762184464, 4624.052069325848, 3429.8628054878022, 3451.7928924264625, 3486.1458942559234, 3503.4569641705575, 3530.435130379178, 624.5628060357768, 629.2511910826103, 632.3992207402894, 636.9649319855235, 645.3643161485933, 589.4076453164628, 614.2199406753488, 741.1958025542347, 743.9367653749492, 767.1484652036236, 9331.813363732688, 9468.715938521855, 9623.422594644344, 9703.12671859536, 9885.0, 657.4346062386344, 665.6438805239173, 716.2228981555071, 734.775893352522, 754.3889449545885, 4094.28350038742, 4285.678574106954, 4357.607815296638, 4369.75966321849, 4393.714408563497, 70445.29554704388, 71160.64419677868, 72671.0, 74598.0, 75341.24658753452, 61737.691311544055, 63633.68183159055, 63688.68155659285, 63697.363026369145, 64547.67726161339, 58447.41552584505, 58505.0, 59072.40927590755, 59590.0, 60097.699511502164, 8974.326925480484, 9011.2790976723, 9016.90983090187, 9094.454332740057, 9098.727038188865, 36401.817990909876, 37857.0, 38159.23681526409, 39179.804100979316, 39477.40783888302, 48791.5120848787, 50227.74886125546, 50730.0, 51072.744636276584, 51651.23518378104, 12397.442115105023, 12481.93759031199, 12498.687532811753, 12717.427715752998, 13203.735925281248, 12559.37203139821, 12972.870271297545, 13106.868931310946, 13779.517716879862, 13811.654708632364, 12554.560590379293, 12780.872191277967, 12984.220946743226, 13087.280199589113, 13183.604491865259, 12009.519619215134, 12152.878471215176, 12165.695857603278, 12431.31627760482, 12793.8080928788, 11248.493817778382, 11713.472893719974, 11715.0, 12028.63914082579, 12161.513539458323, 9871.50642467888, 9893.901060989298, 9981.700548983543, 10026.64906728261, 10038.849417258893, 10028.949855250678, 10212.642557510451, 10216.897831021595, 10245.693137949253, 10323.94838025835], "value": 6855.278712626846, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 111.0, 110.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 160.0, 193.0, 126.0, 160.0, 157.0, 128.0, 185.0, 128.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 161.0, 164.0, 173.0, 163.0, 162.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 165.0, 75.0, 77.0, 74.0, 75.0, 167.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 144.0, 83.0, 84.0, 84.0, 139.0, 84.0, 84.0, 135.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 120.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 146.0, 149.0, 147.0, 148.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 94.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 61.0, 56.0, 56.0, 56.0, 57.0, 82.0, 53.0, 62.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 81.0, 81.0, 87.0, 80.0, 82.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 130.0, 133.0, 124.0, 129.0, 135.0, 131.0, 170.0, 123.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 157.0, 164.0, 164.0, 158.0, 159.0, 164.0, 169.0, 156.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 67.0, 64.0, 63.0, 63.0, 63.0, 65.0, 67.0, 62.0], "value": 64.1, "unit": "score"}]}]} 05:20:04 INFO - Return code: 0 05:20:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:04 ERROR - # TBPL SUCCESS # 05:20:04 INFO - Running post-action listener: _resource_record_post_action 05:20:04 INFO - ##### 05:20:04 INFO - ##### Finished run-tests step (success) 05:20:04 INFO - ##### 05:20:04 INFO - Running post-run listener: _resource_record_post_run 05:20:04 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7847936; Write bytes: 465182720; Read time: 1840; Write time: 478748 05:20:04 INFO - TinderboxPrint: CPU usage
13.4% 05:20:04 INFO - TinderboxPrint: I/O read bytes / time
7,847,936 / 1,840 05:20:04 INFO - TinderboxPrint: I/O write bytes / time
465,182,720 / 478,748 05:20:04 INFO - TinderboxPrint: CPU idle
8,250.7 (86.6%) 05:20:04 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 05:20:04 INFO - TinderboxPrint: Swap in / out
0 / 0 05:20:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 18432000; Read time: 0; Write time: 18688 05:20:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6086656; Write bytes: 446750720; Read time: 1780; Write time: 460060 05:20:04 INFO - Running post-run listener: _upload_blobber_files 05:20:04 INFO - Blob upload gear active. 05:20:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:20:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:06 INFO - (blobuploader) - INFO - Done attempting. 05:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:10 INFO - (blobuploader) - INFO - Done attempting. 05:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:11 INFO - (blobuploader) - INFO - Done attempting. 05:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:11 INFO - Return code: 0 05:20:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4386b674b11024ecb608cd0b3f6343be2e54f7bb29b90d71b6881c89acda072abb7761a3d955520877a603c3c43e2aa0e7e2d4e8ae7c31b7e38db6f88ebf1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efca769249f6322bd448b1deeb6c43d676d29f18e95e1f8e02560044da2a863ca42b0df62a60e49e7069c5aecb82d5334643369ed2605e0caaa0874e6e38c492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f168e9906d68d58fbd55e203cef9fcd5b17262a7e223eb9f42dd73fb61cecb7c7a8c892536f22a9573895374f831d7402b246c74aa4de5ecf329794d9516b0e"} 05:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:11 INFO - Contents: 05:20:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4386b674b11024ecb608cd0b3f6343be2e54f7bb29b90d71b6881c89acda072abb7761a3d955520877a603c3c43e2aa0e7e2d4e8ae7c31b7e38db6f88ebf1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efca769249f6322bd448b1deeb6c43d676d29f18e95e1f8e02560044da2a863ca42b0df62a60e49e7069c5aecb82d5334643369ed2605e0caaa0874e6e38c492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f168e9906d68d58fbd55e203cef9fcd5b17262a7e223eb9f42dd73fb61cecb7c7a8c892536f22a9573895374f831d7402b246c74aa4de5ecf329794d9516b0e"} 05:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:11 INFO - Copying logs to upload dir... 05:20:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.582103 ========= master_lag: -0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-25 05:20:11.430035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:11.434021) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 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/4386b674b11024ecb608cd0b3f6343be2e54f7bb29b90d71b6881c89acda072abb7761a3d955520877a603c3c43e2aa0e7e2d4e8ae7c31b7e38db6f88ebf1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efca769249f6322bd448b1deeb6c43d676d29f18e95e1f8e02560044da2a863ca42b0df62a60e49e7069c5aecb82d5334643369ed2605e0caaa0874e6e38c492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f168e9906d68d58fbd55e203cef9fcd5b17262a7e223eb9f42dd73fb61cecb7c7a8c892536f22a9573895374f831d7402b246c74aa4de5ecf329794d9516b0e"} build_url:https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/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/4386b674b11024ecb608cd0b3f6343be2e54f7bb29b90d71b6881c89acda072abb7761a3d955520877a603c3c43e2aa0e7e2d4e8ae7c31b7e38db6f88ebf1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efca769249f6322bd448b1deeb6c43d676d29f18e95e1f8e02560044da2a863ca42b0df62a60e49e7069c5aecb82d5334643369ed2605e0caaa0874e6e38c492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f168e9906d68d58fbd55e203cef9fcd5b17262a7e223eb9f42dd73fb61cecb7c7a8c892536f22a9573895374f831d7402b246c74aa4de5ecf329794d9516b0e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:11.461623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:11.462226) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464177543.441252-719428373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:11.544278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:20:11.544723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:20:11.545073) ========= ========= Total master_lag: -0.17 =========