builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1466435040.47 results: success (0) buildid: 20160620053002 builduid: 2dc8763fb1a14871929aa723d8195914 revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.473068) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.473488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.473768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.487990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.488257) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 08:04:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-06-20 08:04:00 (88.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.571078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.571388) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.621115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:00.621452) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 08:04:01,011 truncating revision to first 12 chars 2016-06-20 08:04:01,011 Setting DEBUG logging. 2016-06-20 08:04:01,011 attempt 1/10 2016-06-20 08:04:01,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 08:04:01,415 unpacking tar archive at: fx-team-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.769872 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:01.510805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:01.511390) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:01.512292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:01.512984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:04:01.525411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-20 08:04:01.525740) ========= /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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:01 INFO - MultiFileLogger online at 20160620 08:04:01 in /builds/slave/test 08:04:01 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 08:04:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:01 INFO - {'append_to_log': False, 08:04:01 INFO - 'base_work_dir': '/builds/slave/test', 08:04:01 INFO - 'blob_upload_branch': 'Fx-Team', 08:04:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:01 INFO - 'branch': 'Fx-Team', 08:04:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:01 INFO - 'config_files': ('talos/linux_config.py',), 08:04:01 INFO - 'default_actions': ('clobber', 08:04:01 INFO - 'read-buildbot-config', 08:04:01 INFO - 'download-and-extract', 08:04:01 INFO - 'populate-webroot', 08:04:01 INFO - 'create-virtualenv', 08:04:01 INFO - 'install', 08:04:01 INFO - 'run-tests'), 08:04:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:01 INFO - 'download_minidump_stackwalk': True, 08:04:02 INFO - 'download_symbols': 'ondemand', 08:04:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:02 INFO - 'installer_path': 'installer.exe', 08:04:02 INFO - 'log_level': 'info', 08:04:02 INFO - 'log_name': 'talos', 08:04:02 INFO - 'log_to_console': True, 08:04:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:02 INFO - 'opt_config_files': (), 08:04:02 INFO - 'pip_index': False, 08:04:02 INFO - 'sps_profile': False, 08:04:02 INFO - 'sps_profile_interval': 0, 08:04:02 INFO - 'suite': 'dromaeojs-e10s', 08:04:02 INFO - 'system_bits': '32', 08:04:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:02 INFO - 'title': 'talos-linux64-ix-002', 08:04:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:02 INFO - 'use_talos_json': True, 08:04:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:02 INFO - 'work_dir': 'build'} 08:04:02 INFO - ##### 08:04:02 INFO - ##### Running clobber step. 08:04:02 INFO - ##### 08:04:02 INFO - Running pre-action listener: _resource_record_pre_action 08:04:02 INFO - Running main action method: clobber 08:04:02 INFO - rmtree: /builds/slave/test/build 08:04:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:02 INFO - Running post-action listener: _resource_record_post_action 08:04:02 INFO - ##### 08:04:02 INFO - ##### Finished clobber step (success) 08:04:02 INFO - ##### 08:04:02 INFO - ##### 08:04:02 INFO - ##### Running read-buildbot-config step. 08:04:02 INFO - ##### 08:04:02 INFO - Running pre-action listener: _resource_record_pre_action 08:04:02 INFO - Running main action method: read_buildbot_config 08:04:02 INFO - Using buildbot properties: 08:04:02 INFO - { 08:04:02 INFO - "project": "", 08:04:02 INFO - "product": "firefox", 08:04:02 INFO - "script_repo_revision": "production", 08:04:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:04:02 INFO - "repository": "", 08:04:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:04:02 INFO - "buildid": "20160620053002", 08:04:02 INFO - "pgo_build": "True", 08:04:02 INFO - "basedir": "/builds/slave/test", 08:04:02 INFO - "buildnumber": 844, 08:04:02 INFO - "slavename": "talos-linux64-ix-002", 08:04:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:04:02 INFO - "platform": "ubuntu64_hw", 08:04:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:04:02 INFO - "branch": "fx-team", 08:04:02 INFO - "repo_path": "integration/fx-team", 08:04:02 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 08:04:02 INFO - "stage_platform": "linux64-pgo", 08:04:02 INFO - "builduid": "2dc8763fb1a14871929aa723d8195914", 08:04:02 INFO - "slavebuilddir": "test" 08:04:02 INFO - } 08:04:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:04:02 INFO - Running post-action listener: _resource_record_post_action 08:04:02 INFO - ##### 08:04:02 INFO - ##### Finished read-buildbot-config step (success) 08:04:02 INFO - ##### 08:04:02 INFO - ##### 08:04:02 INFO - ##### Running download-and-extract step. 08:04:02 INFO - ##### 08:04:02 INFO - Running pre-action listener: _resource_record_pre_action 08:04:02 INFO - Running main action method: download_and_extract 08:04:02 INFO - mkdir: /builds/slave/test/build/tests 08:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:02 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:04:03 INFO - Downloaded 1361 bytes. 08:04:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:04:03 INFO - Using the following test package requirements: 08:04:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:04:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'jsshell-linux-x86_64.zip'], 08:04:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:03 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:04 INFO - Downloaded 24220838 bytes. 08:04:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:04:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:04:05 INFO - Return code: 0 08:04:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:05 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:06 INFO - Downloaded 24220838 bytes. 08:04:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:04:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:04:08 INFO - Return code: 0 08:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:08 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:04:09 INFO - Downloaded 14405384 bytes. 08:04:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:04:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:04:09 INFO - Return code: 0 08:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:09 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:04:10 INFO - Downloaded 60128070 bytes. 08:04:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:10 INFO - mkdir: /builds/slave/test/properties 08:04:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:10 INFO - Contents: 08:04:10 INFO - build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:11 INFO - Running post-action listener: _resource_record_post_action 08:04:11 INFO - Running post-action listener: set_extra_try_arguments 08:04:11 INFO - ##### 08:04:11 INFO - ##### Finished download-and-extract step (success) 08:04:11 INFO - ##### 08:04:11 INFO - ##### 08:04:11 INFO - ##### Running populate-webroot step. 08:04:11 INFO - ##### 08:04:11 INFO - Running pre-action listener: _resource_record_pre_action 08:04:11 INFO - Running main action method: populate_webroot 08:04:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:11 INFO - '--tppagecycles', 08:04:11 INFO - '7'], 08:04:11 INFO - 'tests': ['tsvgm']}}, 08:04:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:04:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['damp', 'tps']}, 08:04:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'tests': ['damp', 'tps']}, 08:04:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['dromaeo_dom']}, 08:04:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['basic_compositor_video']}, 08:04:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:04:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['a11yr', 08:04:11 INFO - 'ts_paint', 08:04:11 INFO - 'tpaint', 08:04:11 INFO - 'sessionrestore', 08:04:11 INFO - 'sessionrestore_no_auto_restore', 08:04:11 INFO - 'tabpaint']}, 08:04:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['tsvgx', 08:04:11 INFO - 'tsvgr_opacity', 08:04:11 INFO - 'tart', 08:04:11 INFO - 'tscrollx', 08:04:11 INFO - 'cart']}, 08:04:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:11 INFO - 'tsvgr_opacity', 08:04:11 INFO - 'tart', 08:04:11 INFO - 'tscrollx', 08:04:11 INFO - 'cart']}, 08:04:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'talos_options': ['--disable-e10s'], 08:04:11 INFO - 'tests': ['tp5o']}, 08:04:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'tests': ['tp5o']}, 08:04:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'talos_options': ['--disable-e10s', 08:04:11 INFO - '--xperf_path', 08:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:11 INFO - 'tests': ['tp5n']}, 08:04:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:11 INFO - 'talos_options': ['--xperf_path', 08:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:11 INFO - 'tests': ['tp5n']}}, 08:04:11 INFO - 'talos.zip': {'path': '', 08:04:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:11 INFO - Running post-action listener: _resource_record_post_action 08:04:11 INFO - ##### 08:04:11 INFO - ##### Finished populate-webroot step (success) 08:04:11 INFO - ##### 08:04:11 INFO - ##### 08:04:11 INFO - ##### Running create-virtualenv step. 08:04:11 INFO - ##### 08:04:11 INFO - Running pre-action listener: _resource_record_pre_action 08:04:11 INFO - Running main action method: create_virtualenv 08:04:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:11 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 08:04:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:04:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:11 INFO - Using real prefix '/usr' 08:04:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:14 INFO - Installing pip.................done. 08:04:14 INFO - Return code: 0 08:04:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:14 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')]} 08:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:14 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')]} 08:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:14 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:14 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 08:04:14 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 08:04:14 INFO - Using env: {'DISPLAY': ':0', 08:04:14 INFO - 'HOME': '/home/cltbld', 08:04:14 INFO - 'LANG': 'en_US.UTF-8', 08:04:14 INFO - 'LANGUAGE': 'en_US:en', 08:04:14 INFO - 'LOGNAME': 'cltbld', 08:04:14 INFO - 'MAIL': '/var/mail/cltbld', 08:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:14 INFO - 'MOZ_NO_REMOTE': '1', 08:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:14 INFO - 'NO_EM_RESTART': '1', 08:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:14 INFO - 'PWD': '/builds/slave/test', 08:04:14 INFO - 'SHELL': '/bin/bash', 08:04:14 INFO - 'SHLVL': '1', 08:04:14 INFO - 'TERM': 'linux', 08:04:14 INFO - 'TMOUT': '86400', 08:04:14 INFO - 'USER': 'cltbld', 08:04:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:14 INFO - '_': '/tools/buildbot/bin/python'} 08:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:14 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 08:04:14 INFO - Cleaning up... 08:04:14 INFO - Return code: 0 08:04:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04:14 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')]} 08:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:14 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')]} 08:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:14 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:14 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 08:04:14 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 08:04:14 INFO - Using env: {'DISPLAY': ':0', 08:04:14 INFO - 'HOME': '/home/cltbld', 08:04:14 INFO - 'LANG': 'en_US.UTF-8', 08:04:14 INFO - 'LANGUAGE': 'en_US:en', 08:04:14 INFO - 'LOGNAME': 'cltbld', 08:04:14 INFO - 'MAIL': '/var/mail/cltbld', 08:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:14 INFO - 'MOZ_NO_REMOTE': '1', 08:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:14 INFO - 'NO_EM_RESTART': '1', 08:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:14 INFO - 'PWD': '/builds/slave/test', 08:04:14 INFO - 'SHELL': '/bin/bash', 08:04:14 INFO - 'SHLVL': '1', 08:04:14 INFO - 'TERM': 'linux', 08:04:14 INFO - 'TMOUT': '86400', 08:04:14 INFO - 'USER': 'cltbld', 08:04:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:14 INFO - '_': '/tools/buildbot/bin/python'} 08:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:14 INFO - Downloading/unpacking psutil>=3.1.1 08:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:16 INFO - Installing collected packages: psutil 08:04:16 INFO - Running setup.py install for psutil 08:04:16 INFO - building 'psutil._psutil_linux' extension 08:04:16 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 08:04:16 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 08:04:16 INFO - building 'psutil._psutil_posix' extension 08:04:16 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 08:04:16 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 08:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:17 INFO - Successfully installed psutil 08:04:17 INFO - Cleaning up... 08:04:17 INFO - Return code: 0 08:04:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:17 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')]} 08:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:17 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')]} 08:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:17 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:17 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 08:04:17 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 08:04:17 INFO - Using env: {'DISPLAY': ':0', 08:04:17 INFO - 'HOME': '/home/cltbld', 08:04:17 INFO - 'LANG': 'en_US.UTF-8', 08:04:17 INFO - 'LANGUAGE': 'en_US:en', 08:04:17 INFO - 'LOGNAME': 'cltbld', 08:04:17 INFO - 'MAIL': '/var/mail/cltbld', 08:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:17 INFO - 'MOZ_NO_REMOTE': '1', 08:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:17 INFO - 'NO_EM_RESTART': '1', 08:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:17 INFO - 'PWD': '/builds/slave/test', 08:04:17 INFO - 'SHELL': '/bin/bash', 08:04:17 INFO - 'SHLVL': '1', 08:04:17 INFO - 'TERM': 'linux', 08:04:17 INFO - 'TMOUT': '86400', 08:04:17 INFO - 'USER': 'cltbld', 08:04:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:17 INFO - '_': '/tools/buildbot/bin/python'} 08:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:19 INFO - Installing collected packages: mozsystemmonitor 08:04:19 INFO - Running setup.py install for mozsystemmonitor 08:04:19 INFO - Successfully installed mozsystemmonitor 08:04:19 INFO - Cleaning up... 08:04:19 INFO - Return code: 0 08:04:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:19 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:19 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==2.5.1'] in /builds/slave/test/build 08:04:19 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==2.5.1 08:04:19 INFO - Using env: {'DISPLAY': ':0', 08:04:19 INFO - 'HOME': '/home/cltbld', 08:04:19 INFO - 'LANG': 'en_US.UTF-8', 08:04:19 INFO - 'LANGUAGE': 'en_US:en', 08:04:19 INFO - 'LOGNAME': 'cltbld', 08:04:19 INFO - 'MAIL': '/var/mail/cltbld', 08:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:19 INFO - 'MOZ_NO_REMOTE': '1', 08:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:19 INFO - 'NO_EM_RESTART': '1', 08:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:19 INFO - 'PWD': '/builds/slave/test', 08:04:19 INFO - 'SHELL': '/bin/bash', 08:04:19 INFO - 'SHLVL': '1', 08:04:19 INFO - 'TERM': 'linux', 08:04:19 INFO - 'TMOUT': '86400', 08:04:19 INFO - 'USER': 'cltbld', 08:04:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:19 INFO - '_': '/tools/buildbot/bin/python'} 08:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:19 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:21 INFO - warning: no files found matching '*.txt' 08:04:21 INFO - no previously-included directories found matching 'build' 08:04:21 INFO - no previously-included directories found matching 'dist' 08:04:21 INFO - no previously-included directories found matching '.git*' 08:04:21 INFO - Installing collected packages: jsonschema, functools32 08:04:21 INFO - Running setup.py install for functools32 08:04:21 INFO - warning: no files found matching '*.txt' 08:04:21 INFO - no previously-included directories found matching 'build' 08:04:21 INFO - no previously-included directories found matching 'dist' 08:04:21 INFO - no previously-included directories found matching '.git*' 08:04:21 INFO - Successfully installed jsonschema functools32 08:04:21 INFO - Cleaning up... 08:04:21 INFO - Return code: 0 08:04:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:21 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')]} 08:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:21 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')]} 08:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:21 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:21 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 08:04:21 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 08:04:21 INFO - Using env: {'DISPLAY': ':0', 08:04:21 INFO - 'HOME': '/home/cltbld', 08:04:21 INFO - 'LANG': 'en_US.UTF-8', 08:04:21 INFO - 'LANGUAGE': 'en_US:en', 08:04:21 INFO - 'LOGNAME': 'cltbld', 08:04:21 INFO - 'MAIL': '/var/mail/cltbld', 08:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:21 INFO - 'MOZ_NO_REMOTE': '1', 08:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:21 INFO - 'NO_EM_RESTART': '1', 08:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:21 INFO - 'PWD': '/builds/slave/test', 08:04:21 INFO - 'SHELL': '/bin/bash', 08:04:21 INFO - 'SHLVL': '1', 08:04:21 INFO - 'TERM': 'linux', 08:04:21 INFO - 'TMOUT': '86400', 08:04:21 INFO - 'USER': 'cltbld', 08:04:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:21 INFO - '_': '/tools/buildbot/bin/python'} 08:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:22 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 INFO - Downloading docopt-0.6.1.tar.gz 08:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:24 INFO - Running setup.py install for blobuploader 08:04:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:24 INFO - Running setup.py install for requests 08:04:25 INFO - Running setup.py install for docopt 08:04:25 INFO - Successfully installed blobuploader requests docopt 08:04:25 INFO - Cleaning up... 08:04:25 INFO - Return code: 0 08:04:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:25 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')]} 08:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:25 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')]} 08:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:25 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:25 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 08:04:25 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 08:04:25 INFO - Using env: {'DISPLAY': ':0', 08:04:25 INFO - 'HOME': '/home/cltbld', 08:04:25 INFO - 'LANG': 'en_US.UTF-8', 08:04:25 INFO - 'LANGUAGE': 'en_US:en', 08:04:25 INFO - 'LOGNAME': 'cltbld', 08:04:25 INFO - 'MAIL': '/var/mail/cltbld', 08:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:25 INFO - 'MOZ_NO_REMOTE': '1', 08:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:25 INFO - 'NO_EM_RESTART': '1', 08:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:25 INFO - 'PWD': '/builds/slave/test', 08:04:25 INFO - 'SHELL': '/bin/bash', 08:04:25 INFO - 'SHLVL': '1', 08:04:25 INFO - 'TERM': 'linux', 08:04:25 INFO - 'TMOUT': '86400', 08:04:25 INFO - 'USER': 'cltbld', 08:04:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:25 INFO - '_': '/tools/buildbot/bin/python'} 08:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:25 INFO - Running setup.py (path:/tmp/pip-iPgYI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:25 INFO - Running setup.py (path:/tmp/pip-qcIHt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:25 INFO - Running setup.py (path:/tmp/pip-Xl_MM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:25 INFO - Running setup.py (path:/tmp/pip-JaTBkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:25 INFO - Running setup.py (path:/tmp/pip-0I3fYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:25 INFO - Running setup.py (path:/tmp/pip-aVIrF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:26 INFO - Running setup.py (path:/tmp/pip-YlQQ2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:26 INFO - Running setup.py (path:/tmp/pip-MXrKQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:26 INFO - Running setup.py (path:/tmp/pip-hR5EOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:26 INFO - Running setup.py (path:/tmp/pip-aRrWUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:26 INFO - Running setup.py (path:/tmp/pip-RA2sfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:26 INFO - Running setup.py (path:/tmp/pip-7NnoSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:26 INFO - Running setup.py (path:/tmp/pip-aREcjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:26 INFO - Running setup.py (path:/tmp/pip-Ex2AGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:26 INFO - Running setup.py (path:/tmp/pip-8kIXOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:26 INFO - Running setup.py (path:/tmp/pip-Db6R7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:26 INFO - Running setup.py (path:/tmp/pip-IA_1Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:26 INFO - Running setup.py install for manifestparser 08:04:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:26 INFO - Running setup.py install for mozcrash 08:04:27 INFO - Running setup.py install for mozdebug 08:04:27 INFO - Running setup.py install for mozdevice 08:04:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for mozfile 08:04:27 INFO - Running setup.py install for mozhttpd 08:04:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for mozinfo 08:04:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for mozInstall 08:04:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for mozleak 08:04:27 INFO - Running setup.py install for mozlog 08:04:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for moznetwork 08:04:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:27 INFO - Running setup.py install for mozprocess 08:04:28 INFO - Running setup.py install for mozprofile 08:04:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:28 INFO - Running setup.py install for mozrunner 08:04:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:28 INFO - Running setup.py install for mozscreenshot 08:04:28 INFO - Running setup.py install for moztest 08:04:28 INFO - Running setup.py install for mozversion 08:04:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:28 INFO - Cleaning up... 08:04:28 INFO - Return code: 0 08:04:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:28 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:28 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 08:04:28 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 08:04:28 INFO - Using env: {'DISPLAY': ':0', 08:04:28 INFO - 'HOME': '/home/cltbld', 08:04:28 INFO - 'LANG': 'en_US.UTF-8', 08:04:28 INFO - 'LANGUAGE': 'en_US:en', 08:04:28 INFO - 'LOGNAME': 'cltbld', 08:04:28 INFO - 'MAIL': '/var/mail/cltbld', 08:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:28 INFO - 'MOZ_NO_REMOTE': '1', 08:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:28 INFO - 'NO_EM_RESTART': '1', 08:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:28 INFO - 'PWD': '/builds/slave/test', 08:04:28 INFO - 'SHELL': '/bin/bash', 08:04:28 INFO - 'SHLVL': '1', 08:04:28 INFO - 'TERM': 'linux', 08:04:28 INFO - 'TMOUT': '86400', 08:04:28 INFO - 'USER': 'cltbld', 08:04:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:28 INFO - '_': '/tools/buildbot/bin/python'} 08:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:28 INFO - Running setup.py (path:/tmp/pip-IoZgAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:28 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)) 08:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:28 INFO - Running setup.py (path:/tmp/pip-VSiXxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:29 INFO - Running setup.py (path:/tmp/pip-e6_4Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:29 INFO - Running setup.py (path:/tmp/pip-JYCQjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:29 INFO - Running setup.py (path:/tmp/pip-cjTRMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:29 INFO - Running setup.py (path:/tmp/pip-7wO2n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:29 INFO - Running setup.py (path:/tmp/pip-RzSW34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:29 INFO - Running setup.py (path:/tmp/pip-tyA8jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:29 INFO - Running setup.py (path:/tmp/pip-X7XZVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:29 INFO - Running setup.py (path:/tmp/pip-llhZYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:29 INFO - Running setup.py (path:/tmp/pip-hyEHeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:29 INFO - Running setup.py (path:/tmp/pip-pIdK3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:29 INFO - Running setup.py (path:/tmp/pip-yuV1Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:29 INFO - Running setup.py (path:/tmp/pip-ZweFcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:29 INFO - Running setup.py (path:/tmp/pip-TWleQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:29 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)) 08:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:29 INFO - Running setup.py (path:/tmp/pip-dx01JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:30 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)) 08:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:30 INFO - Running setup.py (path:/tmp/pip-tFkSoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:30 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)) 08:04:30 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)) 08:04:30 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)) 08:04:30 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)) 08:04:30 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)) 08:04:30 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)) 08:04:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:30 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 08:04:30 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 08:04:30 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 08:04:30 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 08:04:30 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 08:04:30 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 08:04:31 INFO - Downloading blessings-1.6.tar.gz 08:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:32 INFO - Installing collected packages: blessings 08:04:32 INFO - Running setup.py install for blessings 08:04:32 INFO - Successfully installed blessings 08:04:32 INFO - Cleaning up... 08:04:32 INFO - Return code: 0 08:04:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:32 INFO - Reading from file tmpfile_stdout 08:04:32 INFO - Current package versions: 08:04:32 INFO - argparse == 1.2.1 08:04:32 INFO - blessings == 1.6 08:04:32 INFO - blobuploader == 1.2.4 08:04:32 INFO - docopt == 0.6.1 08:04:32 INFO - functools32 == 3.2.3-2 08:04:32 INFO - jsonschema == 2.5.1 08:04:32 INFO - manifestparser == 1.1 08:04:32 INFO - mozInstall == 1.12 08:04:32 INFO - mozcrash == 0.17 08:04:32 INFO - mozdebug == 0.1 08:04:32 INFO - mozdevice == 0.48 08:04:32 INFO - mozfile == 1.2 08:04:32 INFO - mozhttpd == 0.7 08:04:32 INFO - mozinfo == 0.9 08:04:32 INFO - mozleak == 0.1 08:04:32 INFO - mozlog == 3.2 08:04:32 INFO - moznetwork == 0.27 08:04:32 INFO - mozprocess == 0.22 08:04:32 INFO - mozprofile == 0.28 08:04:32 INFO - mozrunner == 6.11 08:04:32 INFO - mozscreenshot == 0.1 08:04:32 INFO - mozsystemmonitor == 0.3 08:04:32 INFO - moztest == 0.7 08:04:32 INFO - mozversion == 1.4 08:04:32 INFO - psutil == 3.1.1 08:04:32 INFO - requests == 1.2.3 08:04:32 INFO - wsgiref == 0.1.2 08:04:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:32 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 08:04:32 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 08:04:32 INFO - Using env: {'DISPLAY': ':0', 08:04:32 INFO - 'HOME': '/home/cltbld', 08:04:32 INFO - 'LANG': 'en_US.UTF-8', 08:04:32 INFO - 'LANGUAGE': 'en_US:en', 08:04:32 INFO - 'LOGNAME': 'cltbld', 08:04:32 INFO - 'MAIL': '/var/mail/cltbld', 08:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:32 INFO - 'MOZ_NO_REMOTE': '1', 08:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:32 INFO - 'NO_EM_RESTART': '1', 08:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:32 INFO - 'PWD': '/builds/slave/test', 08:04:32 INFO - 'SHELL': '/bin/bash', 08:04:32 INFO - 'SHLVL': '1', 08:04:32 INFO - 'TERM': 'linux', 08:04:32 INFO - 'TMOUT': '86400', 08:04:32 INFO - 'USER': 'cltbld', 08:04:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:32 INFO - '_': '/tools/buildbot/bin/python'} 08:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 INFO - Cleaning up... 08:04:32 INFO - Return code: 0 08:04:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:32 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 08:04:32 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 08:04:32 INFO - Using env: {'DISPLAY': ':0', 08:04:32 INFO - 'HOME': '/home/cltbld', 08:04:32 INFO - 'LANG': 'en_US.UTF-8', 08:04:32 INFO - 'LANGUAGE': 'en_US:en', 08:04:32 INFO - 'LOGNAME': 'cltbld', 08:04:32 INFO - 'MAIL': '/var/mail/cltbld', 08:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:32 INFO - 'MOZ_NO_REMOTE': '1', 08:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:32 INFO - 'NO_EM_RESTART': '1', 08:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:32 INFO - 'PWD': '/builds/slave/test', 08:04:32 INFO - 'SHELL': '/bin/bash', 08:04:32 INFO - 'SHLVL': '1', 08:04:32 INFO - 'TERM': 'linux', 08:04:32 INFO - 'TMOUT': '86400', 08:04:32 INFO - 'USER': 'cltbld', 08:04:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:32 INFO - '_': '/tools/buildbot/bin/python'} 08:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:32 INFO - Cleaning up... 08:04:32 INFO - Return code: 0 08:04:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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 0x7fe19e738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', '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 08:04:32 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 08:04:32 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 08:04:32 INFO - Using env: {'DISPLAY': ':0', 08:04:32 INFO - 'HOME': '/home/cltbld', 08:04:32 INFO - 'LANG': 'en_US.UTF-8', 08:04:32 INFO - 'LANGUAGE': 'en_US:en', 08:04:32 INFO - 'LOGNAME': 'cltbld', 08:04:32 INFO - 'MAIL': '/var/mail/cltbld', 08:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:32 INFO - 'MOZ_NO_REMOTE': '1', 08:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:32 INFO - 'NO_EM_RESTART': '1', 08:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:32 INFO - 'PWD': '/builds/slave/test', 08:04:32 INFO - 'SHELL': '/bin/bash', 08:04:32 INFO - 'SHLVL': '1', 08:04:32 INFO - 'TERM': 'linux', 08:04:32 INFO - 'TMOUT': '86400', 08:04:32 INFO - 'USER': 'cltbld', 08:04:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:32 INFO - '_': '/tools/buildbot/bin/python'} 08:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:33 INFO - Downloading/unpacking flake8 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:35 INFO - no previously-included directories found matching 'docs/_build' 08:04:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:35 INFO - Running setup.py install for pep8 08:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:35 INFO - no previously-included directories found matching 'docs/_build' 08:04:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:04:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:35 INFO - Cleaning up... 08:04:35 INFO - Return code: 0 08:04:35 INFO - Running post-action listener: _resource_record_post_action 08:04:35 INFO - Running post-action listener: _start_resource_monitoring 08:04:36 INFO - Starting resource monitoring. 08:04:36 INFO - ##### 08:04:36 INFO - ##### Finished create-virtualenv step (success) 08:04:36 INFO - ##### 08:04:36 INFO - ##### 08:04:36 INFO - ##### Running install step. 08:04:36 INFO - ##### 08:04:36 INFO - Running pre-action listener: _resource_record_pre_action 08:04:36 INFO - Running main action method: install 08:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:36 INFO - Reading from file tmpfile_stdout 08:04:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:36 INFO - Reading from file tmpfile_stdout 08:04:36 INFO - Output received: 08:04:36 INFO - Usage: mozinstall [options] installer 08:04:36 INFO - Options: 08:04:36 INFO - -h, --help show this help message and exit 08:04:36 INFO - -d DEST, --destination=DEST 08:04:36 INFO - Directory to install application into. [default: 08:04:36 INFO - "/builds/slave/test"] 08:04:36 INFO - --app=APP Application being installed. [default: firefox] 08:04:36 INFO - mkdir: /builds/slave/test/build/application 08:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:04:53 INFO - Reading from file tmpfile_stdout 08:04:53 INFO - Output received: 08:04:53 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:53 INFO - Running post-action listener: _resource_record_post_action 08:04:53 INFO - ##### 08:04:53 INFO - ##### Finished install step (success) 08:04:53 INFO - ##### 08:04:53 INFO - ##### 08:04:53 INFO - ##### Running run-tests step. 08:04:53 INFO - ##### 08:04:53 INFO - Running pre-action listener: _resource_record_pre_action 08:04:53 INFO - Running main action method: run_tests 08:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:53 INFO - Python 2.7.3 08:04:53 INFO - Return code: 0 08:04:53 INFO - grabbing minidump binary from tooltool 08:04: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')]} 08:04:53 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 0x1ed81c0>, '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 0x1ed90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:53 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 08:04:53 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 08:04:53 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 08:04:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:53 INFO - Return code: 0 08:04:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:04:54 INFO - Return code: 0 08:04:54 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:04:54 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 08:04:54 INFO - Using env: {'DISPLAY': ':0', 08:04:54 INFO - 'HOME': '/home/cltbld', 08:04:54 INFO - 'LANG': 'en_US.UTF-8', 08:04:54 INFO - 'LANGUAGE': 'en_US:en', 08:04:54 INFO - 'LOGNAME': 'cltbld', 08:04:54 INFO - 'MAIL': '/var/mail/cltbld', 08:04:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:54 INFO - 'MOZ_NO_REMOTE': '1', 08:04:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:54 INFO - 'NO_EM_RESTART': '1', 08:04:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:54 INFO - 'PWD': '/builds/slave/test', 08:04:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:54 INFO - 'SHELL': '/bin/bash', 08:04:54 INFO - 'SHLVL': '1', 08:04:54 INFO - 'TERM': 'linux', 08:04:54 INFO - 'TMOUT': '86400', 08:04:54 INFO - 'USER': 'cltbld', 08:04:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924', 08:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:54 INFO - '_': '/tools/buildbot/bin/python'} 08:04:54 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:04:54 INFO - mozversion application_buildid: 20160620053002 08:04:54 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:04:54 INFO - mozversion application_display_name: Nightly 08:04:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:54 INFO - mozversion application_name: Firefox 08:04:54 INFO - mozversion application_remotingname: firefox 08:04:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:04:54 INFO - mozversion application_vendor: Mozilla 08:04:54 INFO - mozversion application_version: 50.0a1 08:04:54 INFO - mozversion platform_buildid: 20160620053002 08:04:54 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:04:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:04:54 INFO - mozversion platform_version: 50.0a1 08:04:54 INFO - using testdate: 1466435094 08:04:54 INFO - actual date: 1466435094 08:04:54 INFO - starting webserver on 'localhost:40136' 08:04:54 INFO - SUITE-START | Running 2 tests 08:04:54 INFO - TEST-START | dromaeo_css 08:04:54 INFO - operating with platform_type : linux_ 08:04:54 INFO - Initialising browser for dromaeo_css test... 08:04:54 INFO - TEST-INFO | started process 8546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCxIUfO/profile http://localhost:40136/getInfo.html) 08:04:59 INFO - PROCESS | 8546 | __metrics Screen width/height:1600/1200 08:04:59 INFO - PROCESS | 8546 | colorDepth:24 08:04:59 INFO - PROCESS | 8546 | Browser inner width/height: 1024/697 08:04:59 INFO - PROCESS | 8546 | __metrics 08:05:00 ERROR - PROCESS | 8546 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:05:01 INFO - TEST-INFO | 8546: exit 0 08:05:01 INFO - Browser initialized. 08:05:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:01 INFO - TEST-INFO | started process 8667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCxIUfO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:13 INFO - PROCESS | 8667 | RSS: Main: 184532992 08:05:13 INFO - PROCESS | 8667 | 08:06:02 INFO - PROCESS | 8667 | 1466435162725 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] 08:08:10 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40136/tests/dromaeo/cssquery-ext.html) 08:08:11 INFO - PROCESS | 8667 | RSS: Main: 189280256 08:08:11 INFO - PROCESS | 8667 | 08:11:13 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-ext.html (next: http://localhost:40136/tests/dromaeo/cssquery-jquery.html) 08:11:14 INFO - PROCESS | 8667 | RSS: Main: 187592704 08:11:14 INFO - PROCESS | 8667 | 08:14:16 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40136/tests/dromaeo/cssquery-mootools.html) 08:14:16 INFO - PROCESS | 8667 | RSS: Main: 188870656 08:14:16 INFO - PROCESS | 8667 | 08:17:18 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40136/tests/dromaeo/cssquery-prototype.html) 08:17:19 INFO - PROCESS | 8667 | RSS: Main: 186781696 08:17:19 INFO - PROCESS | 8667 | 08:20:21 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40136/tests/dromaeo/cssquery-yui.html) 08:20:22 INFO - PROCESS | 8667 | RSS: Main: 188719104 08:20:22 INFO - PROCESS | 8667 | 08:23:24 INFO - PROCESS | 8667 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-yui.html (next: http://localhost:40136/tests/dromaeo/cssquery-dojo.html) 08:23:25 INFO - PROCESS | 8667 | RSS: Main: 189734912 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | __start_tp_report 08:23:25 INFO - PROCESS | 8667 | _x_x_mozilla_page_load 08:23:25 INFO - PROCESS | 8667 | _x_x_mozilla_page_load_details 08:23:25 INFO - PROCESS | 8667 | |i|pagename|runs| 08:23:25 INFO - PROCESS | 8667 | |0;dojo.html;3109.580206672099;3116.7506599472044;3156.6685498022716;3171.191346206718;3173.20669832542;5418.647787893784;5446.618736688433;5447.863803404912;5556.249906262663;5579.944200558003;5435.728213589325;5436.320459942507;5481.725913704318;5515.448455154483;5544.86137846554;4914.827981020665;4939.728314942677;5034.748262586874;5083.415407228179;5116.386033675964;730.9995705132254;4998.125328067592;5046.44489106198;5060.7722652480725;5097.872553186163;4966.379202599675;4986.326845875815;4990.3762029746285;4993.425756038047;5055.165897626887;4927.77824997876;5020.171671674169;5022.974885125587;5046.596272298244;5066.442691303953;4927.679700819471;4960.627952903511;4992.076465853828;4996.500349965011;5000.174971129795;5463.31708536433;5526.309211348582;5576.553875689935;5583.3858275590055;5665.3768085510565;5855.033919403293;5935.287765468128;5992.820215393545;5996.760129594811;6014.12795144706;5980.820575382745;6002.099685047234;6018.337982821886;6042.6978651067275;6071.119687645267;5536.529395001429;5539.9169012464845;5546.556275497991;5552.805651802168;5555.166724991243;5859.824205273849;5995.2805663319805;6060.2727672678675;6063.181470501514;6116.174316467309;5860.472557469848;5863.237779088691;5864.824055278348;5868.119782032729;5877.647341159544;5950.7917222896995;5963.940360596425;5967.8209653710455;5975.25309336333;5988.221531201003;5742.3396309424115;5897.056470964711;5916.556258280646;5949.434803693643;5971.492423144082;5834.533237341003;5871.823845284648;5872.207252020922;5890.558208134407;5962.552808539377;4518;4522.321651752198;4523.570260825217;4541.3188021797;4572.771361431982;3943.290207762573;3952.9011774705286;3959.7228194026716;4005.919881602352;4044.090079732037;5619.634723742944;5691.658500489983;5694.857628559236;5704.80033198836;5709.885802283931;5887.35239123696;5953.255843019622;5956.880862382728;5961.701914904324;5961.731722072517;5613.10190369547;5617.634853734494;5671.376148623648;5686;5694.800681976111;5081.695098294114;5086.4659210783075;5096.796128154832;5097.413797413271;5105.758576975686;6003.279606447254;6126.36500017443;6147.477464415485;6153.784617538365;6160.8767824643255;5907.172995780594;5946.345901950868;5975.073863551156;6041.24484439445;6044.063170208625;6182.258129024546;6238.282597501346;6253.155823963707;6255.812325630239;6265.780697675559;5785.161151633074;5840.678762668094;5914.112883067574;5920.348761636131;5950.553708471968;5875.236219291465;5982.940170598413;5988.730507127103;5992.280926288873;6046.969765151146;5776.162456443876;5781.508571771278;5801.100829371286;5834;5834.649921004753;5644.548436125018;5692.7722891083895;5695.572832037531;5783.363829978614;5800.709964501673;5531.0873705839695;5535.8892822144135;5603.971980140073;5649.152627105967;5715.742791574306;5682.06245969427;5713.22871412354;5729.512991395778;5738.598298119092;5748.6838223898085;5550.888982220252;5567.387587365468;5602.831915042555;5614.101743720985;5615.859603509945 08:23:25 INFO - PROCESS | 8667 | |1;ext.html;572.050396342072;629.436654194496;647.2297965421149;650.0054915978551;653.0530730440862;36777.81611091948;41274.17451650965;41441.3783793243;41451;41578;41518.79240603793;41629.791851040776;41793.16413671732;41816.37275440871;41818.790906045426;8706.303495720344;8828.07305232951;8845.248153906925;8852.645894164225;8887.866681999743;8748.737537873874;8855.73432797017;8914.866277005818;8947.105289471066;8953.731388058368;8938.64245430182;8941.64233430662;8947.597358118901;8976.23701985332;9009.279257659371;8812.603432845506;8957.417767845101;8964.820703585958;8966.730998070068;8967.641294348217;8634.352423568258;8677.26243269323;8697.347698922544;8711.433756805787;8728.083551227093;39481.21037579261;39489.40765888514;39752.80123599363;39811.20377592461;39903;3366.208940898887;3610.6208848070837;3690.0590349460717;3722.1253005543676;3978.0054986253435;31874.840625796955;32057.358852823047;32247;32304;32893.34213315744;4437.112577484516;4438.160990743017;4464.906098006009;4480.596746292849;4522.4346956630425;320340;321188;321471;321970;322855.3857230722;33367;57129.714351427974;57179.71410142923;57365.42634573684;57802;34509.309813803586;36249.45625815615;36324.09189770277;36392.27215455729;36409.45385819215;13873.653158670912;14065.71868562623;14094.647633809236;14100.576982690536;14105.929470352583;11742.589009384801;11761.235519691363;11807.586734464252;11827.231229970024;11868.228565143238;8128.349732021424;8248.340132789363;8262.297704695047;8275.296599789086;8345.290650294794;3244.561984132159;3254.8698052077652;3255.104846167323;3267.2356927259016;3315.0386387947706;967.5791030901439;1003.4832061488339;1037.7924415117006;1072.217281384578;1123.230587047875;31177.532337014964;31664.841675791475;32088;32217.51673724896;32274.515882261785;1067.8611780468646;1084.2681190196586;1179.1745777955466;1185.4309931233056;1185.5968970549882;16301.184940753152;16935.830641693425;17144.39994600208;17186.828131718772;17200.397986070428;151329.2433537825;152095;153344;531743;541234;55929.720351397984;56332.15501767477;56590;56823.71588142116;57135;1300.3888172558882;1328.0504439325734;1334.2461509247244;1346.5255545178015;1353.472145863114;30086.24784380408;30991.380172396875;31500;31672.841635791672;31929.840350799026;49958;53357.4664253368;54741;54881;59479.70260148845;495162;495193;499427;499666;506502;27272;42107;42484;42624.57375426206;42821;47432.525674742814;47561.286580702006;47612.52387476081;48040;48380;39711.2057758849;40080.59919400885;40864;41587;41948.79025604852;39371.60628393794;40140;40279.59720402758;40681;41494.79252603718;35969.100772480895;39625.801870991614;40128;40233.1953360937;41048.38427423651;35546;36298.27403451969;36677;36789;37023.62976370202;27360.315992100357;27864.442711145257;28062;28154.43691126207;28249.57625635576 08:23:25 INFO - PROCESS | 8667 | |2;jquery.html;391.3444979659071;398.08043419700476;398.86239247459633;402.29598203144496;422.07354856090893;13807.861921380783;18015;18450.261989520404;19703;19765.110570024346;18757.842848072476;18849.340273090445;19189.32837350693;19513.121909514106;19576.706349404736;5570.108782594785;5654.717264136797;5794.536437085044;5812;5867.266591676041;5663.546916246691;5726.198332233491;5763.337216220126;5816.33112192097;5967;5983.58114931955;5994.430529099728;5999.970000150015;6014.548908831855;6027.186329845481;5833.3874943130995;5931.139984702216;5954.374790646984;5964.880702385928;6008.158857759917;5772.913406298909;5783.855403614902;5790;5795.159701843251;5801.7099145043;13461.932690336584;14198.716025679532;14225.288735563285;14229.430822767077;14271.429142834275;2276.3284830974903;2296.2307626944994;2299.7585253548473;2489.6887889013874;2789.0935445979935;10109.545070471773;10126.139278161365;10448.843267350996;10571.15430765537;10794.622188223375;1918.2806447582157;1989.094961792381;1991.9004049797452;2015.9697604535943;2035.2062695548748;76585.61707191484;77230.6138469304;77325.99999999943;78078;78280;10913.672589822318;11135.72160695989;11144.33134011962;11183.552657893593;11353.375564343874;15340.693186136437;15413;15488.767668484981;15489.380424782883;15533.611659708371;7325.157606875171;7424.443166762514;7448.292412220831;7475.6262186890435;7546;6947.826304342432;7031.507794454441;7128.322809333105;7164.785056448315;7199.316064973819;4806.206975849016;4829.492903245179;4836.226203807374;4851.320815085891;4853.369062021915;1932.9806701933082;1944.844412447029;1982.6184133066085;2031.6647753120865;2033.3391647714552;876.4983889361912;942.9387089839139;963.3978763272954;1018.89811018899;1025.0569476082023;19251.22995080209;19327;19467.31864384768;19502.31741889027;19735.506612334808;947.5404428852002;956.5695437053354;962.6823148361024;995.8307087794948;1036.533559898049;10825.296355736851;11010.48475891017;11166.888331116746;11196.832047519294;11265.887341126649;493445;495570;499587;508908;512093;78505.60747196342;79792.6010369956;81946;82559.5872020636;83619;997.910188083076;1007.1187710753092;1049.9422531760674;1058.2697938422464;1062.5324857062867;17731.64536709233;17942.641147177244;18213.54466138357;18273.99493027843;18517.90741046286;41486.58513414827;42116.15767684568;42691.57308426876;42845.78577107094;43996.34005489856;54172.729136354064;54327;57594.42405576058;63163.105106846866;63765.681171593846;8633.39566230358;8643.438176518506;8748.825023499621;8762.123787621187;8989.46063236208;9530.95234523823;13237.602871913858;13628.182309061489;13742.93128534351;14019.50931717385;11640.592579260025;12055.457504412498;12173.817392738938;12269;12279.508819647113;10038.498075096362;11667.474963626488;11678.30664553618;12027.097967652286;12146.089043321963;12044.578439754918;12098.818517722417;12121.515139394325;12586.307753073303;12604.243745375306;7714.305712485679;8738.21356077956;8774.956125219333;8843.07147749477;8988.505632190292;11666.358350290477;11944.64166075019;12250;12261.325627090238;12287 08:23:25 INFO - PROCESS | 8667 | |3;mootools.html;1440.8991370604056;1457.9271036448179;1493.133982290271;1651.3889860751524;1670.073109424269;7951.324137448324;8645.351598630097;8652.091530389305;9267.351285410025;9294.07059294071;8678.262347700438;8912.8663070054;8936.10638936106;9051.592678329474;9096.135867092615;2284.977150228493;2310.0413328468667;2323.1056043423237;2323.6863023491783;2333.346662934381;2316.455632926261;2341.4146463384154;2360.7403185649564;2375.58427275227;2380.7143142822883;2309.3418375762913;2323.825713071518;2338.4387746940697;2390.9043638254534;2401.95514950996;2263.388885001057;2285.994162568481;2286.0855657736956;2293.3005433342823;2297.9885100574475;2234.0505285253703;2238.373255488466;2241.1035585765662;2245.5733410651924;2246.6854640350366;9024;9046;9066.592003359865;9087.273018158532;9150.084991500864;5173.948260517422;5368.758405871745;5413.891722165574;5423.2949716537;5438.374586922515;3256.267339848539;3299.092749493884;3455.8963231102857;3459.896203113911;3471.9652803471895;1143.9428028598536;1146.0774076868117;2184.5084855907453;2229.375774783063;2241.68616393705;11533.423328833525;11552.711182220428;11566.47950842214;11600.941995290053;11602.303861768321;4384.890377740582;4472.552744725502;4511.88720281989;4525.683202175882;4545.863534116471;9864.408135511892;9868.062534059252;9884.901150988542;9888.456134912649;9922.355046922072;5019.272205530177;5059.468755780664;5071.8985620287385;5120.48795120485;5121.923171152435;4407.977960110179;4674.228752255908;4692.694974826625;4800.639952003614;4808.447028591687;3735.234276973268;3761.39817629178;3837.213371258885;3837.9424308635394;3843.3466310727244;1128.4301427779083;1147.6384938744268;1157.8089615213564;1161.0421402343102;1161.7269941563725;839.0141583639321;890.1943740914353;899.150302963693;917.2707697380598;923.1599244687302;5703.771849126071;5733.283339582552;5759.712014399263;5834.358220595731;6165.84585385369;961.5192403798101;980.152168374351;993.3592832622918;1001.9699409017741;1017.4556612212431;4142.109446469024;4228.9154216915485;4256.616904478612;4271.402003719481;4286.39990401344;11145.442727863574;11399.658010259705;11408.087353011739;11452.255603385753;11486.253393529394;10041.799164016678;11020.393878336768;11042.061424778984;11171.162162837658;11352.602658906899;8234.958825205835;8301.709440169565;8337.791555211046;8354.540500272666;8385.6226469809;5549.417311182267;5592.3009623797025;5623.044082505902;5669.121286200645;5803.709814509173;9944.45305508175;9959.203263739028;9962.402255864672;10039;10131.13885319756;9964.302498825013;10332.948335258576;10333.328333658288;10595.629152979609;10773.299735517166;7139.428845692436;7260.2739726026975;7490.475666703279;7572.167061623327;7752.728654497066;8499.235068843835;8529.530875801891;8631.136886311318;8772.868406973774;8775.473471591726;7361.668724907499;7593.354564861827;7635.503692259986;7672.347850432776;7785.610719464117;7540.434467414856;7666.348360389429;7716.7684969451;7717.57553334572;7739.496932699357;7064.576125432491;7083;7106.751263705745;7128.501004929605;7130.358267755927;5085.92371114441;5154.278401023785;5229.581633469389;5276.736163191902;5279.445658205833;4889.413270407574;4976.975115124401;5027.522385373383;5060.418051924076;5092.134337162765 08:23:25 INFO - PROCESS | 8667 | |4;prototype.html;332.9346092503987;333.7480202447152;336.08249478922534;336.6818356652964;338.7865644643874;5564.443555644439;5655.434456554352;5705.058665320223;5711.914321285179;5730.3123625165035;5536.446355364472;5564.610477266593;5568.413002294347;5592.916106258399;5656.547476201904;4133.297339452292;4233.518268605979;4358.4309648526505;4373.497047839492;4381.53993830648;4350.477942646887;4389.363542286366;4391.890202744941;4392.714473559208;4396.20868243716;4358.368036634686;4380.627646650023;4407.2948328267485;4429.092036132585;4430.867073987785;4318.114786468766;4330.372096046056;4407.757573333465;4415.359772832921;4428.844990425352;3851.881465194132;3852.306584814732;3893.1629699614437;3909.7849618270984;3923.195744872294;5489.862753431156;5547.25112109868;5558.972205138948;5562.221289019541;5572.804951826707;4866.9513304867205;4954.87612809679;4984.950150498485;5048.596112311006;5087.236914462823;5833.533317334603;5854.5023672987845;5871.8532036699;5896.557758168155;5946.494547963428;4214.831406743727;4259.70182087254;4261.488621365425;4284.935725964113;4296.312589985588;5889.2921052895035;5988.520918326523;6023.223149171005;6145.569810113294;6157.322694503601;4326.913461730811;4337.8264869404875;4339.1972485090355;4347.369736348869;4355.891102722394;4391.231534481453;4413.58070983256;4429.667774916894;4438.933415998763;4440.555944405533;4908.8772780680765;4985.426675932242;4992.475790041994;5002.89994200114;5003.749812509433;5767.971160144172;5871.823845284648;5874;5894.938910996062;5982.341942386334;1481.5185064853965;1515.9848401516065;1538.4461593826213;1544.8918575699593;1548.8373720759384;962.5235508423235;969.9524513525375;986.225812736998;1028.5834237133972;1047.3925123428546;5631.183478395692;5633.436656334334;5668.829935101953;5682.488576028178;5695.829125126253;5960.433758792908;5967.523477756769;5975.103734439782;6003.849903752441;6041.24484439445;5470.781168753205;5673.631213971079;5770.5573606598355;5805.593608447452;5817;3244.464663330524;3256.251062255647;3262.885798997024;3265.559149514833;3279.721223695965;6127.5404344674325;6231.906521402183;6267.749290028348;6333;6334.144890439824;6186;6197.628142311476;6213.5339849511465;6228.065790131516;6232.719527621268;5993.580449368503;6221.595596286227;6279.717412716439;6295.874082518324;6312.664314203774;6051.1830902829315;6061.939160646957;6078.209832721718;6085.383285187412;6100.786472473442;6004.969975150097;6010.8497287566415;6017.548683848641;6037.909431358621;6041.758329666764;6045.637261764308;6183.443490085734;6224.533160013108;6229.813105606839;6306.959351706917;4143.316352801754;4152.294110001247;4210.915781684411;4250.489941207075;4255.680823938279;5804.94195058044;6134.386561344008;6143.170671959407;6155.261368635793;6170;5847.970760146172;5880.970595147168;5890.085722140236;5908.493334199751;5916.7041647918295;5794.449527294901;5852.94147058524;5862.355140934408;5862.3844496328975;5868.94131058701;5573.832785016456;5755;5788.305403351625;5877.676727780014;5887.61730487517;6004.909926351195;6005.978983572891;6023.367546407564;6033;6053.365591290239;5562.638428502134;5668;5791.218185545066;5858.882822343444;5875.3243377010485 08:23:25 INFO - PROCESS | 8667 | |5;yui.html;702.8980797784325;748.1994266135238;765.2385876053328;795.113448504917;842.0568962761706;13455.259960702157;14112.92943535281;14500.347484363203;14521.273936303181;14724.6318842029;13170.407331670074;13495.595132146027;13550.119242249248;13556.389962451689;13565.982551308667;760.4372764154541;765.223298352173;772.3396495995927;774.3224678406394;787.1498781316193;771.8340556780291;772.4438404348859;773.0414286284994;773.5668025905483;777.1761932351696;802.3060053054124;804.7263930263709;809.134226377776;810.8337790752911;813.2436833744615;805.730080423059;810.9148539403336;811.7443005453264;813.5484805932705;814.0800894988655;587.4184557288254;588.9322727886263;589.0957380421075;589.855485406074;592.0734051209886;14211.573652790434;14251.78622320666;14317.856821431757;14376.712465750627;14418.495352662607;14401.279936003159;14414.207218602973;14533.70932581353;14655.34050967709;14839.332230049673;12290.385480726018;12353.38233088342;12492.375381230902;12604.621861344174;12703.110782245247;3863.8454461821493;3890.5720370759195;3896.1428485733095;3930.3121953658283;4012.819423125937;76256.23743762547;79662.20337796606;79847.20152798455;80007.19992800055;81273.59363203205;10141.797164056678;10431.791364172674;10784.514696838662;10908.400037997828;10992.725181870517;21533.78466215349;21555.137794488044;21581.892090539448;21683.56632867334;22073.668894966588;8477.152284771473;8631.913680863237;8667.089955554702;8705.173008564176;8791.912080879238;4797.304390863305;4817.542333478314;4843.878903027453;4852.8544143675745;4943.456219815817;3364.9327013459592;3468.0809585459874;3483.198864261234;3486.0239133042787;3493.4934434506854;590.4980766348655;595.4045954045954;600.0968542343745;609.2049874913281;613.7821073518926;608.3490664988508;671.7279501801778;708.879969647955;712.1916624630977;789.4907784478979;9394.765130871783;9581.233501320017;9697.078777516124;10118.747031324276;10223.967858963248;705.4955706669756;743.193634906122;765.3494529649864;766.4060353226183;789.5144486140982;4891.804327826847;4900.460949295574;4921.581665558396;4954.455009948902;4989.027139707795;114744;114977.4251128739;117976;121544;121828;98100.50949745206;99358;99904;100186.49906750419;100310;88565;89689.17020393653;90495.09504904998;91216.08783912209;91879.54060229656;9544.665936692183;9694.418334899929;9761.170300524534;9781.902180978099;9820.558074886505;50031.24953125633;52937;53996.73001634967;54875.5124487548;55120.72439637776;75981;77014;79267.20732792598;79687.60156199182;80461.19538804537;11336.716582085184;11424.200305978502;11463.770724585629;11521.423928803693;11931.164818462625;12957.805632915703;13063.346832658139;13770.104943178661;13892.60776301828;13965.371558280105;12362.3818809061;13293.867061329263;13728.519501817389;13762.24307663048;13817.516386926409;12231.449584768528;12774.23354598727;12875.420606072561;13394.129381590166;13744.244066576433;13000.284984325575;13034;13182.538611148948;13316.40076196554;13429.328533573087;10430.843537347098;10675.51960161779;10807.297525660806;10878.12974962017;10883.945580272048;10251.84622230682;10255.179585632983;10464.476776161313;10535.20985926074;10550.525226364985 08:23:25 INFO - PROCESS | 8667 | __end_tp_report 08:23:25 INFO - PROCESS | 8667 | __start_cc_report 08:23:25 INFO - PROCESS | 8667 | _x_x_mozilla_cycle_collect,371 08:23:25 INFO - PROCESS | 8667 | __end_cc_report 08:23:25 INFO - PROCESS | 8667 | __startTimestamp1466436205043__endTimestamp 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | ------- Summary: start ------- 08:23:25 INFO - PROCESS | 8667 | Number of tests: 6 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#0] dojo.html Cycles:165 Average:5472.26 Median:5694.80 stddev:743.25 (13.1%) stddev-sans-first:722.05 08:23:25 INFO - PROCESS | 8667 | Values: 3109.6 3116.8 3156.7 3171.2 3173.2 5418.6 5446.6 5447.9 5556.2 5579.9 5435.7 5436.3 5481.7 5515.4 5544.9 4914.8 4939.7 5034.7 5083.4 5116.4 731.0 4998.1 5046.4 5060.8 5097.9 4966.4 4986.3 4990.4 4993.4 5055.2 4927.8 5020.2 5023.0 5046.6 5066.4 4927.7 4960.6 4992.1 4996.5 5000.2 5463.3 5526.3 5576.6 5583.4 5665.4 5855.0 5935.3 5992.8 5996.8 6014.1 5980.8 6002.1 6018.3 6042.7 6071.1 5536.5 5539.9 5546.6 5552.8 5555.2 5859.8 5995.3 6060.3 6063.2 6116.2 5860.5 5863.2 5864.8 5868.1 5877.6 5950.8 5963.9 5967.8 5975.3 5988.2 5742.3 5897.1 5916.6 5949.4 5971.5 5834.5 5871.8 5872.2 5890.6 5962.6 4518.0 4522.3 4523.6 4541.3 4572.8 3943.3 3952.9 3959.7 4005.9 4044.1 5619.6 5691.7 5694.9 5704.8 5709.9 5887.4 5953.3 5956.9 5961.7 5961.7 5613.1 5617.6 5671.4 5686.0 5694.8 5081.7 5086.5 5096.8 5097.4 5105.8 6003.3 6126.4 6147.5 6153.8 6160.9 5907.2 5946.3 5975.1 6041.2 6044.1 6182.3 6238.3 6253.2 6255.8 6265.8 5785.2 5840.7 5914.1 5920.3 5950.6 5875.2 5982.9 5988.7 5992.3 6047.0 5776.2 5781.5 5801.1 5834.0 5834.6 5644.5 5692.8 5695.6 5783.4 5800.7 5531.1 5535.9 5604.0 5649.2 5715.7 5682.1 5713.2 5729.5 5738.6 5748.7 5550.9 5567.4 5602.8 5614.1 5615.9 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#1] ext.html Cycles:180 Average:53522.39 Median:40134.00 stddev:106864.15 (266.3%) stddev-sans-first:107089.98 08:23:25 INFO - PROCESS | 8667 | Values: 572.1 629.4 647.2 650.0 653.1 36777.8 41274.2 41441.4 41451.0 41578.0 41518.8 41629.8 41793.2 41816.4 41818.8 8706.3 8828.1 8845.2 8852.6 8887.9 8748.7 8855.7 8914.9 8947.1 8953.7 8938.6 8941.6 8947.6 8976.2 9009.3 8812.6 8957.4 8964.8 8966.7 8967.6 8634.4 8677.3 8697.3 8711.4 8728.1 39481.2 39489.4 39752.8 39811.2 39903.0 3366.2 3610.6 3690.1 3722.1 3978.0 31874.8 32057.4 32247.0 32304.0 32893.3 4437.1 4438.2 4464.9 4480.6 4522.4 320340.0 321188.0 321471.0 321970.0 322855.4 33367.0 57129.7 57179.7 57365.4 57802.0 34509.3 36249.5 36324.1 36392.3 36409.5 13873.7 14065.7 14094.6 14100.6 14105.9 11742.6 11761.2 11807.6 11827.2 11868.2 8128.3 8248.3 8262.3 8275.3 8345.3 3244.6 3254.9 3255.1 3267.2 3315.0 967.6 1003.5 1037.8 1072.2 1123.2 31177.5 31664.8 32088.0 32217.5 32274.5 1067.9 1084.3 1179.2 1185.4 1185.6 16301.2 16935.8 17144.4 17186.8 17200.4 151329.2 152095.0 153344.0 531743.0 541234.0 55929.7 56332.2 56590.0 56823.7 57135.0 1300.4 1328.1 1334.2 1346.5 1353.5 30086.2 30991.4 31500.0 31672.8 31929.8 49958.0 53357.5 54741.0 54881.0 59479.7 495162.0 495193.0 499427.0 499666.0 506502.0 27272.0 42107.0 42484.0 42624.6 42821.0 47432.5 47561.3 47612.5 48040.0 48380.0 39711.2 40080.6 40864.0 41587.0 41948.8 39371.6 40140.0 40279.6 40681.0 41494.8 35969.1 39625.8 40128.0 40233.2 41048.4 35546.0 36298.3 36677.0 36789.0 37023.6 27360.3 27864.4 28062.0 28154.4 28249.6 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#2] jquery.html Cycles:180 Average:28761.72 Median:1590.22 stddev:82470.92 (5186.1%) stddev-sans-first:82674.76 08:23:25 INFO - PROCESS | 8667 | Values: 391.3 398.1 398.9 402.3 422.1 13807.9 18015.0 18450.3 19703.0 19765.1 18757.8 18849.3 19189.3 19513.1 19576.7 5570.1 5654.7 5794.5 5812.0 5867.3 5663.5 5726.2 5763.3 5816.3 5967.0 5983.6 5994.4 6000.0 6014.5 6027.2 5833.4 5931.1 5954.4 5964.9 6008.2 5772.9 5783.9 5790.0 5795.2 5801.7 13461.9 14198.7 14225.3 14229.4 14271.4 2276.3 2296.2 2299.8 2489.7 2789.1 10109.5 10126.1 10448.8 10571.2 10794.6 1918.3 1989.1 1991.9 2016.0 2035.2 76585.6 77230.6 77326.0 78078.0 78280.0 10913.7 11135.7 11144.3 11183.6 11353.4 15340.7 15413.0 15488.8 15489.4 15533.6 7325.2 7424.4 7448.3 7475.6 7546.0 6947.8 7031.5 7128.3 7164.8 7199.3 4806.2 4829.5 4836.2 4851.3 4853.4 1933.0 1944.8 1982.6 2031.7 2033.3 876.5 942.9 963.4 1018.9 1025.1 19251.2 19327.0 19467.3 19502.3 19735.5 947.5 956.6 962.7 995.8 1036.5 10825.3 11010.5 11166.9 11196.8 11265.9 493445.0 495570.0 499587.0 508908.0 512093.0 78505.6 79792.6 81946.0 82559.6 83619.0 997.9 1007.1 1049.9 1058.3 1062.5 17731.6 17942.6 18213.5 18274.0 18517.9 41486.6 42116.2 42691.6 42845.8 43996.3 54172.7 54327.0 57594.4 63163.1 63765.7 8633.4 8643.4 8748.8 8762.1 8989.5 9531.0 13237.6 13628.2 13742.9 14019.5 11640.6 12055.5 12173.8 12269.0 12279.5 10038.5 11667.5 11678.3 12027.1 12146.1 12044.6 12098.8 12121.5 12586.3 12604.2 7714.3 8738.2 8775.0 8843.1 8988.5 11666.4 11944.6 12250.0 12261.3 12287.0 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#3] mootools.html Cycles:180 Average:5788.62 Median:5023.40 stddev:3271.37 (65.1%) stddev-sans-first:3264.23 08:23:25 INFO - PROCESS | 8667 | Values: 1440.9 1457.9 1493.1 1651.4 1670.1 7951.3 8645.4 8652.1 9267.4 9294.1 8678.3 8912.9 8936.1 9051.6 9096.1 2285.0 2310.0 2323.1 2323.7 2333.3 2316.5 2341.4 2360.7 2375.6 2380.7 2309.3 2323.8 2338.4 2390.9 2402.0 2263.4 2286.0 2286.1 2293.3 2298.0 2234.1 2238.4 2241.1 2245.6 2246.7 9024.0 9046.0 9066.6 9087.3 9150.1 5173.9 5368.8 5413.9 5423.3 5438.4 3256.3 3299.1 3455.9 3459.9 3472.0 1143.9 1146.1 2184.5 2229.4 2241.7 11533.4 11552.7 11566.5 11600.9 11602.3 4384.9 4472.6 4511.9 4525.7 4545.9 9864.4 9868.1 9884.9 9888.5 9922.4 5019.3 5059.5 5071.9 5120.5 5121.9 4408.0 4674.2 4692.7 4800.6 4808.4 3735.2 3761.4 3837.2 3837.9 3843.3 1128.4 1147.6 1157.8 1161.0 1161.7 839.0 890.2 899.2 917.3 923.2 5703.8 5733.3 5759.7 5834.4 6165.8 961.5 980.2 993.4 1002.0 1017.5 4142.1 4228.9 4256.6 4271.4 4286.4 11145.4 11399.7 11408.1 11452.3 11486.3 10041.8 11020.4 11042.1 11171.2 11352.6 8235.0 8301.7 8337.8 8354.5 8385.6 5549.4 5592.3 5623.0 5669.1 5803.7 9944.5 9959.2 9962.4 10039.0 10131.1 9964.3 10332.9 10333.3 10595.6 10773.3 7139.4 7260.3 7490.5 7572.2 7752.7 8499.2 8529.5 8631.1 8772.9 8775.5 7361.7 7593.4 7635.5 7672.3 7785.6 7540.4 7666.3 7716.8 7717.6 7739.5 7064.6 7083.0 7106.8 7128.5 7130.4 5085.9 5154.3 5229.6 5276.7 5279.4 4889.4 4977.0 5027.5 5060.4 5092.1 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#4] prototype.html Cycles:180 Average:4971.88 Median:5671.23 stddev:1461.72 (25.8%) stddev-sans-first:1423.74 08:23:25 INFO - PROCESS | 8667 | Values: 332.9 333.7 336.1 336.7 338.8 5564.4 5655.4 5705.1 5711.9 5730.3 5536.4 5564.6 5568.4 5592.9 5656.5 4133.3 4233.5 4358.4 4373.5 4381.5 4350.5 4389.4 4391.9 4392.7 4396.2 4358.4 4380.6 4407.3 4429.1 4430.9 4318.1 4330.4 4407.8 4415.4 4428.8 3851.9 3852.3 3893.2 3909.8 3923.2 5489.9 5547.3 5559.0 5562.2 5572.8 4867.0 4954.9 4985.0 5048.6 5087.2 5833.5 5854.5 5871.9 5896.6 5946.5 4214.8 4259.7 4261.5 4284.9 4296.3 5889.3 5988.5 6023.2 6145.6 6157.3 4326.9 4337.8 4339.2 4347.4 4355.9 4391.2 4413.6 4429.7 4438.9 4440.6 4908.9 4985.4 4992.5 5002.9 5003.7 5768.0 5871.8 5874.0 5894.9 5982.3 1481.5 1516.0 1538.4 1544.9 1548.8 962.5 970.0 986.2 1028.6 1047.4 5631.2 5633.4 5668.8 5682.5 5695.8 5960.4 5967.5 5975.1 6003.8 6041.2 5470.8 5673.6 5770.6 5805.6 5817.0 3244.5 3256.3 3262.9 3265.6 3279.7 6127.5 6231.9 6267.7 6333.0 6334.1 6186.0 6197.6 6213.5 6228.1 6232.7 5993.6 6221.6 6279.7 6295.9 6312.7 6051.2 6061.9 6078.2 6085.4 6100.8 6005.0 6010.8 6017.5 6037.9 6041.8 6045.6 6183.4 6224.5 6229.8 6307.0 4143.3 4152.3 4210.9 4250.5 4255.7 5804.9 6134.4 6143.2 6155.3 6170.0 5848.0 5881.0 5890.1 5908.5 5916.7 5794.4 5852.9 5862.4 5862.4 5868.9 5573.8 5755.0 5788.3 5877.7 5887.6 6004.9 6006.0 6023.4 6033.0 6053.4 5562.6 5668.0 5791.2 5858.9 5875.3 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - PROCESS | 8667 | [#5] yui.html Cycles:180 Average:21072.17 Median:4830.71 stddev:30979.22 (641.3%) stddev-sans-first:31028.37 08:23:25 INFO - PROCESS | 8667 | Values: 702.9 748.2 765.2 795.1 842.1 13455.3 14112.9 14500.3 14521.3 14724.6 13170.4 13495.6 13550.1 13556.4 13566.0 760.4 765.2 772.3 774.3 787.1 771.8 772.4 773.0 773.6 777.2 802.3 804.7 809.1 810.8 813.2 805.7 810.9 811.7 813.5 814.1 587.4 588.9 589.1 589.9 592.1 14211.6 14251.8 14317.9 14376.7 14418.5 14401.3 14414.2 14533.7 14655.3 14839.3 12290.4 12353.4 12492.4 12604.6 12703.1 3863.8 3890.6 3896.1 3930.3 4012.8 76256.2 79662.2 79847.2 80007.2 81273.6 10141.8 10431.8 10784.5 10908.4 10992.7 21533.8 21555.1 21581.9 21683.6 22073.7 8477.2 8631.9 8667.1 8705.2 8791.9 4797.3 4817.5 4843.9 4852.9 4943.5 3364.9 3468.1 3483.2 3486.0 3493.5 590.5 595.4 600.1 609.2 613.8 608.3 671.7 708.9 712.2 789.5 9394.8 9581.2 9697.1 10118.7 10224.0 705.5 743.2 765.3 766.4 789.5 4891.8 4900.5 4921.6 4954.5 4989.0 114744.0 114977.4 117976.0 121544.0 121828.0 98100.5 99358.0 99904.0 100186.5 100310.0 88565.0 89689.2 90495.1 91216.1 91879.5 9544.7 9694.4 9761.2 9781.9 9820.6 50031.2 52937.0 53996.7 54875.5 55120.7 75981.0 77014.0 79267.2 79687.6 80461.2 11336.7 11424.2 11463.8 11521.4 11931.2 12957.8 13063.3 13770.1 13892.6 13965.4 12362.4 13293.9 13728.5 13762.2 13817.5 12231.4 12774.2 12875.4 13394.1 13744.2 13000.3 13034.0 13182.5 13316.4 13429.3 10430.8 10675.5 10807.3 10878.1 10883.9 10251.8 10255.2 10464.5 10535.2 10550.5 08:23:25 INFO - PROCESS | 8667 | -------- Summary: end -------- 08:23:25 INFO - PROCESS | 8667 | 08:23:25 INFO - TEST-INFO | 8667: exit 0 08:23:25 INFO - TEST-OK | dromaeo_css | took 1111190ms 08:23:25 INFO - TEST-START | kraken 08:23:25 INFO - operating with platform_type : linux_ 08:23:25 INFO - Initialising browser for kraken test... 08:23:25 INFO - TEST-INFO | started process 8915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5952VW/profile http://localhost:40136/getInfo.html) 08:23:30 INFO - PROCESS | 8915 | __metrics Screen width/height:1600/1200 08:23:30 INFO - PROCESS | 8915 | colorDepth:24 08:23:30 INFO - PROCESS | 8915 | Browser inner width/height: 1024/697 08:23:30 INFO - PROCESS | 8915 | __metrics 08:23:31 ERROR - PROCESS | 8915 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:23:32 INFO - TEST-INFO | 8915: exit 0 08:23:32 INFO - Browser initialized. 08:23:32 INFO - Running cycle 1/1 for kraken test... 08:23:32 INFO - TEST-INFO | started process 9033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5952VW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:44 INFO - PROCESS | 9033 | RSS: Main: 184823808 08:23:44 INFO - PROCESS | 9033 | 08:23:46 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:47 INFO - PROCESS | 9033 | RSS: Main: 190763008 08:23:47 INFO - PROCESS | 9033 | 08:23:50 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-dft) 08:23:50 INFO - PROCESS | 9033 | RSS: Main: 190242816 08:23:50 INFO - PROCESS | 9033 | 08:23:53 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-fft) 08:23:54 INFO - PROCESS | 9033 | RSS: Main: 184971264 08:23:54 INFO - PROCESS | 9033 | 08:23:56 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator) 08:23:56 INFO - PROCESS | 9033 | RSS: Main: 185675776 08:23:56 INFO - PROCESS | 9033 | 08:23:59 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:59 INFO - PROCESS | 9033 | RSS: Main: 186097664 08:23:59 INFO - PROCESS | 9033 | 08:24:02 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:03 INFO - PROCESS | 9033 | RSS: Main: 185720832 08:24:03 INFO - PROCESS | 9033 | 08:24:06 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:07 INFO - PROCESS | 9033 | RSS: Main: 183701504 08:24:07 INFO - PROCESS | 9033 | 08:24:10 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial) 08:24:11 INFO - PROCESS | 9033 | RSS: Main: 185241600 08:24:11 INFO - PROCESS | 9033 | 08:24:12 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:13 INFO - PROCESS | 9033 | RSS: Main: 185606144 08:24:13 INFO - PROCESS | 9033 | 08:24:15 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:15 INFO - PROCESS | 9033 | RSS: Main: 185769984 08:24:15 INFO - PROCESS | 9033 | 08:24:17 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:18 INFO - PROCESS | 9033 | RSS: Main: 185982976 08:24:18 INFO - PROCESS | 9033 | 08:24:21 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:21 INFO - PROCESS | 9033 | RSS: Main: 186036224 08:24:21 INFO - PROCESS | 9033 | 08:24:24 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:24 INFO - PROCESS | 9033 | RSS: Main: 185524224 08:24:24 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40136/tests/kraken/driver.html?testName=ai-astar) 08:24:26 INFO - PROCESS | 9033 | RSS: Main: 186728448 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | __start_tp_report 08:24:26 INFO - PROCESS | 9033 | _x_x_mozilla_page_load 08:24:26 INFO - PROCESS | 9033 | _x_x_mozilla_page_load_details 08:24:26 INFO - PROCESS | 9033 | |i|pagename|runs| 08:24:26 INFO - PROCESS | 9033 | |0;ai-astar;111;105;116;111;110;110;109;110;111;110 08:24:26 INFO - PROCESS | 9033 | |1;audio-beat-detection;152;131;159;171;130;154;151;125;179;127 08:24:26 INFO - PROCESS | 9033 | |2;audio-dft;165;163;163;161;165;175;172;163;163;165 08:24:26 INFO - PROCESS | 9033 | |3;audio-fft;74;74;75;171;78;75;74;76;167;79 08:24:26 INFO - PROCESS | 9033 | |4;audio-oscillator;85;85;146;86;85;85;140;84;84;147 08:24:26 INFO - PROCESS | 9033 | |5;imaging-gaussian-blur;117;117;118;117;118;117;118;123;118;118 08:24:26 INFO - PROCESS | 9033 | |6;imaging-darkroom;146;148;148;147;148;146;146;147;147;146 08:24:26 INFO - PROCESS | 9033 | |7;imaging-desaturate;96;97;95;94;95;95;95;95;95;96 08:24:26 INFO - PROCESS | 9033 | |8;json-parse-financial;54;55;56;56;56;57;54;57;55;56 08:24:26 INFO - PROCESS | 9033 | |9;json-stringify-tinderbox;61;61;61;62;63;62;62;62;61;61 08:24:26 INFO - PROCESS | 9033 | |10;stanford-crypto-aes;81;78;78;86;81;80;82;79;113;81 08:24:26 INFO - PROCESS | 9033 | |11;stanford-crypto-ccm;135;125;131;132;124;122;132;131;136;121 08:24:26 INFO - PROCESS | 9033 | |12;stanford-crypto-pbkdf2;159;161;165;158;157;164;159;159;163;160 08:24:26 INFO - PROCESS | 9033 | |13;stanford-crypto-sha256-iterative;63;64;65;62;68;62;61;64;61;61 08:24:26 INFO - PROCESS | 9033 | __end_tp_report 08:24:26 INFO - PROCESS | 9033 | __start_cc_report 08:24:26 INFO - PROCESS | 9033 | _x_x_mozilla_cycle_collect,870 08:24:26 INFO - PROCESS | 9033 | __end_cc_report 08:24:26 INFO - PROCESS | 9033 | __startTimestamp1466436266898__endTimestamp 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | ------- Summary: start ------- 08:24:26 INFO - PROCESS | 9033 | Number of tests: 14 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:2.67 (2.4%) stddev-sans-first:2.82 08:24:26 INFO - PROCESS | 9033 | Values: 111.0 105.0 116.0 111.0 110.0 110.0 109.0 110.0 111.0 110.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.00 stddev:19.02 (12.4%) stddev-sans-first:20.11 08:24:26 INFO - PROCESS | 9033 | Values: 152.0 131.0 159.0 171.0 130.0 154.0 151.0 125.0 179.0 127.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:4.45 (2.7%) stddev-sans-first:4.72 08:24:26 INFO - PROCESS | 9033 | Values: 165.0 163.0 163.0 161.0 165.0 175.0 172.0 163.0 163.0 165.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:39.42 (52.6%) stddev-sans-first:41.12 08:24:26 INFO - PROCESS | 9033 | Values: 74.0 74.0 75.0 171.0 78.0 75.0 74.0 76.0 167.0 79.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.79 (33.9%) stddev-sans-first:29.82 08:24:26 INFO - PROCESS | 9033 | Values: 85.0 85.0 146.0 86.0 85.0 85.0 140.0 84.0 84.0 147.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.79 (1.5%) stddev-sans-first:1.86 08:24:26 INFO - PROCESS | 9033 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 118.0 123.0 118.0 118.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 08:24:26 INFO - PROCESS | 9033 | Values: 146.0 148.0 148.0 147.0 148.0 146.0 146.0 147.0 147.0 146.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 08:24:26 INFO - PROCESS | 9033 | Values: 96.0 97.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:0.97 08:24:26 INFO - PROCESS | 9033 | Values: 54.0 55.0 56.0 56.0 56.0 57.0 54.0 57.0 55.0 56.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 08:24:26 INFO - PROCESS | 9033 | Values: 61.0 61.0 61.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:10.48 (12.9%) stddev-sans-first:11.07 08:24:26 INFO - PROCESS | 9033 | Values: 81.0 78.0 78.0 86.0 81.0 80.0 82.0 79.0 113.0 81.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.50 stddev:5.43 (4.1%) stddev-sans-first:5.29 08:24:26 INFO - PROCESS | 9033 | Values: 135.0 125.0 131.0 132.0 124.0 122.0 132.0 131.0 136.0 121.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:2.68 (1.7%) stddev-sans-first:2.78 08:24:26 INFO - PROCESS | 9033 | Values: 159.0 161.0 165.0 158.0 157.0 164.0 159.0 159.0 163.0 160.0 08:24:26 INFO - PROCESS | 9033 | 08:24:26 INFO - PROCESS | 9033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:2.23 (3.5%) stddev-sans-first:2.37 08:24:26 INFO - PROCESS | 9033 | Values: 63.0 64.0 65.0 62.0 68.0 62.0 61.0 64.0 61.0 61.0 08:24:26 INFO - PROCESS | 9033 | -------- Summary: end -------- 08:24:26 INFO - PROCESS | 9033 | 08:24:27 INFO - TEST-INFO | 9033: exit 0 08:24:27 INFO - TEST-OK | kraken | took 62196ms 08:24:27 INFO - SUITE-END | took 1173s 08:24:28 INFO - Completed test suite (00:19:33) 08:24:28 INFO - javascript benchmark 08:24:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.564385690709, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.580206672099, 3116.7506599472044, 3156.6685498022716, 3171.191346206718, 3173.20669832542, 5418.647787893784, 5446.618736688433, 5447.863803404912, 5556.249906262663, 5579.944200558003, 5435.728213589325, 5436.320459942507, 5481.725913704318, 5515.448455154483, 5544.86137846554, 4914.827981020665, 4939.728314942677, 5034.748262586874, 5083.415407228179, 5116.386033675964, 730.9995705132254, 4998.125328067592, 5046.44489106198, 5060.7722652480725, 5097.872553186163, 4966.379202599675, 4986.326845875815, 4990.3762029746285, 4993.425756038047, 5055.165897626887, 4927.77824997876, 5020.171671674169, 5022.974885125587, 5046.596272298244, 5066.442691303953, 4927.679700819471, 4960.627952903511, 4992.076465853828, 4996.500349965011, 5000.174971129795, 5463.31708536433, 5526.309211348582, 5576.553875689935, 5583.3858275590055, 5665.3768085510565, 5855.033919403293, 5935.287765468128, 5992.820215393545, 5996.760129594811, 6014.12795144706, 5980.820575382745, 6002.099685047234, 6018.337982821886, 6042.6978651067275, 6071.119687645267, 5536.529395001429, 5539.9169012464845, 5546.556275497991, 5552.805651802168, 5555.166724991243, 5859.824205273849, 5995.2805663319805, 6060.2727672678675, 6063.181470501514, 6116.174316467309, 5860.472557469848, 5863.237779088691, 5864.824055278348, 5868.119782032729, 5877.647341159544, 5950.7917222896995, 5963.940360596425, 5967.8209653710455, 5975.25309336333, 5988.221531201003, 5742.3396309424115, 5897.056470964711, 5916.556258280646, 5949.434803693643, 5971.492423144082, 5834.533237341003, 5871.823845284648, 5872.207252020922, 5890.558208134407, 5962.552808539377, 4518.0, 4522.321651752198, 4523.570260825217, 4541.3188021797, 4572.771361431982, 3943.290207762573, 3952.9011774705286, 3959.7228194026716, 4005.919881602352, 4044.090079732037, 5619.634723742944, 5691.658500489983, 5694.857628559236, 5704.80033198836, 5709.885802283931, 5887.35239123696, 5953.255843019622, 5956.880862382728, 5961.701914904324, 5961.731722072517, 5613.10190369547, 5617.634853734494, 5671.376148623648, 5686.0, 5694.800681976111, 5081.695098294114, 5086.4659210783075, 5096.796128154832, 5097.413797413271, 5105.758576975686, 6003.279606447254, 6126.36500017443, 6147.477464415485, 6153.784617538365, 6160.8767824643255, 5907.172995780594, 5946.345901950868, 5975.073863551156, 6041.24484439445, 6044.063170208625, 6182.258129024546, 6238.282597501346, 6253.155823963707, 6255.812325630239, 6265.780697675559, 5785.161151633074, 5840.678762668094, 5914.112883067574, 5920.348761636131, 5950.553708471968, 5875.236219291465, 5982.940170598413, 5988.730507127103, 5992.280926288873, 6046.969765151146, 5776.162456443876, 5781.508571771278, 5801.100829371286, 5834.0, 5834.649921004753, 5644.548436125018, 5692.7722891083895, 5695.572832037531, 5783.363829978614, 5800.709964501673, 5531.0873705839695, 5535.8892822144135, 5603.971980140073, 5649.152627105967, 5715.742791574306, 5682.06245969427, 5713.22871412354, 5729.512991395778, 5738.598298119092, 5748.6838223898085, 5550.888982220252, 5567.387587365468, 5602.831915042555, 5614.101743720985, 5615.859603509945], "value": 5422.341094864808, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.050396342072, 629.436654194496, 647.2297965421149, 650.0054915978551, 653.0530730440862, 36777.81611091948, 41274.17451650965, 41441.3783793243, 41451.0, 41578.0, 41518.79240603793, 41629.791851040776, 41793.16413671732, 41816.37275440871, 41818.790906045426, 8706.303495720344, 8828.07305232951, 8845.248153906925, 8852.645894164225, 8887.866681999743, 8748.737537873874, 8855.73432797017, 8914.866277005818, 8947.105289471066, 8953.731388058368, 8938.64245430182, 8941.64233430662, 8947.597358118901, 8976.23701985332, 9009.279257659371, 8812.603432845506, 8957.417767845101, 8964.820703585958, 8966.730998070068, 8967.641294348217, 8634.352423568258, 8677.26243269323, 8697.347698922544, 8711.433756805787, 8728.083551227093, 39481.21037579261, 39489.40765888514, 39752.80123599363, 39811.20377592461, 39903.0, 3366.208940898887, 3610.6208848070837, 3690.0590349460717, 3722.1253005543676, 3978.0054986253435, 31874.840625796955, 32057.358852823047, 32247.0, 32304.0, 32893.34213315744, 4437.112577484516, 4438.160990743017, 4464.906098006009, 4480.596746292849, 4522.4346956630425, 320340.0, 321188.0, 321471.0, 321970.0, 322855.3857230722, 33367.0, 57129.714351427974, 57179.71410142923, 57365.42634573684, 57802.0, 34509.309813803586, 36249.45625815615, 36324.09189770277, 36392.27215455729, 36409.45385819215, 13873.653158670912, 14065.71868562623, 14094.647633809236, 14100.576982690536, 14105.929470352583, 11742.589009384801, 11761.235519691363, 11807.586734464252, 11827.231229970024, 11868.228565143238, 8128.349732021424, 8248.340132789363, 8262.297704695047, 8275.296599789086, 8345.290650294794, 3244.561984132159, 3254.8698052077652, 3255.104846167323, 3267.2356927259016, 3315.0386387947706, 967.5791030901439, 1003.4832061488339, 1037.7924415117006, 1072.217281384578, 1123.230587047875, 31177.532337014964, 31664.841675791475, 32088.0, 32217.51673724896, 32274.515882261785, 1067.8611780468646, 1084.2681190196586, 1179.1745777955466, 1185.4309931233056, 1185.5968970549882, 16301.184940753152, 16935.830641693425, 17144.39994600208, 17186.828131718772, 17200.397986070428, 151329.2433537825, 152095.0, 153344.0, 531743.0, 541234.0, 55929.720351397984, 56332.15501767477, 56590.0, 56823.71588142116, 57135.0, 1300.3888172558882, 1328.0504439325734, 1334.2461509247244, 1346.5255545178015, 1353.472145863114, 30086.24784380408, 30991.380172396875, 31500.0, 31672.841635791672, 31929.840350799026, 49958.0, 53357.4664253368, 54741.0, 54881.0, 59479.70260148845, 495162.0, 495193.0, 499427.0, 499666.0, 506502.0, 27272.0, 42107.0, 42484.0, 42624.57375426206, 42821.0, 47432.525674742814, 47561.286580702006, 47612.52387476081, 48040.0, 48380.0, 39711.2057758849, 40080.59919400885, 40864.0, 41587.0, 41948.79025604852, 39371.60628393794, 40140.0, 40279.59720402758, 40681.0, 41494.79252603718, 35969.100772480895, 39625.801870991614, 40128.0, 40233.1953360937, 41048.38427423651, 35546.0, 36298.27403451969, 36677.0, 36789.0, 37023.62976370202, 27360.315992100357, 27864.442711145257, 28062.0, 28154.43691126207, 28249.57625635576], "value": 18619.834464216077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.3444979659071, 398.08043419700476, 398.86239247459633, 402.29598203144496, 422.07354856090893, 13807.861921380783, 18015.0, 18450.261989520404, 19703.0, 19765.110570024346, 18757.842848072476, 18849.340273090445, 19189.32837350693, 19513.121909514106, 19576.706349404736, 5570.108782594785, 5654.717264136797, 5794.536437085044, 5812.0, 5867.266591676041, 5663.546916246691, 5726.198332233491, 5763.337216220126, 5816.33112192097, 5967.0, 5983.58114931955, 5994.430529099728, 5999.970000150015, 6014.548908831855, 6027.186329845481, 5833.3874943130995, 5931.139984702216, 5954.374790646984, 5964.880702385928, 6008.158857759917, 5772.913406298909, 5783.855403614902, 5790.0, 5795.159701843251, 5801.7099145043, 13461.932690336584, 14198.716025679532, 14225.288735563285, 14229.430822767077, 14271.429142834275, 2276.3284830974903, 2296.2307626944994, 2299.7585253548473, 2489.6887889013874, 2789.0935445979935, 10109.545070471773, 10126.139278161365, 10448.843267350996, 10571.15430765537, 10794.622188223375, 1918.2806447582157, 1989.094961792381, 1991.9004049797452, 2015.9697604535943, 2035.2062695548748, 76585.61707191484, 77230.6138469304, 77325.99999999943, 78078.0, 78280.0, 10913.672589822318, 11135.72160695989, 11144.33134011962, 11183.552657893593, 11353.375564343874, 15340.693186136437, 15413.0, 15488.767668484981, 15489.380424782883, 15533.611659708371, 7325.157606875171, 7424.443166762514, 7448.292412220831, 7475.6262186890435, 7546.0, 6947.826304342432, 7031.507794454441, 7128.322809333105, 7164.785056448315, 7199.316064973819, 4806.206975849016, 4829.492903245179, 4836.226203807374, 4851.320815085891, 4853.369062021915, 1932.9806701933082, 1944.844412447029, 1982.6184133066085, 2031.6647753120865, 2033.3391647714552, 876.4983889361912, 942.9387089839139, 963.3978763272954, 1018.89811018899, 1025.0569476082023, 19251.22995080209, 19327.0, 19467.31864384768, 19502.31741889027, 19735.506612334808, 947.5404428852002, 956.5695437053354, 962.6823148361024, 995.8307087794948, 1036.533559898049, 10825.296355736851, 11010.48475891017, 11166.888331116746, 11196.832047519294, 11265.887341126649, 493445.0, 495570.0, 499587.0, 508908.0, 512093.0, 78505.60747196342, 79792.6010369956, 81946.0, 82559.5872020636, 83619.0, 997.910188083076, 1007.1187710753092, 1049.9422531760674, 1058.2697938422464, 1062.5324857062867, 17731.64536709233, 17942.641147177244, 18213.54466138357, 18273.99493027843, 18517.90741046286, 41486.58513414827, 42116.15767684568, 42691.57308426876, 42845.78577107094, 43996.34005489856, 54172.729136354064, 54327.0, 57594.42405576058, 63163.105106846866, 63765.681171593846, 8633.39566230358, 8643.438176518506, 8748.825023499621, 8762.123787621187, 8989.46063236208, 9530.95234523823, 13237.602871913858, 13628.182309061489, 13742.93128534351, 14019.50931717385, 11640.592579260025, 12055.457504412498, 12173.817392738938, 12269.0, 12279.508819647113, 10038.498075096362, 11667.474963626488, 11678.30664553618, 12027.097967652286, 12146.089043321963, 12044.578439754918, 12098.818517722417, 12121.515139394325, 12586.307753073303, 12604.243745375306, 7714.305712485679, 8738.21356077956, 8774.956125219333, 8843.07147749477, 8988.505632190292, 11666.358350290477, 11944.64166075019, 12250.0, 12261.325627090238, 12287.0], "value": 9116.289559983097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.8991370604056, 1457.9271036448179, 1493.133982290271, 1651.3889860751524, 1670.073109424269, 7951.324137448324, 8645.351598630097, 8652.091530389305, 9267.351285410025, 9294.07059294071, 8678.262347700438, 8912.8663070054, 8936.10638936106, 9051.592678329474, 9096.135867092615, 2284.977150228493, 2310.0413328468667, 2323.1056043423237, 2323.6863023491783, 2333.346662934381, 2316.455632926261, 2341.4146463384154, 2360.7403185649564, 2375.58427275227, 2380.7143142822883, 2309.3418375762913, 2323.825713071518, 2338.4387746940697, 2390.9043638254534, 2401.95514950996, 2263.388885001057, 2285.994162568481, 2286.0855657736956, 2293.3005433342823, 2297.9885100574475, 2234.0505285253703, 2238.373255488466, 2241.1035585765662, 2245.5733410651924, 2246.6854640350366, 9024.0, 9046.0, 9066.592003359865, 9087.273018158532, 9150.084991500864, 5173.948260517422, 5368.758405871745, 5413.891722165574, 5423.2949716537, 5438.374586922515, 3256.267339848539, 3299.092749493884, 3455.8963231102857, 3459.896203113911, 3471.9652803471895, 1143.9428028598536, 1146.0774076868117, 2184.5084855907453, 2229.375774783063, 2241.68616393705, 11533.423328833525, 11552.711182220428, 11566.47950842214, 11600.941995290053, 11602.303861768321, 4384.890377740582, 4472.552744725502, 4511.88720281989, 4525.683202175882, 4545.863534116471, 9864.408135511892, 9868.062534059252, 9884.901150988542, 9888.456134912649, 9922.355046922072, 5019.272205530177, 5059.468755780664, 5071.8985620287385, 5120.48795120485, 5121.923171152435, 4407.977960110179, 4674.228752255908, 4692.694974826625, 4800.639952003614, 4808.447028591687, 3735.234276973268, 3761.39817629178, 3837.213371258885, 3837.9424308635394, 3843.3466310727244, 1128.4301427779083, 1147.6384938744268, 1157.8089615213564, 1161.0421402343102, 1161.7269941563725, 839.0141583639321, 890.1943740914353, 899.150302963693, 917.2707697380598, 923.1599244687302, 5703.771849126071, 5733.283339582552, 5759.712014399263, 5834.358220595731, 6165.84585385369, 961.5192403798101, 980.152168374351, 993.3592832622918, 1001.9699409017741, 1017.4556612212431, 4142.109446469024, 4228.9154216915485, 4256.616904478612, 4271.402003719481, 4286.39990401344, 11145.442727863574, 11399.658010259705, 11408.087353011739, 11452.255603385753, 11486.253393529394, 10041.799164016678, 11020.393878336768, 11042.061424778984, 11171.162162837658, 11352.602658906899, 8234.958825205835, 8301.709440169565, 8337.791555211046, 8354.540500272666, 8385.6226469809, 5549.417311182267, 5592.3009623797025, 5623.044082505902, 5669.121286200645, 5803.709814509173, 9944.45305508175, 9959.203263739028, 9962.402255864672, 10039.0, 10131.13885319756, 9964.302498825013, 10332.948335258576, 10333.328333658288, 10595.629152979609, 10773.299735517166, 7139.428845692436, 7260.2739726026975, 7490.475666703279, 7572.167061623327, 7752.728654497066, 8499.235068843835, 8529.530875801891, 8631.136886311318, 8772.868406973774, 8775.473471591726, 7361.668724907499, 7593.354564861827, 7635.503692259986, 7672.347850432776, 7785.610719464117, 7540.434467414856, 7666.348360389429, 7716.7684969451, 7717.57553334572, 7739.496932699357, 7064.576125432491, 7083.0, 7106.751263705745, 7128.501004929605, 7130.358267755927, 5085.92371114441, 5154.278401023785, 5229.581633469389, 5276.736163191902, 5279.445658205833, 4889.413270407574, 4976.975115124401, 5027.522385373383, 5060.418051924076, 5092.134337162765], "value": 4661.019267163117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9346092503987, 333.7480202447152, 336.08249478922534, 336.6818356652964, 338.7865644643874, 5564.443555644439, 5655.434456554352, 5705.058665320223, 5711.914321285179, 5730.3123625165035, 5536.446355364472, 5564.610477266593, 5568.413002294347, 5592.916106258399, 5656.547476201904, 4133.297339452292, 4233.518268605979, 4358.4309648526505, 4373.497047839492, 4381.53993830648, 4350.477942646887, 4389.363542286366, 4391.890202744941, 4392.714473559208, 4396.20868243716, 4358.368036634686, 4380.627646650023, 4407.2948328267485, 4429.092036132585, 4430.867073987785, 4318.114786468766, 4330.372096046056, 4407.757573333465, 4415.359772832921, 4428.844990425352, 3851.881465194132, 3852.306584814732, 3893.1629699614437, 3909.7849618270984, 3923.195744872294, 5489.862753431156, 5547.25112109868, 5558.972205138948, 5562.221289019541, 5572.804951826707, 4866.9513304867205, 4954.87612809679, 4984.950150498485, 5048.596112311006, 5087.236914462823, 5833.533317334603, 5854.5023672987845, 5871.8532036699, 5896.557758168155, 5946.494547963428, 4214.831406743727, 4259.70182087254, 4261.488621365425, 4284.935725964113, 4296.312589985588, 5889.2921052895035, 5988.520918326523, 6023.223149171005, 6145.569810113294, 6157.322694503601, 4326.913461730811, 4337.8264869404875, 4339.1972485090355, 4347.369736348869, 4355.891102722394, 4391.231534481453, 4413.58070983256, 4429.667774916894, 4438.933415998763, 4440.555944405533, 4908.8772780680765, 4985.426675932242, 4992.475790041994, 5002.89994200114, 5003.749812509433, 5767.971160144172, 5871.823845284648, 5874.0, 5894.938910996062, 5982.341942386334, 1481.5185064853965, 1515.9848401516065, 1538.4461593826213, 1544.8918575699593, 1548.8373720759384, 962.5235508423235, 969.9524513525375, 986.225812736998, 1028.5834237133972, 1047.3925123428546, 5631.183478395692, 5633.436656334334, 5668.829935101953, 5682.488576028178, 5695.829125126253, 5960.433758792908, 5967.523477756769, 5975.103734439782, 6003.849903752441, 6041.24484439445, 5470.781168753205, 5673.631213971079, 5770.5573606598355, 5805.593608447452, 5817.0, 3244.464663330524, 3256.251062255647, 3262.885798997024, 3265.559149514833, 3279.721223695965, 6127.5404344674325, 6231.906521402183, 6267.749290028348, 6333.0, 6334.144890439824, 6186.0, 6197.628142311476, 6213.5339849511465, 6228.065790131516, 6232.719527621268, 5993.580449368503, 6221.595596286227, 6279.717412716439, 6295.874082518324, 6312.664314203774, 6051.1830902829315, 6061.939160646957, 6078.209832721718, 6085.383285187412, 6100.786472473442, 6004.969975150097, 6010.8497287566415, 6017.548683848641, 6037.909431358621, 6041.758329666764, 6045.637261764308, 6183.443490085734, 6224.533160013108, 6229.813105606839, 6306.959351706917, 4143.316352801754, 4152.294110001247, 4210.915781684411, 4250.489941207075, 4255.680823938279, 5804.94195058044, 6134.386561344008, 6143.170671959407, 6155.261368635793, 6170.0, 5847.970760146172, 5880.970595147168, 5890.085722140236, 5908.493334199751, 5916.7041647918295, 5794.449527294901, 5852.94147058524, 5862.355140934408, 5862.3844496328975, 5868.94131058701, 5573.832785016456, 5755.0, 5788.305403351625, 5877.676727780014, 5887.61730487517, 6004.909926351195, 6005.978983572891, 6023.367546407564, 6033.0, 6053.365591290239, 5562.638428502134, 5668.0, 5791.218185545066, 5858.882822343444, 5875.3243377010485], "value": 4500.631678279894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8980797784325, 748.1994266135238, 765.2385876053328, 795.113448504917, 842.0568962761706, 13455.259960702157, 14112.92943535281, 14500.347484363203, 14521.273936303181, 14724.6318842029, 13170.407331670074, 13495.595132146027, 13550.119242249248, 13556.389962451689, 13565.982551308667, 760.4372764154541, 765.223298352173, 772.3396495995927, 774.3224678406394, 787.1498781316193, 771.8340556780291, 772.4438404348859, 773.0414286284994, 773.5668025905483, 777.1761932351696, 802.3060053054124, 804.7263930263709, 809.134226377776, 810.8337790752911, 813.2436833744615, 805.730080423059, 810.9148539403336, 811.7443005453264, 813.5484805932705, 814.0800894988655, 587.4184557288254, 588.9322727886263, 589.0957380421075, 589.855485406074, 592.0734051209886, 14211.573652790434, 14251.78622320666, 14317.856821431757, 14376.712465750627, 14418.495352662607, 14401.279936003159, 14414.207218602973, 14533.70932581353, 14655.34050967709, 14839.332230049673, 12290.385480726018, 12353.38233088342, 12492.375381230902, 12604.621861344174, 12703.110782245247, 3863.8454461821493, 3890.5720370759195, 3896.1428485733095, 3930.3121953658283, 4012.819423125937, 76256.23743762547, 79662.20337796606, 79847.20152798455, 80007.19992800055, 81273.59363203205, 10141.797164056678, 10431.791364172674, 10784.514696838662, 10908.400037997828, 10992.725181870517, 21533.78466215349, 21555.137794488044, 21581.892090539448, 21683.56632867334, 22073.668894966588, 8477.152284771473, 8631.913680863237, 8667.089955554702, 8705.173008564176, 8791.912080879238, 4797.304390863305, 4817.542333478314, 4843.878903027453, 4852.8544143675745, 4943.456219815817, 3364.9327013459592, 3468.0809585459874, 3483.198864261234, 3486.0239133042787, 3493.4934434506854, 590.4980766348655, 595.4045954045954, 600.0968542343745, 609.2049874913281, 613.7821073518926, 608.3490664988508, 671.7279501801778, 708.879969647955, 712.1916624630977, 789.4907784478979, 9394.765130871783, 9581.233501320017, 9697.078777516124, 10118.747031324276, 10223.967858963248, 705.4955706669756, 743.193634906122, 765.3494529649864, 766.4060353226183, 789.5144486140982, 4891.804327826847, 4900.460949295574, 4921.581665558396, 4954.455009948902, 4989.027139707795, 114744.0, 114977.4251128739, 117976.0, 121544.0, 121828.0, 98100.50949745206, 99358.0, 99904.0, 100186.49906750419, 100310.0, 88565.0, 89689.17020393653, 90495.09504904998, 91216.08783912209, 91879.54060229656, 9544.665936692183, 9694.418334899929, 9761.170300524534, 9781.902180978099, 9820.558074886505, 50031.24953125633, 52937.0, 53996.73001634967, 54875.5124487548, 55120.72439637776, 75981.0, 77014.0, 79267.20732792598, 79687.60156199182, 80461.19538804537, 11336.716582085184, 11424.200305978502, 11463.770724585629, 11521.423928803693, 11931.164818462625, 12957.805632915703, 13063.346832658139, 13770.104943178661, 13892.60776301828, 13965.371558280105, 12362.3818809061, 13293.867061329263, 13728.519501817389, 13762.24307663048, 13817.516386926409, 12231.449584768528, 12774.23354598727, 12875.420606072561, 13394.129381590166, 13744.244066576433, 13000.284984325575, 13034.0, 13182.538611148948, 13316.40076196554, 13429.328533573087, 10430.843537347098, 10675.51960161779, 10807.297525660806, 10878.12974962017, 10883.945580272048, 10251.84622230682, 10255.179585632983, 10464.476776161313, 10535.20985926074, 10550.525226364985], "value": 7449.729216281853, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 116.0, 111.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 159.0, 171.0, 130.0, 154.0, 151.0, 125.0, 179.0, 127.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 161.0, 165.0, 175.0, 172.0, 163.0, 163.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 171.0, 78.0, 75.0, 74.0, 76.0, 167.0, 79.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 86.0, 85.0, 85.0, 140.0, 84.0, 84.0, 147.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 123.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 56.0, 56.0, 57.0, 54.0, 57.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 78.0, 86.0, 81.0, 80.0, 82.0, 79.0, 113.0, 81.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 131.0, 132.0, 124.0, 122.0, 132.0, 131.0, 136.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 165.0, 158.0, 157.0, 164.0, 159.0, 159.0, 163.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 62.0, 68.0, 62.0, 61.0, 64.0, 61.0, 61.0], "value": 63.1, "unit": "score"}]}]} 08:24:28 INFO - Return code: 0 08:24:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:28 ERROR - # TBPL SUCCESS # 08:24:28 INFO - Running post-action listener: _resource_record_post_action 08:24:28 INFO - ##### 08:24:28 INFO - ##### Finished run-tests step (success) 08:24:28 INFO - ##### 08:24:28 INFO - Running post-run listener: _resource_record_post_run 08:24:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552771584; Read time: 0; Write time: 446152 08:24:28 INFO - TinderboxPrint: CPU usage
13.4% 08:24:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:24:28 INFO - TinderboxPrint: I/O write bytes / time
552,771,584 / 446,152 08:24:28 INFO - TinderboxPrint: CPU idle
8,231.8 (86.6%) 08:24:28 INFO - TinderboxPrint: CPU user
1,219.5 (12.8%) 08:24:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262922240; Read time: 0; Write time: 241664 08:24:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289849344; Read time: 0; Write time: 204488 08:24:28 INFO - Running post-run listener: _upload_blobber_files 08:24:28 INFO - Blob upload gear active. 08:24:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:28 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 08:24:28 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'] 08:24:28 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 08:24:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:24:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:30 INFO - (blobuploader) - INFO - Done attempting. 08:24:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:33 INFO - (blobuploader) - INFO - Done attempting. 08:24:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:24:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:34 INFO - (blobuploader) - INFO - Done attempting. 08:24:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:34 INFO - Return code: 0 08:24:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/621893718db855d19b655dd1e2a43d85da092d07640eae0dde85198e1d3ce99619451fe3863c7cda20bdaf3999ba0804db7d984ed204afeedab4ac84637980a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5008df1500b837934b577105a46aec1b12bcbe00059f107585c1436583b94ca4de2b12dd51be0c2831300cdb64a78b3c1e7717e3e8d1c987ddb7700833037101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c9c6e5d0b9b27550bc0694e17cbbaa818a44dd6d050f99f3b1c3c612f2aa470e6d971ed3888ec373bf1afdeb3d6b48ba7137b60cc1dd47869866c8183f23e17"} 08:24:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:34 INFO - Contents: 08:24:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/621893718db855d19b655dd1e2a43d85da092d07640eae0dde85198e1d3ce99619451fe3863c7cda20bdaf3999ba0804db7d984ed204afeedab4ac84637980a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5008df1500b837934b577105a46aec1b12bcbe00059f107585c1436583b94ca4de2b12dd51be0c2831300cdb64a78b3c1e7717e3e8d1c987ddb7700833037101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c9c6e5d0b9b27550bc0694e17cbbaa818a44dd6d050f99f3b1c3c612f2aa470e6d971ed3888ec373bf1afdeb3d6b48ba7137b60cc1dd47869866c8183f23e17"} 08:24:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:34 INFO - Copying logs to upload dir... 08:24:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.326947 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-20 08:24:33.875533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:24:33.878903) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 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/621893718db855d19b655dd1e2a43d85da092d07640eae0dde85198e1d3ce99619451fe3863c7cda20bdaf3999ba0804db7d984ed204afeedab4ac84637980a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5008df1500b837934b577105a46aec1b12bcbe00059f107585c1436583b94ca4de2b12dd51be0c2831300cdb64a78b3c1e7717e3e8d1c987ddb7700833037101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c9c6e5d0b9b27550bc0694e17cbbaa818a44dd6d050f99f3b1c3c612f2aa470e6d971ed3888ec373bf1afdeb3d6b48ba7137b60cc1dd47869866c8183f23e17"} build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.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/621893718db855d19b655dd1e2a43d85da092d07640eae0dde85198e1d3ce99619451fe3863c7cda20bdaf3999ba0804db7d984ed204afeedab4ac84637980a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5008df1500b837934b577105a46aec1b12bcbe00059f107585c1436583b94ca4de2b12dd51be0c2831300cdb64a78b3c1e7717e3e8d1c987ddb7700833037101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c9c6e5d0b9b27550bc0694e17cbbaa818a44dd6d050f99f3b1c3c612f2aa470e6d971ed3888ec373bf1afdeb3d6b48ba7137b60cc1dd47869866c8183f23e17"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:24:33.909111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:24:33.909863) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466435039.547420-1528282924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:24:33.992002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:24:33.992710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:24:33.993258) ========= ========= Total master_lag: 0.28 =========