builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1466507373.41 results: success (0) buildid: 20160621025705 builduid: 94301783bf474628bea94b579f25e10f revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.408837) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.409284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.409693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.425483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.425784) ========= 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=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 04:09:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.15M=0.01s 2016-06-21 04:09:33 (1.15 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.537631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.537955) ========= 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=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016974 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:33.588719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 04:09:33.589033) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --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=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 04:09:33,862 truncating revision to first 12 chars 2016-06-21 04:09:33,862 Setting DEBUG logging. 2016-06-21 04:09:33,862 attempt 1/10 2016-06-21 04:09:33,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ffa18cfc8b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 04:09:34,692 unpacking tar archive at: mozilla-central-0ffa18cfc8b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.148786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 04:09:34.751191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:34.751519) ========= script_repo_revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:34.751911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:34.752192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:09:34.763254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-21 04:09:34.763539) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:35 INFO - MultiFileLogger online at 20160621 04:09:35 in /builds/slave/test 04:09:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:09:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:35 INFO - {'append_to_log': False, 04:09:35 INFO - 'base_work_dir': '/builds/slave/test', 04:09:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:09:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:35 INFO - 'branch': 'Firefox-Non-PGO', 04:09:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:35 INFO - 'config_files': ('talos/linux_config.py',), 04:09:35 INFO - 'default_actions': ('clobber', 04:09:35 INFO - 'read-buildbot-config', 04:09:35 INFO - 'download-and-extract', 04:09:35 INFO - 'populate-webroot', 04:09:35 INFO - 'create-virtualenv', 04:09:35 INFO - 'install', 04:09:35 INFO - 'run-tests'), 04:09:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:35 INFO - 'download_minidump_stackwalk': True, 04:09:35 INFO - 'download_symbols': 'ondemand', 04:09:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:35 INFO - 'installer_path': 'installer.exe', 04:09:35 INFO - 'log_level': 'info', 04:09:35 INFO - 'log_name': 'talos', 04:09:35 INFO - 'log_to_console': True, 04:09:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:35 INFO - 'opt_config_files': (), 04:09:35 INFO - 'pip_index': False, 04:09:35 INFO - 'sps_profile': False, 04:09:35 INFO - 'sps_profile_interval': 0, 04:09:35 INFO - 'suite': 'dromaeojs-e10s', 04:09:35 INFO - 'system_bits': '32', 04:09:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:35 INFO - 'title': 'talos-linux64-ix-021', 04:09:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:35 INFO - 'use_talos_json': True, 04:09:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:35 INFO - 'work_dir': 'build'} 04:09:35 INFO - ##### 04:09:35 INFO - ##### Running clobber step. 04:09:35 INFO - ##### 04:09:35 INFO - Running pre-action listener: _resource_record_pre_action 04:09:35 INFO - Running main action method: clobber 04:09:35 INFO - rmtree: /builds/slave/test/build 04:09:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:35 INFO - Running post-action listener: _resource_record_post_action 04:09:35 INFO - ##### 04:09:35 INFO - ##### Finished clobber step (success) 04:09:35 INFO - ##### 04:09:35 INFO - ##### 04:09:35 INFO - ##### Running read-buildbot-config step. 04:09:35 INFO - ##### 04:09:35 INFO - Running pre-action listener: _resource_record_pre_action 04:09:35 INFO - Running main action method: read_buildbot_config 04:09:35 INFO - Using buildbot properties: 04:09:35 INFO - { 04:09:35 INFO - "project": "", 04:09:35 INFO - "product": "firefox", 04:09:35 INFO - "script_repo_revision": "production", 04:09:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:09:35 INFO - "repository": "", 04:09:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:09:35 INFO - "buildid": "20160621025705", 04:09:35 INFO - "pgo_build": "False", 04:09:35 INFO - "basedir": "/builds/slave/test", 04:09:35 INFO - "buildnumber": 350, 04:09:35 INFO - "slavename": "talos-linux64-ix-021", 04:09:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:09:35 INFO - "platform": "ubuntu64_hw", 04:09:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:09:35 INFO - "branch": "mozilla-central", 04:09:35 INFO - "repo_path": "mozilla-central", 04:09:35 INFO - "revision": "0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1", 04:09:35 INFO - "stage_platform": "linux64", 04:09:35 INFO - "builduid": "94301783bf474628bea94b579f25e10f", 04:09:35 INFO - "slavebuilddir": "test" 04:09:35 INFO - } 04:09:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:09:35 INFO - Running post-action listener: _resource_record_post_action 04:09:35 INFO - ##### 04:09:35 INFO - ##### Finished read-buildbot-config step (success) 04:09:35 INFO - ##### 04:09:35 INFO - ##### 04:09:35 INFO - ##### Running download-and-extract step. 04:09:35 INFO - ##### 04:09:35 INFO - Running pre-action listener: _resource_record_pre_action 04:09:35 INFO - Running main action method: download_and_extract 04:09:35 INFO - mkdir: /builds/slave/test/build/tests 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:44 INFO - Downloaded 1361 bytes. 04:09:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:44 INFO - Using the following test package requirements: 04:09:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'jsshell-linux-x86_64.zip'], 04:09:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:44 INFO - https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:54 INFO - Downloaded 22658694 bytes. 04:09:54 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'] 04:09:54 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 04:09:55 INFO - Return code: 0 04:09:55 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 04:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:55 INFO - https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:57 INFO - Downloaded 22658694 bytes. 04:09:57 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'] 04:09:57 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 04:09:58 INFO - Return code: 0 04:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:58 INFO - https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:09:59 INFO - Downloaded 14405384 bytes. 04:09:59 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'] 04:09:59 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 04:10:00 INFO - Return code: 0 04:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:00 INFO - https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VklF6A5RSP6G--lh12uYIQ/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 04:10:02 INFO - Downloaded 56228048 bytes. 04:10:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:02 INFO - mkdir: /builds/slave/test/properties 04:10:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:02 INFO - Contents: 04:10:02 INFO - build_url:https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:03 INFO - Running post-action listener: _resource_record_post_action 04:10:03 INFO - Running post-action listener: set_extra_try_arguments 04:10:03 INFO - ##### 04:10:03 INFO - ##### Finished download-and-extract step (success) 04:10:03 INFO - ##### 04:10:03 INFO - ##### 04:10:03 INFO - ##### Running populate-webroot step. 04:10:03 INFO - ##### 04:10:03 INFO - Running pre-action listener: _resource_record_pre_action 04:10:03 INFO - Running main action method: populate_webroot 04:10:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:03 INFO - '--tppagecycles', 04:10:03 INFO - '7'], 04:10:03 INFO - 'tests': ['tsvgm']}}, 04:10:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['damp', 'tps']}, 04:10:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'tests': ['damp', 'tps']}, 04:10:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['dromaeo_dom']}, 04:10:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['basic_compositor_video']}, 04:10:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:10:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['a11yr', 04:10:03 INFO - 'ts_paint', 04:10:03 INFO - 'tpaint', 04:10:03 INFO - 'sessionrestore', 04:10:03 INFO - 'sessionrestore_no_auto_restore', 04:10:03 INFO - 'tabpaint']}, 04:10:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['tsvgx', 04:10:03 INFO - 'tsvgr_opacity', 04:10:03 INFO - 'tart', 04:10:03 INFO - 'tscrollx', 04:10:03 INFO - 'cart']}, 04:10:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:03 INFO - 'tsvgr_opacity', 04:10:03 INFO - 'tart', 04:10:03 INFO - 'tscrollx', 04:10:03 INFO - 'cart']}, 04:10:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'talos_options': ['--disable-e10s'], 04:10:03 INFO - 'tests': ['tp5o']}, 04:10:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'tests': ['tp5o']}, 04:10:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'talos_options': ['--disable-e10s', 04:10:03 INFO - '--xperf_path', 04:10:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:03 INFO - 'tests': ['tp5n']}, 04:10:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:03 INFO - 'talos_options': ['--xperf_path', 04:10:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:03 INFO - 'tests': ['tp5n']}}, 04:10:03 INFO - 'talos.zip': {'path': '', 04:10:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:03 INFO - Running post-action listener: _resource_record_post_action 04:10:03 INFO - ##### 04:10:03 INFO - ##### Finished populate-webroot step (success) 04:10:03 INFO - ##### 04:10:03 INFO - ##### 04:10:03 INFO - ##### Running create-virtualenv step. 04:10:03 INFO - ##### 04:10:03 INFO - Running pre-action listener: _resource_record_pre_action 04:10:03 INFO - Running main action method: create_virtualenv 04:10:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:10:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:03 INFO - Using real prefix '/usr' 04:10:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:06 INFO - Installing pip.................done. 04:10:06 INFO - Return code: 0 04:10:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:10:06 INFO - Using env: {'DISPLAY': ':0', 04:10:06 INFO - 'HOME': '/home/cltbld', 04:10:06 INFO - 'LANG': 'en_US.UTF-8', 04:10:06 INFO - 'LANGUAGE': 'en_US:en', 04:10:06 INFO - 'LOGNAME': 'cltbld', 04:10:06 INFO - 'MAIL': '/var/mail/cltbld', 04:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:06 INFO - 'MOZ_NO_REMOTE': '1', 04:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:06 INFO - 'NO_EM_RESTART': '1', 04:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:06 INFO - 'PWD': '/builds/slave/test', 04:10:06 INFO - 'SHELL': '/bin/bash', 04:10:06 INFO - 'SHLVL': '1', 04:10:06 INFO - 'TERM': 'linux', 04:10:06 INFO - 'TMOUT': '86400', 04:10:06 INFO - 'USER': 'cltbld', 04:10:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:06 INFO - '_': '/tools/buildbot/bin/python'} 04:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:10:06 INFO - Cleaning up... 04:10:06 INFO - Return code: 0 04:10:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:10:06 INFO - Using env: {'DISPLAY': ':0', 04:10:06 INFO - 'HOME': '/home/cltbld', 04:10:06 INFO - 'LANG': 'en_US.UTF-8', 04:10:06 INFO - 'LANGUAGE': 'en_US:en', 04:10:06 INFO - 'LOGNAME': 'cltbld', 04:10:06 INFO - 'MAIL': '/var/mail/cltbld', 04:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:06 INFO - 'MOZ_NO_REMOTE': '1', 04:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:06 INFO - 'NO_EM_RESTART': '1', 04:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:06 INFO - 'PWD': '/builds/slave/test', 04:10:06 INFO - 'SHELL': '/bin/bash', 04:10:06 INFO - 'SHLVL': '1', 04:10:06 INFO - 'TERM': 'linux', 04:10:06 INFO - 'TMOUT': '86400', 04:10:06 INFO - 'USER': 'cltbld', 04:10:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:06 INFO - '_': '/tools/buildbot/bin/python'} 04:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:06 INFO - Downloading/unpacking psutil>=3.1.1 04:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:08 INFO - Installing collected packages: psutil 04:10:08 INFO - Running setup.py install for psutil 04:10:08 INFO - building 'psutil._psutil_linux' extension 04:10:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:10:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:10:09 INFO - building 'psutil._psutil_posix' extension 04:10:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:10:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:10:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:09 INFO - Successfully installed psutil 04:10:09 INFO - Cleaning up... 04:10:09 INFO - Return code: 0 04:10:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:10:09 INFO - Using env: {'DISPLAY': ':0', 04:10:09 INFO - 'HOME': '/home/cltbld', 04:10:09 INFO - 'LANG': 'en_US.UTF-8', 04:10:09 INFO - 'LANGUAGE': 'en_US:en', 04:10:09 INFO - 'LOGNAME': 'cltbld', 04:10:09 INFO - 'MAIL': '/var/mail/cltbld', 04:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:09 INFO - 'MOZ_NO_REMOTE': '1', 04:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:09 INFO - 'NO_EM_RESTART': '1', 04:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:09 INFO - 'PWD': '/builds/slave/test', 04:10:09 INFO - 'SHELL': '/bin/bash', 04:10:09 INFO - 'SHLVL': '1', 04:10:09 INFO - 'TERM': 'linux', 04:10:09 INFO - 'TMOUT': '86400', 04:10:09 INFO - 'USER': 'cltbld', 04:10:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:09 INFO - '_': '/tools/buildbot/bin/python'} 04:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:11 INFO - Installing collected packages: mozsystemmonitor 04:10:11 INFO - Running setup.py install for mozsystemmonitor 04:10:11 INFO - Successfully installed mozsystemmonitor 04:10:11 INFO - Cleaning up... 04:10:11 INFO - Return code: 0 04:10:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:10:11 INFO - Using env: {'DISPLAY': ':0', 04:10:11 INFO - 'HOME': '/home/cltbld', 04:10:11 INFO - 'LANG': 'en_US.UTF-8', 04:10:11 INFO - 'LANGUAGE': 'en_US:en', 04:10:11 INFO - 'LOGNAME': 'cltbld', 04:10:11 INFO - 'MAIL': '/var/mail/cltbld', 04:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:11 INFO - 'MOZ_NO_REMOTE': '1', 04:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:11 INFO - 'NO_EM_RESTART': '1', 04:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:11 INFO - 'PWD': '/builds/slave/test', 04:10:11 INFO - 'SHELL': '/bin/bash', 04:10:11 INFO - 'SHLVL': '1', 04:10:11 INFO - 'TERM': 'linux', 04:10:11 INFO - 'TMOUT': '86400', 04:10:11 INFO - 'USER': 'cltbld', 04:10:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:11 INFO - '_': '/tools/buildbot/bin/python'} 04:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:11 INFO - Downloading/unpacking jsonschema==2.5.1 04:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:14 INFO - warning: no files found matching '*.txt' 04:10:14 INFO - no previously-included directories found matching 'build' 04:10:14 INFO - no previously-included directories found matching 'dist' 04:10:14 INFO - no previously-included directories found matching '.git*' 04:10:14 INFO - Installing collected packages: jsonschema, functools32 04:10:14 INFO - Running setup.py install for functools32 04:10:14 INFO - warning: no files found matching '*.txt' 04:10:14 INFO - no previously-included directories found matching 'build' 04:10:14 INFO - no previously-included directories found matching 'dist' 04:10:14 INFO - no previously-included directories found matching '.git*' 04:10:14 INFO - Successfully installed jsonschema functools32 04:10:14 INFO - Cleaning up... 04:10:14 INFO - Return code: 0 04:10:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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', '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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:10: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 blobuploader==1.2.4 04:10:14 INFO - Using env: {'DISPLAY': ':0', 04:10:14 INFO - 'HOME': '/home/cltbld', 04:10:14 INFO - 'LANG': 'en_US.UTF-8', 04:10:14 INFO - 'LANGUAGE': 'en_US:en', 04:10:14 INFO - 'LOGNAME': 'cltbld', 04:10:14 INFO - 'MAIL': '/var/mail/cltbld', 04:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:14 INFO - 'MOZ_NO_REMOTE': '1', 04:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:14 INFO - 'NO_EM_RESTART': '1', 04:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:14 INFO - 'PWD': '/builds/slave/test', 04:10:14 INFO - 'SHELL': '/bin/bash', 04:10:14 INFO - 'SHLVL': '1', 04:10:14 INFO - 'TERM': 'linux', 04:10:14 INFO - 'TMOUT': '86400', 04:10:14 INFO - 'USER': 'cltbld', 04:10:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:14 INFO - '_': '/tools/buildbot/bin/python'} 04:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:17 INFO - Downloading docopt-0.6.1.tar.gz 04:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:17 INFO - Running setup.py install for blobuploader 04:10:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:17 INFO - Running setup.py install for requests 04:10:17 INFO - Running setup.py install for docopt 04:10:17 INFO - Successfully installed blobuploader requests docopt 04:10:17 INFO - Cleaning up... 04:10:17 INFO - Return code: 0 04:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:10:17 INFO - Using env: {'DISPLAY': ':0', 04:10:17 INFO - 'HOME': '/home/cltbld', 04:10:17 INFO - 'LANG': 'en_US.UTF-8', 04:10:17 INFO - 'LANGUAGE': 'en_US:en', 04:10:17 INFO - 'LOGNAME': 'cltbld', 04:10:17 INFO - 'MAIL': '/var/mail/cltbld', 04:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:17 INFO - 'MOZ_NO_REMOTE': '1', 04:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:17 INFO - 'NO_EM_RESTART': '1', 04:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:17 INFO - 'PWD': '/builds/slave/test', 04:10:17 INFO - 'SHELL': '/bin/bash', 04:10:17 INFO - 'SHLVL': '1', 04:10:17 INFO - 'TERM': 'linux', 04:10:17 INFO - 'TMOUT': '86400', 04:10:17 INFO - 'USER': 'cltbld', 04:10:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:17 INFO - '_': '/tools/buildbot/bin/python'} 04:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:17 INFO - Running setup.py (path:/tmp/pip-fPDoue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:18 INFO - Running setup.py (path:/tmp/pip-OxoxvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:18 INFO - Running setup.py (path:/tmp/pip-UoG65T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:18 INFO - Running setup.py (path:/tmp/pip-tVmdIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:18 INFO - Running setup.py (path:/tmp/pip-47q044-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:18 INFO - Running setup.py (path:/tmp/pip-Abc11c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:18 INFO - Running setup.py (path:/tmp/pip-Z1QWJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:18 INFO - Running setup.py (path:/tmp/pip-yjLbUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:18 INFO - Running setup.py (path:/tmp/pip-j4AQr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:18 INFO - Running setup.py (path:/tmp/pip-Zx6KZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:18 INFO - Running setup.py (path:/tmp/pip-N61Xkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:18 INFO - Running setup.py (path:/tmp/pip-uFMANV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:18 INFO - Running setup.py (path:/tmp/pip-CyfV1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:18 INFO - Running setup.py (path:/tmp/pip-70Yo0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:18 INFO - Running setup.py (path:/tmp/pip-Z3VCOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:19 INFO - Running setup.py (path:/tmp/pip-iMKczd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:19 INFO - Running setup.py (path:/tmp/pip-PwwHE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:19 INFO - Running setup.py install for manifestparser 04:10:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:19 INFO - Running setup.py install for mozcrash 04:10:19 INFO - Running setup.py install for mozdebug 04:10:19 INFO - Running setup.py install for mozdevice 04:10:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:19 INFO - Running setup.py install for mozfile 04:10:19 INFO - Running setup.py install for mozhttpd 04:10:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:19 INFO - Running setup.py install for mozinfo 04:10:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:19 INFO - Running setup.py install for mozInstall 04:10:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Running setup.py install for mozleak 04:10:20 INFO - Running setup.py install for mozlog 04:10:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Running setup.py install for moznetwork 04:10:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Running setup.py install for mozprocess 04:10:20 INFO - Running setup.py install for mozprofile 04:10:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Running setup.py install for mozrunner 04:10:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Running setup.py install for mozscreenshot 04:10:20 INFO - Running setup.py install for moztest 04:10:20 INFO - Running setup.py install for mozversion 04:10:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:20 INFO - Cleaning up... 04:10:20 INFO - Return code: 0 04:10:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:20 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 04:10:20 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 04:10:20 INFO - Using env: {'DISPLAY': ':0', 04:10:20 INFO - 'HOME': '/home/cltbld', 04:10:20 INFO - 'LANG': 'en_US.UTF-8', 04:10:20 INFO - 'LANGUAGE': 'en_US:en', 04:10:20 INFO - 'LOGNAME': 'cltbld', 04:10:20 INFO - 'MAIL': '/var/mail/cltbld', 04:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:20 INFO - 'MOZ_NO_REMOTE': '1', 04:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:20 INFO - 'NO_EM_RESTART': '1', 04:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:20 INFO - 'PWD': '/builds/slave/test', 04:10:20 INFO - 'SHELL': '/bin/bash', 04:10:20 INFO - 'SHLVL': '1', 04:10:21 INFO - 'TERM': 'linux', 04:10:21 INFO - 'TMOUT': '86400', 04:10:21 INFO - 'USER': 'cltbld', 04:10:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:21 INFO - '_': '/tools/buildbot/bin/python'} 04:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:21 INFO - Running setup.py (path:/tmp/pip-Del_jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:21 INFO - Running setup.py (path:/tmp/pip-PssNCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:21 INFO - Running setup.py (path:/tmp/pip-VNahBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:21 INFO - Running setup.py (path:/tmp/pip-jHQ838-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:21 INFO - Running setup.py (path:/tmp/pip-YgnWSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:21 INFO - Running setup.py (path:/tmp/pip-UMTvvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:21 INFO - Running setup.py (path:/tmp/pip-4c8g5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:21 INFO - Running setup.py (path:/tmp/pip-vhFyEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:21 INFO - Running setup.py (path:/tmp/pip-QArHvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:21 INFO - Running setup.py (path:/tmp/pip-Y3TePd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:21 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)) 04:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:21 INFO - Running setup.py (path:/tmp/pip-8nNNIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:22 INFO - Running setup.py (path:/tmp/pip-mnt7ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:22 INFO - Running setup.py (path:/tmp/pip-YPogqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:22 INFO - Running setup.py (path:/tmp/pip-IGsNll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:22 INFO - Running setup.py (path:/tmp/pip-1A4kn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:22 INFO - Running setup.py (path:/tmp/pip-UpsN7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:22 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)) 04:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:22 INFO - Running setup.py (path:/tmp/pip-Fc4TKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:22 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)) 04:10:22 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)) 04:10:22 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)) 04:10:22 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)) 04:10:22 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)) 04:10:22 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)) 04:10:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:24 INFO - Downloading blessings-1.6.tar.gz 04:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:24 INFO - Installing collected packages: blessings 04:10:24 INFO - Running setup.py install for blessings 04:10:24 INFO - Successfully installed blessings 04:10:24 INFO - Cleaning up... 04:10:24 INFO - Return code: 0 04:10:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:24 INFO - Reading from file tmpfile_stdout 04:10:24 INFO - Current package versions: 04:10:24 INFO - argparse == 1.2.1 04:10:24 INFO - blessings == 1.6 04:10:24 INFO - blobuploader == 1.2.4 04:10:24 INFO - docopt == 0.6.1 04:10:24 INFO - functools32 == 3.2.3-2 04:10:24 INFO - jsonschema == 2.5.1 04:10:24 INFO - manifestparser == 1.1 04:10:24 INFO - mozInstall == 1.12 04:10:24 INFO - mozcrash == 0.17 04:10:24 INFO - mozdebug == 0.1 04:10:24 INFO - mozdevice == 0.48 04:10:24 INFO - mozfile == 1.2 04:10:24 INFO - mozhttpd == 0.7 04:10:24 INFO - mozinfo == 0.9 04:10:24 INFO - mozleak == 0.1 04:10:24 INFO - mozlog == 3.2 04:10:24 INFO - moznetwork == 0.27 04:10:24 INFO - mozprocess == 0.22 04:10:24 INFO - mozprofile == 0.28 04:10:24 INFO - mozrunner == 6.11 04:10:24 INFO - mozscreenshot == 0.1 04:10:24 INFO - mozsystemmonitor == 0.3 04:10:24 INFO - moztest == 0.7 04:10:24 INFO - mozversion == 1.4 04:10:24 INFO - psutil == 3.1.1 04:10:24 INFO - requests == 1.2.3 04:10:24 INFO - wsgiref == 0.1.2 04:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:24 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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:24 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 04:10:24 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 04:10:24 INFO - Using env: {'DISPLAY': ':0', 04:10:24 INFO - 'HOME': '/home/cltbld', 04:10:24 INFO - 'LANG': 'en_US.UTF-8', 04:10:24 INFO - 'LANGUAGE': 'en_US:en', 04:10:24 INFO - 'LOGNAME': 'cltbld', 04:10:24 INFO - 'MAIL': '/var/mail/cltbld', 04:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:24 INFO - 'MOZ_NO_REMOTE': '1', 04:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:24 INFO - 'NO_EM_RESTART': '1', 04:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:24 INFO - 'PWD': '/builds/slave/test', 04:10:24 INFO - 'SHELL': '/bin/bash', 04:10:24 INFO - 'SHLVL': '1', 04:10:24 INFO - 'TERM': 'linux', 04:10:24 INFO - 'TMOUT': '86400', 04:10:24 INFO - 'USER': 'cltbld', 04:10:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:24 INFO - '_': '/tools/buildbot/bin/python'} 04:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 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)) 04:10:25 INFO - Cleaning up... 04:10:25 INFO - Return code: 0 04:10:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:25 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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:25 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 04:10:25 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 04:10:25 INFO - Using env: {'DISPLAY': ':0', 04:10:25 INFO - 'HOME': '/home/cltbld', 04:10:25 INFO - 'LANG': 'en_US.UTF-8', 04:10:25 INFO - 'LANGUAGE': 'en_US:en', 04:10:25 INFO - 'LOGNAME': 'cltbld', 04:10:25 INFO - 'MAIL': '/var/mail/cltbld', 04:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:25 INFO - 'MOZ_NO_REMOTE': '1', 04:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:25 INFO - 'NO_EM_RESTART': '1', 04:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:25 INFO - 'PWD': '/builds/slave/test', 04:10:25 INFO - 'SHELL': '/bin/bash', 04:10:25 INFO - 'SHLVL': '1', 04:10:25 INFO - 'TERM': 'linux', 04:10:25 INFO - 'TMOUT': '86400', 04:10:25 INFO - 'USER': 'cltbld', 04:10:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:25 INFO - '_': '/tools/buildbot/bin/python'} 04:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:25 INFO - Cleaning up... 04:10:25 INFO - Return code: 0 04:10:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:25 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 0x7fd1443fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, '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': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:10:25 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 04:10:25 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 04:10:25 INFO - Using env: {'DISPLAY': ':0', 04:10:25 INFO - 'HOME': '/home/cltbld', 04:10:25 INFO - 'LANG': 'en_US.UTF-8', 04:10:25 INFO - 'LANGUAGE': 'en_US:en', 04:10:25 INFO - 'LOGNAME': 'cltbld', 04:10:25 INFO - 'MAIL': '/var/mail/cltbld', 04:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:25 INFO - 'MOZ_NO_REMOTE': '1', 04:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:25 INFO - 'NO_EM_RESTART': '1', 04:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:25 INFO - 'PWD': '/builds/slave/test', 04:10:25 INFO - 'SHELL': '/bin/bash', 04:10:25 INFO - 'SHLVL': '1', 04:10:25 INFO - 'TERM': 'linux', 04:10:25 INFO - 'TMOUT': '86400', 04:10:25 INFO - 'USER': 'cltbld', 04:10:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:25 INFO - '_': '/tools/buildbot/bin/python'} 04:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:25 INFO - Downloading/unpacking flake8 04:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:28 INFO - no previously-included directories found matching 'docs/_build' 04:10:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:28 INFO - Running setup.py install for pep8 04:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:28 INFO - no previously-included directories found matching 'docs/_build' 04:10:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:28 INFO - Cleaning up... 04:10:28 INFO - Return code: 0 04:10:28 INFO - Running post-action listener: _resource_record_post_action 04:10:28 INFO - Running post-action listener: _start_resource_monitoring 04:10:28 INFO - Starting resource monitoring. 04:10:28 INFO - ##### 04:10:28 INFO - ##### Finished create-virtualenv step (success) 04:10:28 INFO - ##### 04:10:28 INFO - ##### 04:10:28 INFO - ##### Running install step. 04:10:28 INFO - ##### 04:10:28 INFO - Running pre-action listener: _resource_record_pre_action 04:10:28 INFO - Running main action method: install 04:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:28 INFO - Reading from file tmpfile_stdout 04:10:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:28 INFO - Reading from file tmpfile_stdout 04:10:28 INFO - Output received: 04:10:28 INFO - Usage: mozinstall [options] installer 04:10:28 INFO - Options: 04:10:28 INFO - -h, --help show this help message and exit 04:10:28 INFO - -d DEST, --destination=DEST 04:10:28 INFO - Directory to install application into. [default: 04:10:28 INFO - "/builds/slave/test"] 04:10:28 INFO - --app=APP Application being installed. [default: firefox] 04:10:28 INFO - mkdir: /builds/slave/test/build/application 04:10:28 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'] 04:10:28 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 04:10:44 INFO - Reading from file tmpfile_stdout 04:10:44 INFO - Output received: 04:10:44 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:44 INFO - Running post-action listener: _resource_record_post_action 04:10:44 INFO - ##### 04:10:44 INFO - ##### Finished install step (success) 04:10:44 INFO - ##### 04:10:44 INFO - ##### 04:10:44 INFO - ##### Running run-tests step. 04:10:44 INFO - ##### 04:10:44 INFO - Running pre-action listener: _resource_record_pre_action 04:10:44 INFO - Running main action method: run_tests 04:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:44 INFO - Python 2.7.3 04:10:44 INFO - Return code: 0 04:10:44 INFO - grabbing minidump binary from tooltool 04:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:44 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 0x17de2e0>, '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 0x174a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:44 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 04:10:44 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 04:10:44 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 04:10:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:44 INFO - Return code: 0 04:10:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:10:45 INFO - Return code: 0 04:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 04:10:45 INFO - Using env: {'DISPLAY': ':0', 04:10:45 INFO - 'HOME': '/home/cltbld', 04:10:45 INFO - 'LANG': 'en_US.UTF-8', 04:10:45 INFO - 'LANGUAGE': 'en_US:en', 04:10:45 INFO - 'LOGNAME': 'cltbld', 04:10:45 INFO - 'MAIL': '/var/mail/cltbld', 04:10:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:45 INFO - 'MOZ_NO_REMOTE': '1', 04:10:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:45 INFO - 'NO_EM_RESTART': '1', 04:10:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:45 INFO - 'PWD': '/builds/slave/test', 04:10:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:45 INFO - 'SHELL': '/bin/bash', 04:10:45 INFO - 'SHLVL': '1', 04:10:45 INFO - 'TERM': 'linux', 04:10:45 INFO - 'TMOUT': '86400', 04:10:45 INFO - 'USER': 'cltbld', 04:10:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466506792.165797-125668021', 04:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:45 INFO - '_': '/tools/buildbot/bin/python'} 04:10:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:10:46 INFO - mozversion application_buildid: 20160621025705 04:10:46 INFO - mozversion application_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 04:10:46 INFO - mozversion application_display_name: Nightly 04:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:46 INFO - mozversion application_name: Firefox 04:10:46 INFO - mozversion application_remotingname: firefox 04:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:10:46 INFO - mozversion application_vendor: Mozilla 04:10:46 INFO - mozversion application_version: 50.0a1 04:10:46 INFO - mozversion platform_buildid: 20160621025705 04:10:46 INFO - mozversion platform_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 04:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:10:46 INFO - mozversion platform_version: 50.0a1 04:10:46 INFO - using testdate: 1466507446 04:10:46 INFO - actual date: 1466507446 04:10:46 INFO - starting webserver on 'localhost:57371' 04:10:46 INFO - SUITE-START | Running 2 tests 04:10:46 INFO - TEST-START | dromaeo_css 04:10:46 INFO - operating with platform_type : linux_ 04:10:46 INFO - Initialising browser for dromaeo_css test... 04:10:46 INFO - TEST-INFO | started process 21859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzDb9k/profile http://localhost:57371/getInfo.html) 04:10:53 INFO - PROCESS | 21859 | __metrics Screen width/height:1600/1200 04:10:53 INFO - PROCESS | 21859 | colorDepth:24 04:10:53 INFO - PROCESS | 21859 | Browser inner width/height: 1024/697 04:10:53 INFO - PROCESS | 21859 | __metrics 04:10:54 ERROR - PROCESS | 21859 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:10:55 INFO - TEST-INFO | 21859: exit 0 04:10:55 INFO - Browser initialized. 04:10:55 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:55 INFO - TEST-INFO | started process 21976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzDb9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:07 INFO - PROCESS | 21976 | RSS: Main: 186044416 04:11:07 INFO - PROCESS | 21976 | 04:11:56 INFO - PROCESS | 21976 | 1466507516872 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] 04:14:09 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57371/tests/dromaeo/cssquery-ext.html) 04:14:10 INFO - PROCESS | 21976 | RSS: Main: 189005824 04:14:10 INFO - PROCESS | 21976 | 04:17:12 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-ext.html (next: http://localhost:57371/tests/dromaeo/cssquery-jquery.html) 04:17:13 INFO - PROCESS | 21976 | RSS: Main: 188346368 04:17:13 INFO - PROCESS | 21976 | 04:20:15 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57371/tests/dromaeo/cssquery-mootools.html) 04:20:15 INFO - PROCESS | 21976 | RSS: Main: 189091840 04:20:15 INFO - PROCESS | 21976 | 04:23:17 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57371/tests/dromaeo/cssquery-prototype.html) 04:23:18 INFO - PROCESS | 21976 | RSS: Main: 186683392 04:23:18 INFO - PROCESS | 21976 | 04:26:21 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57371/tests/dromaeo/cssquery-yui.html) 04:26:21 INFO - PROCESS | 21976 | RSS: Main: 189034496 04:26:21 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-yui.html (next: http://localhost:57371/tests/dromaeo/cssquery-dojo.html) 04:29:24 INFO - PROCESS | 21976 | RSS: Main: 189710336 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | __start_tp_report 04:29:24 INFO - PROCESS | 21976 | _x_x_mozilla_page_load 04:29:24 INFO - PROCESS | 21976 | _x_x_mozilla_page_load_details 04:29:24 INFO - PROCESS | 21976 | |i|pagename|runs| 04:29:24 INFO - PROCESS | 21976 | |0;dojo.html;2566.55085360062;2647.9735202647967;2661.3878807874203;2665.413609006018;2674.759271665551;4637.165310244159;4681.4616319123315;4698.27176787598;4745.833895813647;4783.593394561466;4535.841245556406;4650.883727906804;4665.556772106653;4673.415823022122;4680.3447517347595;4229.259879521087;4354.738715677054;4369.344598310263;4373.868783936487;4409.691321607489;606.6409659329828;4188.979055104735;4276.914461710764;4286.892827679318;4308.612224899758;4249.405083288342;4278.957210427887;4282;4309.35359696045;4353.303471444554;4186.120914607936;4261.829526818955;4287.678424118204;4314.935275970863;4344.1311737652595;4241.639460645849;4264;4266.594673506043;4271.060366719316;4287;4675.4155730533685;4685.835995740167;4719.528047195287;4724.574788269072;4781.737004464753;5037.345145131109;5037.874053148664;5045.823396181116;5047.192449208146;5098.439171691111;5075.365579302587;5152.562032227265;5157.5616072633875;5163.870903227412;5195.506426889439;4737.763111844429;4748.264019077049;4772;4775.808967641325;4798.736069516175;5100.821471248489;5172.8965420691375;5184;5207.062728708869;5275.788968441219;5004.299398084271;5017.523335283142;5019.0463811875625;5037.848864534069;5069.188929771219;5079.466656001066;5096.184610462383;5103.948960510347;5112.130937740593;5113.335266415343;4858.514148585114;4939.481354457802;4948.38145231846;4992;5039.4708555601865;4845.418549773979;4848.12733707936;4886.364772579542;4888.926666100011;4930.926036109389;4127.628513433805;4163.250614889288;4166.395872598457;4207.8316867325575;4214.936775948363;3676.3015027144756;3693.7414380993073;3700.703943684499;3704.444333350019;3742.700583953277;4426.911461770746;4441.444819397575;4455.643548516111;4456.286994080931;4502.122086193226;5123.38519377677;5147.6654017488745;5168.250603662448;5177.7152256625495;5223.869403264873;4284.057507348379;4394.252976993855;4403.119376124788;4406.383106365111;4449.377087207794;4499.52754960731;4533.433320834895;4551.749653769075;4552.772361381918;4590.380298659638;4816.975915120402;4820.3492528508905;4828.106800241966;4828.324034635084;4903.117438860968;4927.852164435073;5078.56832169255;5109.437961824271;5129.92305115431;5139.691618502902;4815.205491094071;4823.589994850477;4836.298736683231;4836.960053588496;4886.193778026586;4925.285833554186;5052.8484145475695;5054.444011158843;5059.519345662156;5105.566026887756;5042.092423363683;5062.417821950523;5068.493150684902;5080.720560369067;5084.3644544431945;4944.653874228769;4959.776810043484;4964.05682920244;4969.701817890938;4979.850604481871;4857.514248575114;4872.975635121802;4945.431275403231;4968.652194346361;5007.298978143136;4644.210484217623;4737.881552961204;4790.4251489821445;4812.783424745965;4857.805687772449;4916.508349165198;4917.9016419672125;4923.236898280772;4941.308216849572;4945.554900059012;4783.354247176587;4859.757012149449;4866.95133048665;4870.878228044327;4917.877053073702 04:29:24 INFO - PROCESS | 21976 | |1;ext.html;550.7937616619603;587.2747157260782;592.8606777407311;597.4145337569182;604.9909251361229;38978.99999999996;40069;40079.198416031664;40128.19743605126;43219.567804321945;39891.20217595654;40091.59908400923;40234.39648405276;40426.595734042654;40574.18851622966;7902.288794008552;8015.1984801519675;8035.758927232192;8046.316063134641;8055.073666528366;7978.122406535305;8021.839563208732;8023.31801796848;8040.075391329984;8040.517568945882;8000.719974800883;8073.515589064646;8093.069297030858;8097.392695547828;8100.068492123393;8019.558924259134;8058.033036035684;8083.474574152661;8097.2712455879255;8099;7891.368690504746;7916;7936.563489008102;7960.562169080698;7969.960150199212;38308.233835323415;38358.23283534314;38400.231995359936;38448.80775596132;38562;2835.7447829695425;2859.4995875721875;2965.525515917443;3063.3720087382035;3294.9291480269007;28739.856300718362;29028.12915612535;29064.564031539543;29337.266568335748;30022;3196.8721251149927;3199.520071989197;3224.67753224678;3310.337932413527;3449.862005519776;255912;258118;258506;258560.9999999981;260088;31561;32587.674123258465;50242.748786255834;50914.65396133427;51266.48733512617;34091.4886276706;34214.82892585521;34228.48657270143;34325.485117723256;34350.82824585861;12278.079144064051;12493.93753031229;12498.812517812241;12507.06197035226;12530.81203781944;9774.16919561831;9806.460644664468;9910.55402506889;9915.702528924;9927.602895884229;7903.328217101611;7912.248336408032;7951.443398962017;7963.0842453117475;7974.043114826258;3063.341381602966;3103.7827352085137;3106.2079169811554;3106.9378612427627;3135.263213144909;823.4647479138608;853.8676505141713;870.760540851271;950.5722424908819;958.1616085924816;26669.866650666623;27400.72599273982;28045.71954280472;28070.578941315896;28187.15438536847;875.6584931876573;890.2655309369667;933.5985526223789;934.9719508414759;981.1169947047714;14437.20595367244;14651.560453186421;14764.187969661773;14818.92590537062;15082.698346033018;400621;417449;418169;418608;419740;47437.76281118573;49024.754876225394;49239.507604924205;49459;49513;1136.6590022993068;1158.9826152607718;1162;1165.9825102623468;1186.9228500147462;25927.222183333775;26797.33006674771;26825.597616035386;27491.725082749716;27632.723672763015;40492.797536012135;40817.59182408138;40993.59006409898;41002.79498602607;41022.38466423066;344559;346669;350864;353179;353294;25031.249062528153;25166.874165629055;25647.743522564535;25990.87004564965;26096.086636967615;41047.1790564193;41225.79387103045;41279;41308.1738365225;42241.57758422376;36084.09789755172;36258.09354766152;36390;36423.63576364202;36740;34845.825770870986;35320;35352.29295414129;35554;36041.279174416886;30932;35229.29541409106;35574.28851423009;36142;36275.27449450943;29493.115206543836;29900.70099298979;30323.545146823257;30327.848360758057;30355.696443035285;25265.62101568515;25733.871330643975;25739;25940.22179334623;26078.73921260839 04:29:24 INFO - PROCESS | 21976 | |2;jquery.html;359.656528015745;371.9702423806096;373.13618972079644;382.35954775750645;389.1069994362937;15543.378264869405;16188.919055404707;16705.415310464105;16738.246778894947;16738.330466781328;15253.6949261015;15718.764218536702;16136.112513811735;16149.192540372964;16173.19134043299;5066.442691303944;5207.4792520747815;5222.843314700565;5253.842384728464;5258.55302299305;3762.7366084374103;5169.793208271664;5774;6060.030395136779;6060.727267272983;6064.9696751516185;6081.6351018938785;6112;6119.6328220306705;6148.723307451175;4828.493008234138;5121.974390128025;5133.691978481284;5141.871453213681;5224.686518808883;4426.889327766799;4729.912120212336;4759.547842954914;5027.949720502785;5032.043911656773;11546;11937;12083.818742718866;12110.910018098413;12256.693582660504;1910.1595298068805;2038.2458490358515;2105.4420578546697;2273.8294627902974;2394.7851780865626;8309.169083091643;8624.568771561397;8634.697785577537;8730.825383492294;8937.106289371075;1606.2691475378792;1635.893666911647;1693.9153042347834;1706.445405243301;1741.6690828742499;66322;66407.33592664108;66902;67161.32838671649;70086;8346.791330216793;8768.123187681182;8866.645334186689;9089.77275568116;9095.863562046574;11376.374299413612;11515.136364772676;11551.133664975161;11588.188826782212;11588.478518466689;6620.3710647488415;6642.701078451481;6663.133792607027;6762.864742705118;6782.220044694924;6389.3291204423795;6493.740250390026;6579.736810527621;6614.140161779034;6658.1344425224415;3284.556584861061;3389.372966001248;3493.5458390409594;3655.141041855162;3710.1466662667735;1648.6620242850188;1680.5882558773178;1700.1839117223801;1751.4833124228383;1807.5842556212144;840.8570543007581;850.5534594338022;869.1091631078069;911.2573252799081;930.418488444722;16095.436659716854;16581.17094145312;16669.83330166683;16747.665046699243;16828.579285517717;830.6179157587457;833.6498670558381;840.9831803363899;874.7900503879023;895.136193573205;8999.280057595508;9285.25717942563;9352.906470935339;9631.903680963242;9765.02349765032;353347;367962;381275;385730;389640;67319.3268067313;70494.29505704877;72883.63558182176;74623;77048;905.4883990545321;923.2982932970856;928.4197376639735;951.7097285328041;955.1642312976146;15745.921270393575;15823;15864.841351586798;15925.124118173148;16320.183990800175;30086.849565752033;31393.52909706402;32751.017469475955;34674.47988280228;37853.621463785006;50270;51916.221256681936;52222;52296.47703522916;52341.7382913083;7104.751333703295;7170.928290717026;7196.604186769778;7299.05112335393;7334.486585938933;8052.194780521901;10130;11241.60654377093;11782.764344712887;12124.211926224767;9527.904720952702;10011.349262297927;10058.899411005796;10157.085862272432;10444.112250458493;10111.797764044824;10162.390256584333;10225.335353202017;10378.169746420419;10438.739031524272;10089;10301.330413523097;10416.791664166825;10430.478476076318;10448.738781530523;7129.82175445618;7200.351968322876;7209.927900720925;7312.7440539582985;7411.444141689287;7020.122484689414;8400.537970411686;10031.398116113056;10238.846417303896;10318.742031448974 04:29:24 INFO - PROCESS | 21976 | |3;mootools.html;1361.2309045389352;1390.4090761426394;1483.1546018769307;1676.597616572023;1687.5527985083947;6778.694958726856;7457.589832559207;7462.21646727094;8002.279794818465;8036.116027237006;7509.737159199429;7737.071551413824;7767.9611601941915;7801.375889928806;7801.726939557117;2173.7065496158016;2179.455136215946;2201.8550353816086;2204.261572373257;2208.4810069633622;2146.1308170191096;2158.179891641174;2182.2907555044594;2183.410479170623;2192.572448372568;2116.904739286736;2161.049138379116;2175.912963481459;2178.2049551913597;2178.4118288062214;2137.9251726189586;2150.1506904772527;2151.268568686654;2151.601953638574;2153.504693920391;2075.9481012974647;2125.5748850230016;2127.074722495704;2147.8066973972263;2158.589867925105;7784.7275345363205;7789.7273595423885;7880.211978802131;7894.368450523944;7912.525248485109;4424.469063712343;4463.754493502856;4538.704984176018;4548.977255113703;4563.566461186182;2745.4646343962936;2749.3539018330675;2860.9713902860913;2878.2228798224364;2885.5238885583854;865.9177378149066;877.2017464107695;879.907609700985;919.420764918104;925.0425809287423;10418.166546676324;10452.843207351896;10500.422476763775;10622.628208012682;10699.411532365717;4089.1003979124544;4096.139810639799;4193.7693426861815;4207.326827707613;4208.558101399371;9010.098990100938;9061.41100828444;9071.59177836999;9096;9096.8635470468;4625.699329543569;4634.096351211481;4655.720656760537;4663.323818046364;4674.97662511692;3609.783412995229;4089.6932730045364;4155.709100362946;4205.327147656421;4269.359596060615;3664.688501477351;3675.9816200918826;3764.378877485239;3793.5637401698605;3907.1404291055924;1179.6520026592175;1190.898773604236;1200.5557943560764;1204.3376143121423;1208.8186771984097;791.1534657915975;808.5835794565803;813.5810057820228;816.4040250617082;816.6855760532238;4995.475475075137;5057.620678449131;5101.51535604117;5152.742362881841;5214.8957020860125;369.78367654921635;385.49500154797306;390.2078780076449;394.445803645878;394.9447077409165;3393.185635447475;3444.3111377724554;3453.395655760232;3466.6013408457848;3479.8260086995547;9243.676471323606;9382.906170938204;9594.808103837884;9619.711408657751;9740.366876153028;9492.857607135898;9611.471369074769;9623.615055397706;9656.034396560288;9662.951685241529;7222.96388518054;7276.96361518189;7301.89047164293;7313.08586426686;7359.448041396917;5070.873228169177;5117.1300878851425;5159.09715799726;5192.299039629602;5206.843794686166;8680.262177714965;8788.2529984952;8802.163794439519;8873.201411872962;8963.103689630985;8932.419392739452;8947.150020748019;9067.818643627223;9071.138241867013;9082.772930676785;5977.491913187428;6463.903041454288;6588.967055164693;6647.235567909753;6704.530682852349;7377;7452.143003554661;7501.474896757175;7519.661615227218;7521.398288137046;6605.47156227491;6769.1876974763345;6823.317668233137;6854.760083397057;6937.340952609494;6771.492138089565;6829.6243706596615;6843.418309443753;6891.104156459628;6933.1333583302085;5954.345022047484;5970.283565972111;6015;6034.63792172471;6035.758569657341;4456;4475.9328610071525;4550.112728018004;4558.384618076518;4559.726416415026;4485.125400546862;4531.478879928719;4551.271796512675;4636.559526844944;4671.649626278111 04:29:24 INFO - PROCESS | 21976 | |4;prototype.html;305.59661247153736;308.998455007725;312.4251377465464;320.4648237443469;321.45513354863516;4745.430548334205;4770.141374552579;4901.877453063676;4946.134426475371;4980.60155187585;4856.538628830255;4870.756462176894;4891.706497610146;4894.486078961711;4909.189983652702;3875.360565506688;3908.6286802753693;3916.060145565072;3923.607639236082;3930.3711406175016;3651.6348365163535;3914.588968158345;3931.6264954829244;3941.960580394188;3955.0705584187695;3811.6950643948417;3815.6184381561898;3829.5639135324254;3839.0978120141745;3848.134169811784;3824.426336049587;3826.292135954843;3835.520559930009;3843.3658446356317;3871.9032024199337;3233.757468189895;3381.357542067024;3389;3414.7609667323295;3425.1265927188656;4822.710637361734;4834.7824347904425;4844.806207751686;4847.878803029917;4872.196087645534;4418.602325790662;4419.270820314644;4421.9336709949375;4450.1767173073085;4486.304622783474;4973.204287314049;5176.352955880515;5197.870053248661;5239.375793503988;5277.182036784305;3821.48409964654;3830.253100645375;3843.9231215375817;3848.2111167210655;3849.2301539692176;5424.0744535690055;5460.153676180238;5500.50495455407;5504.311961004874;5512.972435137839;3703.8703645372284;3948.7038472114705;3952.4268980997595;3952.7233093683167;3966.3058964681063;3937.527496700357;3950.4198320671385;3958.960410395917;3975.6024397560013;3980.920381592352;4436.201483732894;4437.489688685778;4440.134173836135;4452.732836029849;4520.547945205453;5170;5200.5059519345605;5254.343207099113;5266.947330526722;5267.973660131752;1260.6692085522839;1378.696686728918;1382.4884792626592;1391.2348208485294;1392.610069180631;887.5961437545901;890.5725251879005;902.1654969153507;907.8243674441615;918.1874041473344;4115.456703736099;4129.215449064668;4133.545310015896;4155.358633339813;4192.413062171298;4761.547652972962;4813.302071199656;4827.300041493963;4847.660663753574;4847.878803029882;4119.8970025749595;4128.731632443882;4185.686073544496;4194.839657576351;4199.202151591249;2473.7773600376054;2545.1855406269815;2547.286759707285;2555.7349112189213;2580.3291144302616;4544.500104988449;4571.542845715402;4582.9541704582525;4593.425821772278;4616.722996620147;4914.65597408178;4920.3111564381015;4945.258211268267;4950.752462376867;4957.231629097496;4378.868633940987;4468.731876087445;4475.30632751924;4483.417155769729;4569.360289559464;4697.718136911796;4741.857744267678;4759.214729569582;4779.95220047809;4797.232442809134;4619.891226105643;4623.953760462487;4672.813087476598;4687.968646897677;4731.858044258678;4214.978925105354;4479.328100784778;4509.503954565061;4519.774011299488;4521.806923641965;3561.0563200751303;3574.410222313289;3581.6955558777795;3585.247098109426;3598.8946466317498;4722.834700785456;4757;4762.9523704762505;4831.830885918976;5167.328247327823;5093.668911520739;5160.535551800356;5207.817726379559;5236.842894713165;5245.527902488794;5183.688978661293;5218.112920803548;5225.372955245395;5241.737913104405;5246.658967167122;4937.679050861826;5129.769160387867;5147.485251474823;5206.297149884717;5211.765470553758;5326.707031113326;5329.147336426153;5330.813421530228;5346.7059311736675;5351.919721204107;5131.409887862944;5180.274761533313;5214.400343960493;5219.399769026459;5223.399309079505 04:29:24 INFO - PROCESS | 21976 | |5;yui.html;647.4205586000527;653.6013032050452;706.152616859768;730.7990302666767;736.4255880413277;12725;13295.667608309785;13332.266725330102;14393.208373539477;14974;14610.269486525684;14920.776188357157;14936.925315373435;14939.178345191038;14964.102153870748;632.0203684289356;796.6654005317752;809.550699361854;810.6635746165334;810.841885832263;780.1184661332715;796.1918652567648;803.116571771053;803.907550631676;804.505229283989;817.5503473089807;824.4435006370705;833.4207725630689;836.3601844588894;838.0990435282066;822.5475988206463;823.9876401853948;826.6114925984778;828.8798124271977;829.854775414303;605.2313561776563;605.5186127029023;609.704293417692;610.5695484683288;611.0864257934372;13509;13613.659658508517;13616.591502254849;13640.113392629546;13647;12411.813822792665;12857.90707789839;12863.356832158355;13034.478620855154;13073.934630326883;10335.638252661196;10598.682039538826;10629.73425664357;10654.62708805188;10689.518971646217;3318;3352.0614228016193;3354.630990591033;3387.356402283583;3412.6416726243633;59181;59570.10644840331;59720.10419843706;59767.103493447634;59787.40212597862;10119.342242754197;10143.949280253699;10196.541155648014;10257.897421025844;10298.330608510423;18555;18641.347552835585;18723.344682936306;18750.1562429691;19325.226990920204;7097.290270972965;7108.111486064242;7172.031775710212;7181.7486387977215;7276.890846637305;3832.827522761482;3941.4481972523868;3950.9604903951167;3962.881113566598;3965.643092121723;2914.198595386243;3000.609920710294;3001.1146711720094;3017.909462716122;3032.120685001369;511.7722613437059;516.2772119033308;517.2319106127397;521.0698902459093;524.3393324411193;435.42741295197345;441.89173652455355;488.4236600811006;507.84510724228727;521.317074632233;7444.404447644176;7481.738139165212;7668.156502784689;7670.578118203441;7776.339011184113;493.58538827385166;545.6671430427436;552.8175702018324;553.6346011632303;562.5977426140329;3933.8819835404984;4322.265214913472;4450.265706158512;4497.64018878489;4521.118381915495;57904.71047644735;58008;94857.41140708726;102678.48660756797;104349;85980;90205;90225.54887225523;91204;92107.53946230226;48838.511614884104;71814.64092679607;73720.26279737242;73728.26271737322;73777.26222737812;8510.574471276535;8632.482051076955;8665.393422460367;8678.175573320525;8749.300055995378;42676.78661606672;43132;43269.78365108154;43559;44359.55640443684;63999;67000.6649966747;67369;67384;67962.3203767956;10860.131189504662;11147.219694621299;11256.549738010388;11295.265807722471;11442.313461192354;12371.69070773202;12848.293343866177;12939.805902911652;12960.416781245056;12968.805467918177;12040.939795300967;12460.234089902044;12595.811062834247;12677.798392084003;12879.613611591667;11461.541538338373;11780.52877884875;11870.525178992744;12247.816282755588;12372.690682732644;11389.829152562885;11728.41357932117;11989.700257493632;12020.63938081859;12054.276743395425;9564.713058608253;10352;10387.729903154375;10417.16662667;10447.529861156114;9400.219510620407;10069.345492542961;10099.63947545675;10294.639687610897;10431.947840261053 04:29:24 INFO - PROCESS | 21976 | __end_tp_report 04:29:24 INFO - PROCESS | 21976 | __start_cc_report 04:29:24 INFO - PROCESS | 21976 | _x_x_mozilla_cycle_collect,386 04:29:24 INFO - PROCESS | 21976 | __end_cc_report 04:29:24 INFO - PROCESS | 21976 | __startTimestamp1466508564588__endTimestamp 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | ------- Summary: start ------- 04:29:24 INFO - PROCESS | 21976 | Number of tests: 6 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#0] dojo.html Cycles:165 Average:4645.65 Median:4823.59 stddev:594.50 (12.3%) stddev-sans-first:573.51 04:29:24 INFO - PROCESS | 21976 | Values: 2566.6 2648.0 2661.4 2665.4 2674.8 4637.2 4681.5 4698.3 4745.8 4783.6 4535.8 4650.9 4665.6 4673.4 4680.3 4229.3 4354.7 4369.3 4373.9 4409.7 606.6 4189.0 4276.9 4286.9 4308.6 4249.4 4279.0 4282.0 4309.4 4353.3 4186.1 4261.8 4287.7 4314.9 4344.1 4241.6 4264.0 4266.6 4271.1 4287.0 4675.4 4685.8 4719.5 4724.6 4781.7 5037.3 5037.9 5045.8 5047.2 5098.4 5075.4 5152.6 5157.6 5163.9 5195.5 4737.8 4748.3 4772.0 4775.8 4798.7 5100.8 5172.9 5184.0 5207.1 5275.8 5004.3 5017.5 5019.0 5037.8 5069.2 5079.5 5096.2 5103.9 5112.1 5113.3 4858.5 4939.5 4948.4 4992.0 5039.5 4845.4 4848.1 4886.4 4888.9 4930.9 4127.6 4163.3 4166.4 4207.8 4214.9 3676.3 3693.7 3700.7 3704.4 3742.7 4426.9 4441.4 4455.6 4456.3 4502.1 5123.4 5147.7 5168.3 5177.7 5223.9 4284.1 4394.3 4403.1 4406.4 4449.4 4499.5 4533.4 4551.7 4552.8 4590.4 4817.0 4820.3 4828.1 4828.3 4903.1 4927.9 5078.6 5109.4 5129.9 5139.7 4815.2 4823.6 4836.3 4837.0 4886.2 4925.3 5052.8 5054.4 5059.5 5105.6 5042.1 5062.4 5068.5 5080.7 5084.4 4944.7 4959.8 4964.1 4969.7 4979.9 4857.5 4873.0 4945.4 4968.7 5007.3 4644.2 4737.9 4790.4 4812.8 4857.8 4916.5 4917.9 4923.2 4941.3 4945.6 4783.4 4859.8 4867.0 4870.9 4917.9 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#1] ext.html Cycles:180 Average:47799.33 Median:36581.82 stddev:91825.22 (251.0%) stddev-sans-first:92014.29 04:29:24 INFO - PROCESS | 21976 | Values: 550.8 587.3 592.9 597.4 605.0 38979.0 40069.0 40079.2 40128.2 43219.6 39891.2 40091.6 40234.4 40426.6 40574.2 7902.3 8015.2 8035.8 8046.3 8055.1 7978.1 8021.8 8023.3 8040.1 8040.5 8000.7 8073.5 8093.1 8097.4 8100.1 8019.6 8058.0 8083.5 8097.3 8099.0 7891.4 7916.0 7936.6 7960.6 7970.0 38308.2 38358.2 38400.2 38448.8 38562.0 2835.7 2859.5 2965.5 3063.4 3294.9 28739.9 29028.1 29064.6 29337.3 30022.0 3196.9 3199.5 3224.7 3310.3 3449.9 255912.0 258118.0 258506.0 258561.0 260088.0 31561.0 32587.7 50242.7 50914.7 51266.5 34091.5 34214.8 34228.5 34325.5 34350.8 12278.1 12493.9 12498.8 12507.1 12530.8 9774.2 9806.5 9910.6 9915.7 9927.6 7903.3 7912.2 7951.4 7963.1 7974.0 3063.3 3103.8 3106.2 3106.9 3135.3 823.5 853.9 870.8 950.6 958.2 26669.9 27400.7 28045.7 28070.6 28187.2 875.7 890.3 933.6 935.0 981.1 14437.2 14651.6 14764.2 14818.9 15082.7 400621.0 417449.0 418169.0 418608.0 419740.0 47437.8 49024.8 49239.5 49459.0 49513.0 1136.7 1159.0 1162.0 1166.0 1186.9 25927.2 26797.3 26825.6 27491.7 27632.7 40492.8 40817.6 40993.6 41002.8 41022.4 344559.0 346669.0 350864.0 353179.0 353294.0 25031.2 25166.9 25647.7 25990.9 26096.1 41047.2 41225.8 41279.0 41308.2 42241.6 36084.1 36258.1 36390.0 36423.6 36740.0 34845.8 35320.0 35352.3 35554.0 36041.3 30932.0 35229.3 35574.3 36142.0 36275.3 29493.1 29900.7 30323.5 30327.8 30355.7 25265.6 25733.9 25739.0 25940.2 26078.7 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#2] jquery.html Cycles:180 Average:23129.45 Median:4928.22 stddev:62095.71 (1260.0%) stddev-sans-first:62246.37 04:29:24 INFO - PROCESS | 21976 | Values: 359.7 372.0 373.1 382.4 389.1 15543.4 16188.9 16705.4 16738.2 16738.3 15253.7 15718.8 16136.1 16149.2 16173.2 5066.4 5207.5 5222.8 5253.8 5258.6 3762.7 5169.8 5774.0 6060.0 6060.7 6065.0 6081.6 6112.0 6119.6 6148.7 4828.5 5122.0 5133.7 5141.9 5224.7 4426.9 4729.9 4759.5 5027.9 5032.0 11546.0 11937.0 12083.8 12110.9 12256.7 1910.2 2038.2 2105.4 2273.8 2394.8 8309.2 8624.6 8634.7 8730.8 8937.1 1606.3 1635.9 1693.9 1706.4 1741.7 66322.0 66407.3 66902.0 67161.3 70086.0 8346.8 8768.1 8866.6 9089.8 9095.9 11376.4 11515.1 11551.1 11588.2 11588.5 6620.4 6642.7 6663.1 6762.9 6782.2 6389.3 6493.7 6579.7 6614.1 6658.1 3284.6 3389.4 3493.5 3655.1 3710.1 1648.7 1680.6 1700.2 1751.5 1807.6 840.9 850.6 869.1 911.3 930.4 16095.4 16581.2 16669.8 16747.7 16828.6 830.6 833.6 841.0 874.8 895.1 8999.3 9285.3 9352.9 9631.9 9765.0 353347.0 367962.0 381275.0 385730.0 389640.0 67319.3 70494.3 72883.6 74623.0 77048.0 905.5 923.3 928.4 951.7 955.2 15745.9 15823.0 15864.8 15925.1 16320.2 30086.8 31393.5 32751.0 34674.5 37853.6 50270.0 51916.2 52222.0 52296.5 52341.7 7104.8 7170.9 7196.6 7299.1 7334.5 8052.2 10130.0 11241.6 11782.8 12124.2 9527.9 10011.3 10058.9 10157.1 10444.1 10111.8 10162.4 10225.3 10378.2 10438.7 10089.0 10301.3 10416.8 10430.5 10448.7 7129.8 7200.4 7209.9 7312.7 7411.4 7020.1 8400.5 10031.4 10238.8 10318.7 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#3] mootools.html Cycles:180 Average:5082.54 Median:5026.55 stddev:2879.38 (57.3%) stddev-sans-first:2873.88 04:29:24 INFO - PROCESS | 21976 | Values: 1361.2 1390.4 1483.2 1676.6 1687.6 6778.7 7457.6 7462.2 8002.3 8036.1 7509.7 7737.1 7768.0 7801.4 7801.7 2173.7 2179.5 2201.9 2204.3 2208.5 2146.1 2158.2 2182.3 2183.4 2192.6 2116.9 2161.0 2175.9 2178.2 2178.4 2137.9 2150.2 2151.3 2151.6 2153.5 2075.9 2125.6 2127.1 2147.8 2158.6 7784.7 7789.7 7880.2 7894.4 7912.5 4424.5 4463.8 4538.7 4549.0 4563.6 2745.5 2749.4 2861.0 2878.2 2885.5 865.9 877.2 879.9 919.4 925.0 10418.2 10452.8 10500.4 10622.6 10699.4 4089.1 4096.1 4193.8 4207.3 4208.6 9010.1 9061.4 9071.6 9096.0 9096.9 4625.7 4634.1 4655.7 4663.3 4675.0 3609.8 4089.7 4155.7 4205.3 4269.4 3664.7 3676.0 3764.4 3793.6 3907.1 1179.7 1190.9 1200.6 1204.3 1208.8 791.2 808.6 813.6 816.4 816.7 4995.5 5057.6 5101.5 5152.7 5214.9 369.8 385.5 390.2 394.4 394.9 3393.2 3444.3 3453.4 3466.6 3479.8 9243.7 9382.9 9594.8 9619.7 9740.4 9492.9 9611.5 9623.6 9656.0 9663.0 7223.0 7277.0 7301.9 7313.1 7359.4 5070.9 5117.1 5159.1 5192.3 5206.8 8680.3 8788.3 8802.2 8873.2 8963.1 8932.4 8947.2 9067.8 9071.1 9082.8 5977.5 6463.9 6589.0 6647.2 6704.5 7377.0 7452.1 7501.5 7519.7 7521.4 6605.5 6769.2 6823.3 6854.8 6937.3 6771.5 6829.6 6843.4 6891.1 6933.1 5954.3 5970.3 6015.0 6034.6 6035.8 4456.0 4475.9 4550.1 4558.4 4559.7 4485.1 4531.5 4551.3 4636.6 4671.6 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#4] prototype.html Cycles:180 Average:4181.19 Median:4570.45 stddev:1195.25 (26.2%) stddev-sans-first:1162.67 04:29:24 INFO - PROCESS | 21976 | Values: 305.6 309.0 312.4 320.5 321.5 4745.4 4770.1 4901.9 4946.1 4980.6 4856.5 4870.8 4891.7 4894.5 4909.2 3875.4 3908.6 3916.1 3923.6 3930.4 3651.6 3914.6 3931.6 3942.0 3955.1 3811.7 3815.6 3829.6 3839.1 3848.1 3824.4 3826.3 3835.5 3843.4 3871.9 3233.8 3381.4 3389.0 3414.8 3425.1 4822.7 4834.8 4844.8 4847.9 4872.2 4418.6 4419.3 4421.9 4450.2 4486.3 4973.2 5176.4 5197.9 5239.4 5277.2 3821.5 3830.3 3843.9 3848.2 3849.2 5424.1 5460.2 5500.5 5504.3 5513.0 3703.9 3948.7 3952.4 3952.7 3966.3 3937.5 3950.4 3959.0 3975.6 3980.9 4436.2 4437.5 4440.1 4452.7 4520.5 5170.0 5200.5 5254.3 5266.9 5268.0 1260.7 1378.7 1382.5 1391.2 1392.6 887.6 890.6 902.2 907.8 918.2 4115.5 4129.2 4133.5 4155.4 4192.4 4761.5 4813.3 4827.3 4847.7 4847.9 4119.9 4128.7 4185.7 4194.8 4199.2 2473.8 2545.2 2547.3 2555.7 2580.3 4544.5 4571.5 4583.0 4593.4 4616.7 4914.7 4920.3 4945.3 4950.8 4957.2 4378.9 4468.7 4475.3 4483.4 4569.4 4697.7 4741.9 4759.2 4780.0 4797.2 4619.9 4624.0 4672.8 4688.0 4731.9 4215.0 4479.3 4509.5 4519.8 4521.8 3561.1 3574.4 3581.7 3585.2 3598.9 4722.8 4757.0 4763.0 4831.8 5167.3 5093.7 5160.5 5207.8 5236.8 5245.5 5183.7 5218.1 5225.4 5241.7 5246.7 4937.7 5129.8 5147.5 5206.3 5211.8 5326.7 5329.1 5330.8 5346.7 5351.9 5131.4 5180.3 5214.4 5219.4 5223.4 04:29:24 INFO - PROCESS | 21976 | 04:29:24 INFO - PROCESS | 21976 | [#5] yui.html Cycles:180 Average:17528.69 Median:21997.21 stddev:24584.21 (111.8%) stddev-sans-first:24620.49 04:29:24 INFO - PROCESS | 21976 | Values: 647.4 653.6 706.2 730.8 736.4 12725.0 13295.7 13332.3 14393.2 14974.0 14610.3 14920.8 14936.9 14939.2 14964.1 632.0 796.7 809.6 810.7 810.8 780.1 796.2 803.1 803.9 804.5 817.6 824.4 833.4 836.4 838.1 822.5 824.0 826.6 828.9 829.9 605.2 605.5 609.7 610.6 611.1 13509.0 13613.7 13616.6 13640.1 13647.0 12411.8 12857.9 12863.4 13034.5 13073.9 10335.6 10598.7 10629.7 10654.6 10689.5 3318.0 3352.1 3354.6 3387.4 3412.6 59181.0 59570.1 59720.1 59767.1 59787.4 10119.3 10143.9 10196.5 10257.9 10298.3 18555.0 18641.3 18723.3 18750.2 19325.2 7097.3 7108.1 7172.0 7181.7 7276.9 3832.8 3941.4 3951.0 3962.9 3965.6 2914.2 3000.6 3001.1 3017.9 3032.1 511.8 516.3 517.2 521.1 524.3 435.4 441.9 488.4 507.8 521.3 7444.4 7481.7 7668.2 7670.6 7776.3 493.6 545.7 552.8 553.6 562.6 3933.9 4322.3 4450.3 4497.6 4521.1 57904.7 58008.0 94857.4 102678.5 104349.0 85980.0 90205.0 90225.5 91204.0 92107.5 48838.5 71814.6 73720.3 73728.3 73777.3 8510.6 8632.5 8665.4 8678.2 8749.3 42676.8 43132.0 43269.8 43559.0 44359.6 63999.0 67000.7 67369.0 67384.0 67962.3 10860.1 11147.2 11256.5 11295.3 11442.3 12371.7 12848.3 12939.8 12960.4 12968.8 12040.9 12460.2 12595.8 12677.8 12879.6 11461.5 11780.5 11870.5 12247.8 12372.7 11389.8 11728.4 11989.7 12020.6 12054.3 9564.7 10352.0 10387.7 10417.2 10447.5 9400.2 10069.3 10099.6 10294.6 10431.9 04:29:24 INFO - PROCESS | 21976 | -------- Summary: end -------- 04:29:24 INFO - PROCESS | 21976 | 04:29:25 INFO - TEST-INFO | 21976: exit 0 04:29:25 INFO - TEST-OK | dromaeo_css | took 1119362ms 04:29:25 INFO - TEST-START | kraken 04:29:25 INFO - operating with platform_type : linux_ 04:29:25 INFO - Initialising browser for kraken test... 04:29:25 INFO - TEST-INFO | started process 22216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvMUJC/profile http://localhost:57371/getInfo.html) 04:29:31 INFO - PROCESS | 22216 | __metrics Screen width/height:1600/1200 04:29:31 INFO - PROCESS | 22216 | colorDepth:24 04:29:31 INFO - PROCESS | 22216 | Browser inner width/height: 1024/697 04:29:31 INFO - PROCESS | 22216 | __metrics 04:29:32 ERROR - PROCESS | 22216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:29:33 INFO - TEST-INFO | 22216: exit 0 04:29:33 INFO - Browser initialized. 04:29:33 INFO - Running cycle 1/1 for kraken test... 04:29:33 INFO - TEST-INFO | started process 22335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvMUJC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:45 INFO - PROCESS | 22335 | RSS: Main: 185733120 04:29:45 INFO - PROCESS | 22335 | 04:29:48 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:49 INFO - PROCESS | 22335 | RSS: Main: 190664704 04:29:49 INFO - PROCESS | 22335 | 04:29:52 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-dft) 04:29:52 INFO - PROCESS | 22335 | RSS: Main: 190296064 04:29:52 INFO - PROCESS | 22335 | 04:29:55 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-fft) 04:29:56 INFO - PROCESS | 22335 | RSS: Main: 186228736 04:29:56 INFO - PROCESS | 22335 | 04:29:58 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-oscillator) 04:29:59 INFO - PROCESS | 22335 | RSS: Main: 186667008 04:29:59 INFO - PROCESS | 22335 | 04:30:01 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:02 INFO - PROCESS | 22335 | RSS: Main: 187019264 04:30:02 INFO - PROCESS | 22335 | 04:30:05 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:06 INFO - PROCESS | 22335 | RSS: Main: 187371520 04:30:06 INFO - PROCESS | 22335 | 04:30:09 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:10 INFO - PROCESS | 22335 | RSS: Main: 184152064 04:30:10 INFO - PROCESS | 22335 | 04:30:13 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57371/tests/kraken/driver.html?testName=json-parse-financial) 04:30:13 INFO - PROCESS | 22335 | RSS: Main: 186683392 04:30:13 INFO - PROCESS | 22335 | 04:30:15 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:16 INFO - PROCESS | 22335 | RSS: Main: 186826752 04:30:16 INFO - PROCESS | 22335 | 04:30:18 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:18 INFO - PROCESS | 22335 | RSS: Main: 186826752 04:30:18 INFO - PROCESS | 22335 | 04:30:20 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:21 INFO - PROCESS | 22335 | RSS: Main: 187203584 04:30:21 INFO - PROCESS | 22335 | 04:30:24 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:25 INFO - PROCESS | 22335 | RSS: Main: 187219968 04:30:25 INFO - PROCESS | 22335 | 04:30:28 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:28 INFO - PROCESS | 22335 | RSS: Main: 186519552 04:30:28 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57371/tests/kraken/driver.html?testName=ai-astar) 04:30:30 INFO - PROCESS | 22335 | RSS: Main: 188166144 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | __start_tp_report 04:30:30 INFO - PROCESS | 22335 | _x_x_mozilla_page_load 04:30:30 INFO - PROCESS | 22335 | _x_x_mozilla_page_load_details 04:30:30 INFO - PROCESS | 22335 | |i|pagename|runs| 04:30:30 INFO - PROCESS | 22335 | |0;ai-astar;115;109;114;114;117;114;114;115;114;114 04:30:30 INFO - PROCESS | 22335 | |1;audio-beat-detection;162;136;157;181;134;157;164;132;195;133 04:30:30 INFO - PROCESS | 22335 | |2;audio-dft;163;169;169;161;164;162;163;165;162;163 04:30:30 INFO - PROCESS | 22335 | |3;audio-fft;77;76;77;155;77;78;78;76;157;77 04:30:30 INFO - PROCESS | 22335 | |4;audio-oscillator;87;85;144;86;87;87;135;86;86;138 04:30:30 INFO - PROCESS | 22335 | |5;imaging-gaussian-blur;117;120;117;118;121;118;118;118;117;117 04:30:30 INFO - PROCESS | 22335 | |6;imaging-darkroom;147;148;146;147;147;149;149;149;147;148 04:30:30 INFO - PROCESS | 22335 | |7;imaging-desaturate;96;97;95;96;95;96;98;96;96;96 04:30:30 INFO - PROCESS | 22335 | |8;json-parse-financial;64;63;64;64;65;64;63;70;65;65 04:30:30 INFO - PROCESS | 22335 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;64;65;65 04:30:30 INFO - PROCESS | 22335 | |10;stanford-crypto-aes;83;90;84;85;85;84;91;85;113;85 04:30:30 INFO - PROCESS | 22335 | |11;stanford-crypto-ccm;132;139;135;133;143;130;145;139;138;136 04:30:30 INFO - PROCESS | 22335 | |12;stanford-crypto-pbkdf2;174;173;170;171;167;170;170;172;174;169 04:30:30 INFO - PROCESS | 22335 | |13;stanford-crypto-sha256-iterative;68;67;68;68;67;69;66;71;66;66 04:30:30 INFO - PROCESS | 22335 | __end_tp_report 04:30:30 INFO - PROCESS | 22335 | __start_cc_report 04:30:30 INFO - PROCESS | 22335 | _x_x_mozilla_cycle_collect,995 04:30:30 INFO - PROCESS | 22335 | __end_cc_report 04:30:30 INFO - PROCESS | 22335 | __startTimestamp1466508630724__endTimestamp 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | ------- Summary: start ------- 04:30:30 INFO - PROCESS | 22335 | Number of tests: 14 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:2.00 (1.8%) stddev-sans-first:2.09 04:30:30 INFO - PROCESS | 22335 | Values: 115.0 109.0 114.0 114.0 117.0 114.0 114.0 115.0 114.0 114.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:159.50 stddev:21.68 (13.6%) stddev-sans-first:22.85 04:30:30 INFO - PROCESS | 22335 | Values: 162.0 136.0 157.0 181.0 134.0 157.0 164.0 132.0 195.0 133.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.81 (1.7%) stddev-sans-first:2.95 04:30:30 INFO - PROCESS | 22335 | Values: 163.0 169.0 169.0 161.0 164.0 162.0 163.0 165.0 162.0 163.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#3] audio-fft Cycles:10 Average:92.80 Median:77.00 stddev:33.32 (43.3%) stddev-sans-first:34.85 04:30:30 INFO - PROCESS | 22335 | Values: 77.0 76.0 77.0 155.0 77.0 78.0 78.0 76.0 157.0 77.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:86.00 stddev:25.56 (29.7%) stddev-sans-first:26.52 04:30:30 INFO - PROCESS | 22335 | Values: 87.0 85.0 144.0 86.0 87.0 87.0 135.0 86.0 86.0 138.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.37 (1.2%) stddev-sans-first:1.39 04:30:30 INFO - PROCESS | 22335 | Values: 117.0 120.0 117.0 118.0 121.0 118.0 118.0 118.0 117.0 117.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 04:30:30 INFO - PROCESS | 22335 | Values: 147.0 148.0 146.0 147.0 147.0 149.0 149.0 149.0 147.0 148.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 04:30:30 INFO - PROCESS | 22335 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 98.0 96.0 96.0 96.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.50 stddev:2.00 (3.1%) stddev-sans-first:2.11 04:30:30 INFO - PROCESS | 22335 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 63.0 70.0 65.0 65.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:30:30 INFO - PROCESS | 22335 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.00 stddev:9.00 (10.6%) stddev-sans-first:9.32 04:30:30 INFO - PROCESS | 22335 | Values: 83.0 90.0 84.0 85.0 85.0 84.0 91.0 85.0 113.0 85.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:138.50 stddev:4.76 (3.4%) stddev-sans-first:4.69 04:30:30 INFO - PROCESS | 22335 | Values: 132.0 139.0 135.0 133.0 143.0 130.0 145.0 139.0 138.0 136.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:2.26 (1.3%) stddev-sans-first:2.12 04:30:30 INFO - PROCESS | 22335 | Values: 174.0 173.0 170.0 171.0 167.0 170.0 170.0 172.0 174.0 169.0 04:30:30 INFO - PROCESS | 22335 | 04:30:30 INFO - PROCESS | 22335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 04:30:30 INFO - PROCESS | 22335 | Values: 68.0 67.0 68.0 68.0 67.0 69.0 66.0 71.0 66.0 66.0 04:30:30 INFO - PROCESS | 22335 | -------- Summary: end -------- 04:30:30 INFO - PROCESS | 22335 | 04:30:31 INFO - TEST-INFO | 22335: exit 0 04:30:31 INFO - TEST-OK | kraken | took 66396ms 04:30:31 INFO - SUITE-END | took 1185s 04:30:31 INFO - Completed test suite (00:19:45) 04:30:31 INFO - javascript benchmark 04:30:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6243.363689874916, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.55085360062, 2647.9735202647967, 2661.3878807874203, 2665.413609006018, 2674.759271665551, 4637.165310244159, 4681.4616319123315, 4698.27176787598, 4745.833895813647, 4783.593394561466, 4535.841245556406, 4650.883727906804, 4665.556772106653, 4673.415823022122, 4680.3447517347595, 4229.259879521087, 4354.738715677054, 4369.344598310263, 4373.868783936487, 4409.691321607489, 606.6409659329828, 4188.979055104735, 4276.914461710764, 4286.892827679318, 4308.612224899758, 4249.405083288342, 4278.957210427887, 4282.0, 4309.35359696045, 4353.303471444554, 4186.120914607936, 4261.829526818955, 4287.678424118204, 4314.935275970863, 4344.1311737652595, 4241.639460645849, 4264.0, 4266.594673506043, 4271.060366719316, 4287.0, 4675.4155730533685, 4685.835995740167, 4719.528047195287, 4724.574788269072, 4781.737004464753, 5037.345145131109, 5037.874053148664, 5045.823396181116, 5047.192449208146, 5098.439171691111, 5075.365579302587, 5152.562032227265, 5157.5616072633875, 5163.870903227412, 5195.506426889439, 4737.763111844429, 4748.264019077049, 4772.0, 4775.808967641325, 4798.736069516175, 5100.821471248489, 5172.8965420691375, 5184.0, 5207.062728708869, 5275.788968441219, 5004.299398084271, 5017.523335283142, 5019.0463811875625, 5037.848864534069, 5069.188929771219, 5079.466656001066, 5096.184610462383, 5103.948960510347, 5112.130937740593, 5113.335266415343, 4858.514148585114, 4939.481354457802, 4948.38145231846, 4992.0, 5039.4708555601865, 4845.418549773979, 4848.12733707936, 4886.364772579542, 4888.926666100011, 4930.926036109389, 4127.628513433805, 4163.250614889288, 4166.395872598457, 4207.8316867325575, 4214.936775948363, 3676.3015027144756, 3693.7414380993073, 3700.703943684499, 3704.444333350019, 3742.700583953277, 4426.911461770746, 4441.444819397575, 4455.643548516111, 4456.286994080931, 4502.122086193226, 5123.38519377677, 5147.6654017488745, 5168.250603662448, 5177.7152256625495, 5223.869403264873, 4284.057507348379, 4394.252976993855, 4403.119376124788, 4406.383106365111, 4449.377087207794, 4499.52754960731, 4533.433320834895, 4551.749653769075, 4552.772361381918, 4590.380298659638, 4816.975915120402, 4820.3492528508905, 4828.106800241966, 4828.324034635084, 4903.117438860968, 4927.852164435073, 5078.56832169255, 5109.437961824271, 5129.92305115431, 5139.691618502902, 4815.205491094071, 4823.589994850477, 4836.298736683231, 4836.960053588496, 4886.193778026586, 4925.285833554186, 5052.8484145475695, 5054.444011158843, 5059.519345662156, 5105.566026887756, 5042.092423363683, 5062.417821950523, 5068.493150684902, 5080.720560369067, 5084.3644544431945, 4944.653874228769, 4959.776810043484, 4964.05682920244, 4969.701817890938, 4979.850604481871, 4857.514248575114, 4872.975635121802, 4945.431275403231, 4968.652194346361, 5007.298978143136, 4644.210484217623, 4737.881552961204, 4790.4251489821445, 4812.783424745965, 4857.805687772449, 4916.508349165198, 4917.9016419672125, 4923.236898280772, 4941.308216849572, 4945.554900059012, 4783.354247176587, 4859.757012149449, 4866.95133048665, 4870.878228044327, 4917.877053073702], "value": 4608.591600173587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.7937616619603, 587.2747157260782, 592.8606777407311, 597.4145337569182, 604.9909251361229, 38978.99999999996, 40069.0, 40079.198416031664, 40128.19743605126, 43219.567804321945, 39891.20217595654, 40091.59908400923, 40234.39648405276, 40426.595734042654, 40574.18851622966, 7902.288794008552, 8015.1984801519675, 8035.758927232192, 8046.316063134641, 8055.073666528366, 7978.122406535305, 8021.839563208732, 8023.31801796848, 8040.075391329984, 8040.517568945882, 8000.719974800883, 8073.515589064646, 8093.069297030858, 8097.392695547828, 8100.068492123393, 8019.558924259134, 8058.033036035684, 8083.474574152661, 8097.2712455879255, 8099.0, 7891.368690504746, 7916.0, 7936.563489008102, 7960.562169080698, 7969.960150199212, 38308.233835323415, 38358.23283534314, 38400.231995359936, 38448.80775596132, 38562.0, 2835.7447829695425, 2859.4995875721875, 2965.525515917443, 3063.3720087382035, 3294.9291480269007, 28739.856300718362, 29028.12915612535, 29064.564031539543, 29337.266568335748, 30022.0, 3196.8721251149927, 3199.520071989197, 3224.67753224678, 3310.337932413527, 3449.862005519776, 255912.0, 258118.0, 258506.0, 258560.9999999981, 260088.0, 31561.0, 32587.674123258465, 50242.748786255834, 50914.65396133427, 51266.48733512617, 34091.4886276706, 34214.82892585521, 34228.48657270143, 34325.485117723256, 34350.82824585861, 12278.079144064051, 12493.93753031229, 12498.812517812241, 12507.06197035226, 12530.81203781944, 9774.16919561831, 9806.460644664468, 9910.55402506889, 9915.702528924, 9927.602895884229, 7903.328217101611, 7912.248336408032, 7951.443398962017, 7963.0842453117475, 7974.043114826258, 3063.341381602966, 3103.7827352085137, 3106.2079169811554, 3106.9378612427627, 3135.263213144909, 823.4647479138608, 853.8676505141713, 870.760540851271, 950.5722424908819, 958.1616085924816, 26669.866650666623, 27400.72599273982, 28045.71954280472, 28070.578941315896, 28187.15438536847, 875.6584931876573, 890.2655309369667, 933.5985526223789, 934.9719508414759, 981.1169947047714, 14437.20595367244, 14651.560453186421, 14764.187969661773, 14818.92590537062, 15082.698346033018, 400621.0, 417449.0, 418169.0, 418608.0, 419740.0, 47437.76281118573, 49024.754876225394, 49239.507604924205, 49459.0, 49513.0, 1136.6590022993068, 1158.9826152607718, 1162.0, 1165.9825102623468, 1186.9228500147462, 25927.222183333775, 26797.33006674771, 26825.597616035386, 27491.725082749716, 27632.723672763015, 40492.797536012135, 40817.59182408138, 40993.59006409898, 41002.79498602607, 41022.38466423066, 344559.0, 346669.0, 350864.0, 353179.0, 353294.0, 25031.249062528153, 25166.874165629055, 25647.743522564535, 25990.87004564965, 26096.086636967615, 41047.1790564193, 41225.79387103045, 41279.0, 41308.1738365225, 42241.57758422376, 36084.09789755172, 36258.09354766152, 36390.0, 36423.63576364202, 36740.0, 34845.825770870986, 35320.0, 35352.29295414129, 35554.0, 36041.279174416886, 30932.0, 35229.29541409106, 35574.28851423009, 36142.0, 36275.27449450943, 29493.115206543836, 29900.70099298979, 30323.545146823257, 30327.848360758057, 30355.696443035285, 25265.62101568515, 25733.871330643975, 25739.0, 25940.22179334623, 26078.73921260839], "value": 16325.38270136445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.656528015745, 371.9702423806096, 373.13618972079644, 382.35954775750645, 389.1069994362937, 15543.378264869405, 16188.919055404707, 16705.415310464105, 16738.246778894947, 16738.330466781328, 15253.6949261015, 15718.764218536702, 16136.112513811735, 16149.192540372964, 16173.19134043299, 5066.442691303944, 5207.4792520747815, 5222.843314700565, 5253.842384728464, 5258.55302299305, 3762.7366084374103, 5169.793208271664, 5774.0, 6060.030395136779, 6060.727267272983, 6064.9696751516185, 6081.6351018938785, 6112.0, 6119.6328220306705, 6148.723307451175, 4828.493008234138, 5121.974390128025, 5133.691978481284, 5141.871453213681, 5224.686518808883, 4426.889327766799, 4729.912120212336, 4759.547842954914, 5027.949720502785, 5032.043911656773, 11546.0, 11937.0, 12083.818742718866, 12110.910018098413, 12256.693582660504, 1910.1595298068805, 2038.2458490358515, 2105.4420578546697, 2273.8294627902974, 2394.7851780865626, 8309.169083091643, 8624.568771561397, 8634.697785577537, 8730.825383492294, 8937.106289371075, 1606.2691475378792, 1635.893666911647, 1693.9153042347834, 1706.445405243301, 1741.6690828742499, 66322.0, 66407.33592664108, 66902.0, 67161.32838671649, 70086.0, 8346.791330216793, 8768.123187681182, 8866.645334186689, 9089.77275568116, 9095.863562046574, 11376.374299413612, 11515.136364772676, 11551.133664975161, 11588.188826782212, 11588.478518466689, 6620.3710647488415, 6642.701078451481, 6663.133792607027, 6762.864742705118, 6782.220044694924, 6389.3291204423795, 6493.740250390026, 6579.736810527621, 6614.140161779034, 6658.1344425224415, 3284.556584861061, 3389.372966001248, 3493.5458390409594, 3655.141041855162, 3710.1466662667735, 1648.6620242850188, 1680.5882558773178, 1700.1839117223801, 1751.4833124228383, 1807.5842556212144, 840.8570543007581, 850.5534594338022, 869.1091631078069, 911.2573252799081, 930.418488444722, 16095.436659716854, 16581.17094145312, 16669.83330166683, 16747.665046699243, 16828.579285517717, 830.6179157587457, 833.6498670558381, 840.9831803363899, 874.7900503879023, 895.136193573205, 8999.280057595508, 9285.25717942563, 9352.906470935339, 9631.903680963242, 9765.02349765032, 353347.0, 367962.0, 381275.0, 385730.0, 389640.0, 67319.3268067313, 70494.29505704877, 72883.63558182176, 74623.0, 77048.0, 905.4883990545321, 923.2982932970856, 928.4197376639735, 951.7097285328041, 955.1642312976146, 15745.921270393575, 15823.0, 15864.841351586798, 15925.124118173148, 16320.183990800175, 30086.849565752033, 31393.52909706402, 32751.017469475955, 34674.47988280228, 37853.621463785006, 50270.0, 51916.221256681936, 52222.0, 52296.47703522916, 52341.7382913083, 7104.751333703295, 7170.928290717026, 7196.604186769778, 7299.05112335393, 7334.486585938933, 8052.194780521901, 10130.0, 11241.60654377093, 11782.764344712887, 12124.211926224767, 9527.904720952702, 10011.349262297927, 10058.899411005796, 10157.085862272432, 10444.112250458493, 10111.797764044824, 10162.390256584333, 10225.335353202017, 10378.169746420419, 10438.739031524272, 10089.0, 10301.330413523097, 10416.791664166825, 10430.478476076318, 10448.738781530523, 7129.82175445618, 7200.351968322876, 7209.927900720925, 7312.7440539582985, 7411.444141689287, 7020.122484689414, 8400.537970411686, 10031.398116113056, 10238.846417303896, 10318.742031448974], "value": 7789.07556588478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.2309045389352, 1390.4090761426394, 1483.1546018769307, 1676.597616572023, 1687.5527985083947, 6778.694958726856, 7457.589832559207, 7462.21646727094, 8002.279794818465, 8036.116027237006, 7509.737159199429, 7737.071551413824, 7767.9611601941915, 7801.375889928806, 7801.726939557117, 2173.7065496158016, 2179.455136215946, 2201.8550353816086, 2204.261572373257, 2208.4810069633622, 2146.1308170191096, 2158.179891641174, 2182.2907555044594, 2183.410479170623, 2192.572448372568, 2116.904739286736, 2161.049138379116, 2175.912963481459, 2178.2049551913597, 2178.4118288062214, 2137.9251726189586, 2150.1506904772527, 2151.268568686654, 2151.601953638574, 2153.504693920391, 2075.9481012974647, 2125.5748850230016, 2127.074722495704, 2147.8066973972263, 2158.589867925105, 7784.7275345363205, 7789.7273595423885, 7880.211978802131, 7894.368450523944, 7912.525248485109, 4424.469063712343, 4463.754493502856, 4538.704984176018, 4548.977255113703, 4563.566461186182, 2745.4646343962936, 2749.3539018330675, 2860.9713902860913, 2878.2228798224364, 2885.5238885583854, 865.9177378149066, 877.2017464107695, 879.907609700985, 919.420764918104, 925.0425809287423, 10418.166546676324, 10452.843207351896, 10500.422476763775, 10622.628208012682, 10699.411532365717, 4089.1003979124544, 4096.139810639799, 4193.7693426861815, 4207.326827707613, 4208.558101399371, 9010.098990100938, 9061.41100828444, 9071.59177836999, 9096.0, 9096.8635470468, 4625.699329543569, 4634.096351211481, 4655.720656760537, 4663.323818046364, 4674.97662511692, 3609.783412995229, 4089.6932730045364, 4155.709100362946, 4205.327147656421, 4269.359596060615, 3664.688501477351, 3675.9816200918826, 3764.378877485239, 3793.5637401698605, 3907.1404291055924, 1179.6520026592175, 1190.898773604236, 1200.5557943560764, 1204.3376143121423, 1208.8186771984097, 791.1534657915975, 808.5835794565803, 813.5810057820228, 816.4040250617082, 816.6855760532238, 4995.475475075137, 5057.620678449131, 5101.51535604117, 5152.742362881841, 5214.8957020860125, 369.78367654921635, 385.49500154797306, 390.2078780076449, 394.445803645878, 394.9447077409165, 3393.185635447475, 3444.3111377724554, 3453.395655760232, 3466.6013408457848, 3479.8260086995547, 9243.676471323606, 9382.906170938204, 9594.808103837884, 9619.711408657751, 9740.366876153028, 9492.857607135898, 9611.471369074769, 9623.615055397706, 9656.034396560288, 9662.951685241529, 7222.96388518054, 7276.96361518189, 7301.89047164293, 7313.08586426686, 7359.448041396917, 5070.873228169177, 5117.1300878851425, 5159.09715799726, 5192.299039629602, 5206.843794686166, 8680.262177714965, 8788.2529984952, 8802.163794439519, 8873.201411872962, 8963.103689630985, 8932.419392739452, 8947.150020748019, 9067.818643627223, 9071.138241867013, 9082.772930676785, 5977.491913187428, 6463.903041454288, 6588.967055164693, 6647.235567909753, 6704.530682852349, 7377.0, 7452.143003554661, 7501.474896757175, 7519.661615227218, 7521.398288137046, 6605.47156227491, 6769.1876974763345, 6823.317668233137, 6854.760083397057, 6937.340952609494, 6771.492138089565, 6829.6243706596615, 6843.418309443753, 6891.104156459628, 6933.1333583302085, 5954.345022047484, 5970.283565972111, 6015.0, 6034.63792172471, 6035.758569657341, 4456.0, 4475.9328610071525, 4550.112728018004, 4558.384618076518, 4559.726416415026, 4485.125400546862, 4531.478879928719, 4551.271796512675, 4636.559526844944, 4671.649626278111], "value": 4013.6564571130166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.59661247153736, 308.998455007725, 312.4251377465464, 320.4648237443469, 321.45513354863516, 4745.430548334205, 4770.141374552579, 4901.877453063676, 4946.134426475371, 4980.60155187585, 4856.538628830255, 4870.756462176894, 4891.706497610146, 4894.486078961711, 4909.189983652702, 3875.360565506688, 3908.6286802753693, 3916.060145565072, 3923.607639236082, 3930.3711406175016, 3651.6348365163535, 3914.588968158345, 3931.6264954829244, 3941.960580394188, 3955.0705584187695, 3811.6950643948417, 3815.6184381561898, 3829.5639135324254, 3839.0978120141745, 3848.134169811784, 3824.426336049587, 3826.292135954843, 3835.520559930009, 3843.3658446356317, 3871.9032024199337, 3233.757468189895, 3381.357542067024, 3389.0, 3414.7609667323295, 3425.1265927188656, 4822.710637361734, 4834.7824347904425, 4844.806207751686, 4847.878803029917, 4872.196087645534, 4418.602325790662, 4419.270820314644, 4421.9336709949375, 4450.1767173073085, 4486.304622783474, 4973.204287314049, 5176.352955880515, 5197.870053248661, 5239.375793503988, 5277.182036784305, 3821.48409964654, 3830.253100645375, 3843.9231215375817, 3848.2111167210655, 3849.2301539692176, 5424.0744535690055, 5460.153676180238, 5500.50495455407, 5504.311961004874, 5512.972435137839, 3703.8703645372284, 3948.7038472114705, 3952.4268980997595, 3952.7233093683167, 3966.3058964681063, 3937.527496700357, 3950.4198320671385, 3958.960410395917, 3975.6024397560013, 3980.920381592352, 4436.201483732894, 4437.489688685778, 4440.134173836135, 4452.732836029849, 4520.547945205453, 5170.0, 5200.5059519345605, 5254.343207099113, 5266.947330526722, 5267.973660131752, 1260.6692085522839, 1378.696686728918, 1382.4884792626592, 1391.2348208485294, 1392.610069180631, 887.5961437545901, 890.5725251879005, 902.1654969153507, 907.8243674441615, 918.1874041473344, 4115.456703736099, 4129.215449064668, 4133.545310015896, 4155.358633339813, 4192.413062171298, 4761.547652972962, 4813.302071199656, 4827.300041493963, 4847.660663753574, 4847.878803029882, 4119.8970025749595, 4128.731632443882, 4185.686073544496, 4194.839657576351, 4199.202151591249, 2473.7773600376054, 2545.1855406269815, 2547.286759707285, 2555.7349112189213, 2580.3291144302616, 4544.500104988449, 4571.542845715402, 4582.9541704582525, 4593.425821772278, 4616.722996620147, 4914.65597408178, 4920.3111564381015, 4945.258211268267, 4950.752462376867, 4957.231629097496, 4378.868633940987, 4468.731876087445, 4475.30632751924, 4483.417155769729, 4569.360289559464, 4697.718136911796, 4741.857744267678, 4759.214729569582, 4779.95220047809, 4797.232442809134, 4619.891226105643, 4623.953760462487, 4672.813087476598, 4687.968646897677, 4731.858044258678, 4214.978925105354, 4479.328100784778, 4509.503954565061, 4519.774011299488, 4521.806923641965, 3561.0563200751303, 3574.410222313289, 3581.6955558777795, 3585.247098109426, 3598.8946466317498, 4722.834700785456, 4757.0, 4762.9523704762505, 4831.830885918976, 5167.328247327823, 5093.668911520739, 5160.535551800356, 5207.817726379559, 5236.842894713165, 5245.527902488794, 5183.688978661293, 5218.112920803548, 5225.372955245395, 5241.737913104405, 5246.658967167122, 4937.679050861826, 5129.769160387867, 5147.485251474823, 5206.297149884717, 5211.765470553758, 5326.707031113326, 5329.147336426153, 5330.813421530228, 5346.7059311736675, 5351.919721204107, 5131.409887862944, 5180.274761533313, 5214.400343960493, 5219.399769026459, 5223.399309079505], "value": 3810.5184387831437, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.4205586000527, 653.6013032050452, 706.152616859768, 730.7990302666767, 736.4255880413277, 12725.0, 13295.667608309785, 13332.266725330102, 14393.208373539477, 14974.0, 14610.269486525684, 14920.776188357157, 14936.925315373435, 14939.178345191038, 14964.102153870748, 632.0203684289356, 796.6654005317752, 809.550699361854, 810.6635746165334, 810.841885832263, 780.1184661332715, 796.1918652567648, 803.116571771053, 803.907550631676, 804.505229283989, 817.5503473089807, 824.4435006370705, 833.4207725630689, 836.3601844588894, 838.0990435282066, 822.5475988206463, 823.9876401853948, 826.6114925984778, 828.8798124271977, 829.854775414303, 605.2313561776563, 605.5186127029023, 609.704293417692, 610.5695484683288, 611.0864257934372, 13509.0, 13613.659658508517, 13616.591502254849, 13640.113392629546, 13647.0, 12411.813822792665, 12857.90707789839, 12863.356832158355, 13034.478620855154, 13073.934630326883, 10335.638252661196, 10598.682039538826, 10629.73425664357, 10654.62708805188, 10689.518971646217, 3318.0, 3352.0614228016193, 3354.630990591033, 3387.356402283583, 3412.6416726243633, 59181.0, 59570.10644840331, 59720.10419843706, 59767.103493447634, 59787.40212597862, 10119.342242754197, 10143.949280253699, 10196.541155648014, 10257.897421025844, 10298.330608510423, 18555.0, 18641.347552835585, 18723.344682936306, 18750.1562429691, 19325.226990920204, 7097.290270972965, 7108.111486064242, 7172.031775710212, 7181.7486387977215, 7276.890846637305, 3832.827522761482, 3941.4481972523868, 3950.9604903951167, 3962.881113566598, 3965.643092121723, 2914.198595386243, 3000.609920710294, 3001.1146711720094, 3017.909462716122, 3032.120685001369, 511.7722613437059, 516.2772119033308, 517.2319106127397, 521.0698902459093, 524.3393324411193, 435.42741295197345, 441.89173652455355, 488.4236600811006, 507.84510724228727, 521.317074632233, 7444.404447644176, 7481.738139165212, 7668.156502784689, 7670.578118203441, 7776.339011184113, 493.58538827385166, 545.6671430427436, 552.8175702018324, 553.6346011632303, 562.5977426140329, 3933.8819835404984, 4322.265214913472, 4450.265706158512, 4497.64018878489, 4521.118381915495, 57904.71047644735, 58008.0, 94857.41140708726, 102678.48660756797, 104349.0, 85980.0, 90205.0, 90225.54887225523, 91204.0, 92107.53946230226, 48838.511614884104, 71814.64092679607, 73720.26279737242, 73728.26271737322, 73777.26222737812, 8510.574471276535, 8632.482051076955, 8665.393422460367, 8678.175573320525, 8749.300055995378, 42676.78661606672, 43132.0, 43269.78365108154, 43559.0, 44359.55640443684, 63999.0, 67000.6649966747, 67369.0, 67384.0, 67962.3203767956, 10860.131189504662, 11147.219694621299, 11256.549738010388, 11295.265807722471, 11442.313461192354, 12371.69070773202, 12848.293343866177, 12939.805902911652, 12960.416781245056, 12968.805467918177, 12040.939795300967, 12460.234089902044, 12595.811062834247, 12677.798392084003, 12879.613611591667, 11461.541538338373, 11780.52877884875, 11870.525178992744, 12247.816282755588, 12372.690682732644, 11389.829152562885, 11728.41357932117, 11989.700257493632, 12020.63938081859, 12054.276743395425, 9564.713058608253, 10352.0, 10387.729903154375, 10417.16662667, 10447.529861156114, 9400.219510620407, 10069.345492542961, 10099.63947545675, 10294.639687610897, 10431.947840261053], "value": 6607.282993862763, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 114.0, 117.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 136.0, 157.0, 181.0, 134.0, 157.0, 164.0, 132.0, 195.0, 133.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 169.0, 161.0, 164.0, 162.0, 163.0, 165.0, 162.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 155.0, 77.0, 78.0, 78.0, 76.0, 157.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 144.0, 86.0, 87.0, 87.0, 135.0, 86.0, 86.0, 138.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 117.0, 118.0, 121.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 149.0, 149.0, 149.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 70.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 84.0, 85.0, 85.0, 84.0, 91.0, 85.0, 113.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 135.0, 133.0, 143.0, 130.0, 145.0, 139.0, 138.0, 136.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 170.0, 171.0, 167.0, 170.0, 170.0, 172.0, 174.0, 169.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 66.0, 71.0, 66.0, 66.0], "value": 67.6, "unit": "score"}]}]} 04:30:31 INFO - Return code: 0 04:30:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:30:32 ERROR - # TBPL SUCCESS # 04:30:32 INFO - Running post-action listener: _resource_record_post_action 04:30:32 INFO - ##### 04:30:32 INFO - ##### Finished run-tests step (success) 04:30:32 INFO - ##### 04:30:32 INFO - Running post-run listener: _resource_record_post_run 04:30:32 INFO - Total resource usage - Wall time: 1203s; CPU: 14.0%; Read bytes: 4096; Write bytes: 532119552; Read time: 8; Write time: 1698392 04:30:32 INFO - TinderboxPrint: CPU usage
13.7% 04:30:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:30:32 INFO - TinderboxPrint: I/O write bytes / time
532,119,552 / 1,698,392 04:30:32 INFO - TinderboxPrint: CPU idle
8,278.8 (86.3%) 04:30:32 INFO - TinderboxPrint: CPU user
1,240.9 (12.9%) 04:30:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:32 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 189190144; Read time: 0; Write time: 1046352 04:30:32 INFO - run-tests - Wall time: 1187s; CPU: 14.0%; Read bytes: 4096; Write bytes: 296235008; Read time: 8; Write time: 596972 04:30:32 INFO - Running post-run listener: _upload_blobber_files 04:30:32 INFO - Blob upload gear active. 04:30:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:32 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 04:30:32 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:32 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:36 INFO - (blobuploader) - INFO - Done attempting. 04:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:37 INFO - (blobuploader) - INFO - Done attempting. 04:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:38 INFO - (blobuploader) - INFO - Done attempting. 04:30:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:38 INFO - Return code: 0 04:30:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/649670e58ecd7c51bfdacd8e5a7a2d917a79d2650da6ab88c45c2ff7513f941f6a3c204757f5ea475ca023abead01b7279c21f704ecd5f78caa50dd9fde2950d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bad5bfbf9a6c96a3652a1e1a641d70ad91e36c44f33e2e52a6ba170ef584a4d5973877b62e8781668a5283676090217391ce54b1facb999a2bf00ee92b93ba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52aa1b41916f4e2ac3c7efca5a45de516aa0c83e9a5a75669542b4ddc9ed0d1ace70d153cfc8941a2fede5e8bffd93b79d4f11d35781eac2ac910f1343e0472d"} 04:30:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:38 INFO - Contents: 04:30:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/649670e58ecd7c51bfdacd8e5a7a2d917a79d2650da6ab88c45c2ff7513f941f6a3c204757f5ea475ca023abead01b7279c21f704ecd5f78caa50dd9fde2950d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bad5bfbf9a6c96a3652a1e1a641d70ad91e36c44f33e2e52a6ba170ef584a4d5973877b62e8781668a5283676090217391ce54b1facb999a2bf00ee92b93ba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52aa1b41916f4e2ac3c7efca5a45de516aa0c83e9a5a75669542b4ddc9ed0d1ace70d153cfc8941a2fede5e8bffd93b79d4f11d35781eac2ac910f1343e0472d"} 04:30:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:38 INFO - Copying logs to upload dir... 04:30:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.420700 ========= master_lag: 8.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-21 04:30:46.337157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:30:46.340964) ========= 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=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 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/Firefox-Non-PGO/sha512/649670e58ecd7c51bfdacd8e5a7a2d917a79d2650da6ab88c45c2ff7513f941f6a3c204757f5ea475ca023abead01b7279c21f704ecd5f78caa50dd9fde2950d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bad5bfbf9a6c96a3652a1e1a641d70ad91e36c44f33e2e52a6ba170ef584a4d5973877b62e8781668a5283676090217391ce54b1facb999a2bf00ee92b93ba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52aa1b41916f4e2ac3c7efca5a45de516aa0c83e9a5a75669542b4ddc9ed0d1ace70d153cfc8941a2fede5e8bffd93b79d4f11d35781eac2ac910f1343e0472d"} build_url:https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/VklF6A5RSP6G--lh12uYIQ/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/Firefox-Non-PGO/sha512/649670e58ecd7c51bfdacd8e5a7a2d917a79d2650da6ab88c45c2ff7513f941f6a3c204757f5ea475ca023abead01b7279c21f704ecd5f78caa50dd9fde2950d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1bad5bfbf9a6c96a3652a1e1a641d70ad91e36c44f33e2e52a6ba170ef584a4d5973877b62e8781668a5283676090217391ce54b1facb999a2bf00ee92b93ba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52aa1b41916f4e2ac3c7efca5a45de516aa0c83e9a5a75669542b4ddc9ed0d1ace70d153cfc8941a2fede5e8bffd93b79d4f11d35781eac2ac910f1343e0472d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:30:46.369149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:30:46.369482) ========= 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=df17445c3590ff7897617a0e00000225-1466506792.165797-125668021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:30:46.419397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:30:46.419732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:30:46.420036) ========= ========= Total master_lag: 8.28 =========