builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1467041423.55 results: success (0) buildid: 20160627075158 builduid: 33463bf984224435a4b11bedebff5e15 revision: 13aad7c0cfda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.555230) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.555728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.558696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.574581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.574912) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:30:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-06-27 08:30:23 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077738 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.667352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.667711) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.718772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:23.719549) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 13aad7c0cfda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 13aad7c0cfda --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=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:30:23,880 Setting DEBUG logging. 2016-06-27 08:30:23,880 attempt 1/10 2016-06-27 08:30:23,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/13aad7c0cfda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:30:24,417 unpacking tar archive at: fx-team-13aad7c0cfda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:24.632693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:24.633352) ========= script_repo_revision: 13aad7c0cfda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:24.633903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:24.634323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:30:24.645537) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 08:30:24.645852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:30:24 INFO - MultiFileLogger online at 20160627 08:30:24 in /builds/slave/test 08:30:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:30:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:24 INFO - {'append_to_log': False, 08:30:24 INFO - 'base_work_dir': '/builds/slave/test', 08:30:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:30:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:24 INFO - 'branch': 'Fx-Team-Non-PGO', 08:30:24 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:24 INFO - 'config_files': ('talos/linux_config.py',), 08:30:24 INFO - 'default_actions': ('clobber', 08:30:24 INFO - 'read-buildbot-config', 08:30:24 INFO - 'download-and-extract', 08:30:24 INFO - 'populate-webroot', 08:30:24 INFO - 'create-virtualenv', 08:30:24 INFO - 'install', 08:30:24 INFO - 'run-tests'), 08:30:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:24 INFO - 'download_minidump_stackwalk': True, 08:30:24 INFO - 'download_symbols': 'ondemand', 08:30:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:24 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:24 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:24 INFO - 'installer_path': 'installer.exe', 08:30:24 INFO - 'log_level': 'info', 08:30:24 INFO - 'log_name': 'talos', 08:30:24 INFO - 'log_to_console': True, 08:30:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:30:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:30:24 INFO - 'opt_config_files': (), 08:30:24 INFO - 'pip_index': False, 08:30:24 INFO - 'sps_profile': False, 08:30:24 INFO - 'sps_profile_interval': 0, 08:30:24 INFO - 'suite': 'dromaeojs-e10s', 08:30:24 INFO - 'system_bits': '32', 08:30:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:24 INFO - 'title': 'talos-linux64-ix-015', 08:30:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:24 INFO - 'use_talos_json': True, 08:30:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:24 INFO - 'work_dir': 'build'} 08:30:24 INFO - ##### 08:30:24 INFO - ##### Running clobber step. 08:30:24 INFO - ##### 08:30:24 INFO - Running pre-action listener: _resource_record_pre_action 08:30:24 INFO - Running main action method: clobber 08:30:24 INFO - rmtree: /builds/slave/test/build 08:30:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - ##### 08:30:25 INFO - ##### Finished clobber step (success) 08:30:25 INFO - ##### 08:30:25 INFO - ##### 08:30:25 INFO - ##### Running read-buildbot-config step. 08:30:25 INFO - ##### 08:30:25 INFO - Running pre-action listener: _resource_record_pre_action 08:30:25 INFO - Running main action method: read_buildbot_config 08:30:25 INFO - Using buildbot properties: 08:30:25 INFO - { 08:30:25 INFO - "project": "", 08:30:25 INFO - "product": "firefox", 08:30:25 INFO - "script_repo_revision": "production", 08:30:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:30:25 INFO - "repository": "", 08:30:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:30:25 INFO - "buildid": "20160627075158", 08:30:25 INFO - "pgo_build": "False", 08:30:25 INFO - "basedir": "/builds/slave/test", 08:30:25 INFO - "buildnumber": 1616, 08:30:25 INFO - "slavename": "talos-linux64-ix-015", 08:30:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:30:25 INFO - "platform": "ubuntu64_hw", 08:30:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:30:25 INFO - "branch": "fx-team", 08:30:25 INFO - "repo_path": "integration/fx-team", 08:30:25 INFO - "revision": "13aad7c0cfda", 08:30:25 INFO - "stage_platform": "linux64", 08:30:25 INFO - "builduid": "33463bf984224435a4b11bedebff5e15", 08:30:25 INFO - "slavebuilddir": "test" 08:30:25 INFO - } 08:30:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - ##### 08:30:25 INFO - ##### Finished read-buildbot-config step (success) 08:30:25 INFO - ##### 08:30:25 INFO - ##### 08:30:25 INFO - ##### Running download-and-extract step. 08:30:25 INFO - ##### 08:30:25 INFO - Running pre-action listener: _resource_record_pre_action 08:30:25 INFO - Running main action method: download_and_extract 08:30:25 INFO - mkdir: /builds/slave/test/build/tests 08:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:25 INFO - https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:30:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:30:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:30:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:30:26 INFO - Downloaded 1361 bytes. 08:30:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:30:26 INFO - Using the following test package requirements: 08:30:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:30:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:30:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:30:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'jsshell-linux-x86_64.zip'], 08:30:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:30:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:30:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:30:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:30:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:30:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:30:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:26 INFO - https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:27 INFO - Downloaded 22713224 bytes. 08:30:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:30:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:30:28 INFO - Return code: 0 08:30:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:28 INFO - https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:29 INFO - Downloaded 22713224 bytes. 08:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:30:30 INFO - Return code: 0 08:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:30 INFO - https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:30:31 INFO - Downloaded 14405245 bytes. 08:30:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:30:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:30:32 INFO - Return code: 0 08:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:32 INFO - https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:30:33 INFO - Downloaded 56288709 bytes. 08:30:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:30:33 INFO - mkdir: /builds/slave/test/properties 08:30:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:30:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:30:33 INFO - Contents: 08:30:33 INFO - build_url:https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:30:34 INFO - Running post-action listener: _resource_record_post_action 08:30:34 INFO - Running post-action listener: set_extra_try_arguments 08:30:34 INFO - ##### 08:30:34 INFO - ##### Finished download-and-extract step (success) 08:30:34 INFO - ##### 08:30:34 INFO - ##### 08:30:34 INFO - ##### Running populate-webroot step. 08:30:34 INFO - ##### 08:30:34 INFO - Running pre-action listener: _resource_record_pre_action 08:30:34 INFO - Running main action method: populate_webroot 08:30:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:30:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:30:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:30:34 INFO - '--tppagecycles', 08:30:34 INFO - '7'], 08:30:34 INFO - 'tests': ['tsvgm']}}, 08:30:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:30:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:30:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:30:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:30:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['damp', 'tps']}, 08:30:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'tests': ['damp', 'tps']}, 08:30:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['dromaeo_dom']}, 08:30:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:30:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['basic_compositor_video']}, 08:30:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:30:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['a11yr', 08:30:34 INFO - 'ts_paint', 08:30:34 INFO - 'tpaint', 08:30:34 INFO - 'sessionrestore', 08:30:34 INFO - 'sessionrestore_no_auto_restore', 08:30:34 INFO - 'tabpaint']}, 08:30:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['tsvgx', 08:30:34 INFO - 'tsvgr_opacity', 08:30:34 INFO - 'tart', 08:30:34 INFO - 'tscrollx', 08:30:34 INFO - 'cart']}, 08:30:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:30:34 INFO - 'tsvgr_opacity', 08:30:34 INFO - 'tart', 08:30:34 INFO - 'tscrollx', 08:30:34 INFO - 'cart']}, 08:30:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'talos_options': ['--disable-e10s'], 08:30:34 INFO - 'tests': ['tp5o']}, 08:30:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'tests': ['tp5o']}, 08:30:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'talos_options': ['--disable-e10s', 08:30:34 INFO - '--xperf_path', 08:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:34 INFO - 'tests': ['tp5n']}, 08:30:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:34 INFO - 'talos_options': ['--xperf_path', 08:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:34 INFO - 'tests': ['tp5n']}}, 08:30:34 INFO - 'talos.zip': {'path': '', 08:30:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:34 INFO - Running post-action listener: _resource_record_post_action 08:30:34 INFO - ##### 08:30:34 INFO - ##### Finished populate-webroot step (success) 08:30:34 INFO - ##### 08:30:34 INFO - ##### 08:30:34 INFO - ##### Running create-virtualenv step. 08:30:34 INFO - ##### 08:30:34 INFO - Running pre-action listener: _resource_record_pre_action 08:30:34 INFO - Running main action method: create_virtualenv 08:30:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:30:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:30:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:30:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:30:34 INFO - Using real prefix '/usr' 08:30:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:30:36 INFO - Installing pip.................done. 08:30:36 INFO - Return code: 0 08:30:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:36 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:30:36 INFO - Using env: {'DISPLAY': ':0', 08:30:36 INFO - 'HOME': '/home/cltbld', 08:30:36 INFO - 'LANG': 'en_US.UTF-8', 08:30:36 INFO - 'LANGUAGE': 'en_US:en', 08:30:36 INFO - 'LOGNAME': 'cltbld', 08:30:36 INFO - 'MAIL': '/var/mail/cltbld', 08:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:36 INFO - 'MOZ_NO_REMOTE': '1', 08:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:36 INFO - 'NO_EM_RESTART': '1', 08:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:36 INFO - 'PWD': '/builds/slave/test', 08:30:36 INFO - 'SHELL': '/bin/bash', 08:30:36 INFO - 'SHLVL': '1', 08:30:36 INFO - 'TERM': 'linux', 08:30:36 INFO - 'TMOUT': '86400', 08:30:36 INFO - 'USER': 'cltbld', 08:30:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:36 INFO - '_': '/tools/buildbot/bin/python'} 08:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:30:37 INFO - Cleaning up... 08:30:37 INFO - Return code: 0 08:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:37 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:30:37 INFO - Using env: {'DISPLAY': ':0', 08:30:37 INFO - 'HOME': '/home/cltbld', 08:30:37 INFO - 'LANG': 'en_US.UTF-8', 08:30:37 INFO - 'LANGUAGE': 'en_US:en', 08:30:37 INFO - 'LOGNAME': 'cltbld', 08:30:37 INFO - 'MAIL': '/var/mail/cltbld', 08:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:37 INFO - 'MOZ_NO_REMOTE': '1', 08:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:37 INFO - 'NO_EM_RESTART': '1', 08:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:37 INFO - 'PWD': '/builds/slave/test', 08:30:37 INFO - 'SHELL': '/bin/bash', 08:30:37 INFO - 'SHLVL': '1', 08:30:37 INFO - 'TERM': 'linux', 08:30:37 INFO - 'TMOUT': '86400', 08:30:37 INFO - 'USER': 'cltbld', 08:30:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:37 INFO - '_': '/tools/buildbot/bin/python'} 08:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:37 INFO - Downloading/unpacking psutil>=3.1.1 08:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:39 INFO - Installing collected packages: psutil 08:30:39 INFO - Running setup.py install for psutil 08:30:39 INFO - building 'psutil._psutil_linux' extension 08:30:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:30:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:30:39 INFO - building 'psutil._psutil_posix' extension 08:30:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:30:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:39 INFO - Successfully installed psutil 08:30:39 INFO - Cleaning up... 08:30:39 INFO - Return code: 0 08:30:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:39 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:30:39 INFO - Using env: {'DISPLAY': ':0', 08:30:39 INFO - 'HOME': '/home/cltbld', 08:30:39 INFO - 'LANG': 'en_US.UTF-8', 08:30:39 INFO - 'LANGUAGE': 'en_US:en', 08:30:39 INFO - 'LOGNAME': 'cltbld', 08:30:39 INFO - 'MAIL': '/var/mail/cltbld', 08:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:39 INFO - 'MOZ_NO_REMOTE': '1', 08:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:39 INFO - 'NO_EM_RESTART': '1', 08:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:39 INFO - 'PWD': '/builds/slave/test', 08:30:39 INFO - 'SHELL': '/bin/bash', 08:30:39 INFO - 'SHLVL': '1', 08:30:39 INFO - 'TERM': 'linux', 08:30:39 INFO - 'TMOUT': '86400', 08:30:39 INFO - 'USER': 'cltbld', 08:30:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:39 INFO - '_': '/tools/buildbot/bin/python'} 08:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:30:42 INFO - Installing collected packages: mozsystemmonitor 08:30:42 INFO - Running setup.py install for mozsystemmonitor 08:30:42 INFO - Successfully installed mozsystemmonitor 08:30:42 INFO - Cleaning up... 08:30:42 INFO - Return code: 0 08:30:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:42 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:30:42 INFO - Using env: {'DISPLAY': ':0', 08:30:42 INFO - 'HOME': '/home/cltbld', 08:30:42 INFO - 'LANG': 'en_US.UTF-8', 08:30:42 INFO - 'LANGUAGE': 'en_US:en', 08:30:42 INFO - 'LOGNAME': 'cltbld', 08:30:42 INFO - 'MAIL': '/var/mail/cltbld', 08:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:42 INFO - 'MOZ_NO_REMOTE': '1', 08:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:42 INFO - 'NO_EM_RESTART': '1', 08:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:42 INFO - 'PWD': '/builds/slave/test', 08:30:42 INFO - 'SHELL': '/bin/bash', 08:30:42 INFO - 'SHLVL': '1', 08:30:42 INFO - 'TERM': 'linux', 08:30:42 INFO - 'TMOUT': '86400', 08:30:42 INFO - 'USER': 'cltbld', 08:30:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:42 INFO - '_': '/tools/buildbot/bin/python'} 08:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:42 INFO - Downloading/unpacking jsonschema==2.5.1 08:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:30:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:30:44 INFO - warning: no files found matching '*.txt' 08:30:44 INFO - no previously-included directories found matching 'build' 08:30:44 INFO - no previously-included directories found matching 'dist' 08:30:44 INFO - no previously-included directories found matching '.git*' 08:30:44 INFO - Installing collected packages: jsonschema, functools32 08:30:44 INFO - Running setup.py install for functools32 08:30:44 INFO - warning: no files found matching '*.txt' 08:30:44 INFO - no previously-included directories found matching 'build' 08:30:44 INFO - no previously-included directories found matching 'dist' 08:30:44 INFO - no previously-included directories found matching '.git*' 08:30:44 INFO - Successfully installed jsonschema functools32 08:30:44 INFO - Cleaning up... 08:30:44 INFO - Return code: 0 08:30:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:44 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:30:44 INFO - Using env: {'DISPLAY': ':0', 08:30:44 INFO - 'HOME': '/home/cltbld', 08:30:44 INFO - 'LANG': 'en_US.UTF-8', 08:30:44 INFO - 'LANGUAGE': 'en_US:en', 08:30:44 INFO - 'LOGNAME': 'cltbld', 08:30:44 INFO - 'MAIL': '/var/mail/cltbld', 08:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:44 INFO - 'MOZ_NO_REMOTE': '1', 08:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:44 INFO - 'NO_EM_RESTART': '1', 08:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:44 INFO - 'PWD': '/builds/slave/test', 08:30:44 INFO - 'SHELL': '/bin/bash', 08:30:44 INFO - 'SHLVL': '1', 08:30:44 INFO - 'TERM': 'linux', 08:30:44 INFO - 'TMOUT': '86400', 08:30:44 INFO - 'USER': 'cltbld', 08:30:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:44 INFO - '_': '/tools/buildbot/bin/python'} 08:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:30:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:47 INFO - Downloading docopt-0.6.1.tar.gz 08:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:47 INFO - Running setup.py install for blobuploader 08:30:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:47 INFO - Running setup.py install for requests 08:30:48 INFO - Running setup.py install for docopt 08:30:48 INFO - Successfully installed blobuploader requests docopt 08:30:48 INFO - Cleaning up... 08:30:48 INFO - Return code: 0 08:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:48 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:48 INFO - Using env: {'DISPLAY': ':0', 08:30:48 INFO - 'HOME': '/home/cltbld', 08:30:48 INFO - 'LANG': 'en_US.UTF-8', 08:30:48 INFO - 'LANGUAGE': 'en_US:en', 08:30:48 INFO - 'LOGNAME': 'cltbld', 08:30:48 INFO - 'MAIL': '/var/mail/cltbld', 08:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:48 INFO - 'MOZ_NO_REMOTE': '1', 08:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:48 INFO - 'NO_EM_RESTART': '1', 08:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:48 INFO - 'PWD': '/builds/slave/test', 08:30:48 INFO - 'SHELL': '/bin/bash', 08:30:48 INFO - 'SHLVL': '1', 08:30:48 INFO - 'TERM': 'linux', 08:30:48 INFO - 'TMOUT': '86400', 08:30:48 INFO - 'USER': 'cltbld', 08:30:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:48 INFO - '_': '/tools/buildbot/bin/python'} 08:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:48 INFO - Running setup.py (path:/tmp/pip-BwxN6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:48 INFO - Running setup.py (path:/tmp/pip-DdQBtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:48 INFO - Running setup.py (path:/tmp/pip-VOdWnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:48 INFO - Running setup.py (path:/tmp/pip-h_cCNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:48 INFO - Running setup.py (path:/tmp/pip-KvAotN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:48 INFO - Running setup.py (path:/tmp/pip-Derytb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:48 INFO - Running setup.py (path:/tmp/pip-a6WGdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:48 INFO - Running setup.py (path:/tmp/pip-HB8jhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:49 INFO - Running setup.py (path:/tmp/pip-iO2nXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:49 INFO - Running setup.py (path:/tmp/pip-rCY6MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:49 INFO - Running setup.py (path:/tmp/pip-8oi8im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:49 INFO - Running setup.py (path:/tmp/pip-AazACL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:49 INFO - Running setup.py (path:/tmp/pip-HnYZqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:49 INFO - Running setup.py (path:/tmp/pip-sTxip3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:49 INFO - Running setup.py (path:/tmp/pip-5uKUOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:49 INFO - Running setup.py (path:/tmp/pip-9LSYCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:49 INFO - Running setup.py (path:/tmp/pip-PrTuj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:49 INFO - Running setup.py install for manifestparser 08:30:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:49 INFO - Running setup.py install for mozcrash 08:30:49 INFO - Running setup.py install for mozdebug 08:30:49 INFO - Running setup.py install for mozdevice 08:30:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for mozfile 08:30:50 INFO - Running setup.py install for mozhttpd 08:30:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for mozinfo 08:30:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for mozInstall 08:30:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for mozleak 08:30:50 INFO - Running setup.py install for mozlog 08:30:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for moznetwork 08:30:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Running setup.py install for mozprocess 08:30:50 INFO - Running setup.py install for mozprofile 08:30:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:51 INFO - Running setup.py install for mozrunner 08:30:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:51 INFO - Running setup.py install for mozscreenshot 08:30:51 INFO - Running setup.py install for moztest 08:30:51 INFO - Running setup.py install for mozversion 08:30:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:51 INFO - Cleaning up... 08:30:51 INFO - Return code: 0 08:30:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:51 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:51 INFO - Using env: {'DISPLAY': ':0', 08:30:51 INFO - 'HOME': '/home/cltbld', 08:30:51 INFO - 'LANG': 'en_US.UTF-8', 08:30:51 INFO - 'LANGUAGE': 'en_US:en', 08:30:51 INFO - 'LOGNAME': 'cltbld', 08:30:51 INFO - 'MAIL': '/var/mail/cltbld', 08:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:51 INFO - 'MOZ_NO_REMOTE': '1', 08:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:51 INFO - 'NO_EM_RESTART': '1', 08:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:51 INFO - 'PWD': '/builds/slave/test', 08:30:51 INFO - 'SHELL': '/bin/bash', 08:30:51 INFO - 'SHLVL': '1', 08:30:51 INFO - 'TERM': 'linux', 08:30:51 INFO - 'TMOUT': '86400', 08:30:51 INFO - 'USER': 'cltbld', 08:30:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:51 INFO - '_': '/tools/buildbot/bin/python'} 08:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:51 INFO - Running setup.py (path:/tmp/pip-TD1bDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:51 INFO - Running setup.py (path:/tmp/pip-Io9iPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:51 INFO - Running setup.py (path:/tmp/pip-r0V75l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:51 INFO - Running setup.py (path:/tmp/pip-3kmKQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:51 INFO - Running setup.py (path:/tmp/pip-Cf2BH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:52 INFO - Running setup.py (path:/tmp/pip-C9x_Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:52 INFO - Running setup.py (path:/tmp/pip-IP2tEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:52 INFO - Running setup.py (path:/tmp/pip-TOEGHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:52 INFO - Running setup.py (path:/tmp/pip-DbisFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:52 INFO - Running setup.py (path:/tmp/pip-y_3qrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:52 INFO - Running setup.py (path:/tmp/pip-bHPdjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:52 INFO - Running setup.py (path:/tmp/pip-r1yJgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:52 INFO - Running setup.py (path:/tmp/pip-PGY_Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:52 INFO - Running setup.py (path:/tmp/pip-X8L6xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:52 INFO - Running setup.py (path:/tmp/pip-gA3pXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:52 INFO - Running setup.py (path:/tmp/pip-Ns3jqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:52 INFO - Running setup.py (path:/tmp/pip-scklGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:54 INFO - Downloading blessings-1.6.tar.gz 08:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:54 INFO - Installing collected packages: blessings 08:30:54 INFO - Running setup.py install for blessings 08:30:54 INFO - Successfully installed blessings 08:30:54 INFO - Cleaning up... 08:30:55 INFO - Return code: 0 08:30:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:55 INFO - Reading from file tmpfile_stdout 08:30:55 INFO - Current package versions: 08:30:55 INFO - argparse == 1.2.1 08:30:55 INFO - blessings == 1.6 08:30:55 INFO - blobuploader == 1.2.4 08:30:55 INFO - docopt == 0.6.1 08:30:55 INFO - functools32 == 3.2.3-2 08:30:55 INFO - jsonschema == 2.5.1 08:30:55 INFO - manifestparser == 1.1 08:30:55 INFO - mozInstall == 1.12 08:30:55 INFO - mozcrash == 0.17 08:30:55 INFO - mozdebug == 0.1 08:30:55 INFO - mozdevice == 0.48 08:30:55 INFO - mozfile == 1.2 08:30:55 INFO - mozhttpd == 0.7 08:30:55 INFO - mozinfo == 0.9 08:30:55 INFO - mozleak == 0.1 08:30:55 INFO - mozlog == 3.2 08:30:55 INFO - moznetwork == 0.27 08:30:55 INFO - mozprocess == 0.22 08:30:55 INFO - mozprofile == 0.28 08:30:55 INFO - mozrunner == 6.11 08:30:55 INFO - mozscreenshot == 0.1 08:30:55 INFO - mozsystemmonitor == 0.3 08:30:55 INFO - moztest == 0.7 08:30:55 INFO - mozversion == 1.4 08:30:55 INFO - psutil == 3.1.1 08:30:55 INFO - requests == 1.2.3 08:30:55 INFO - wsgiref == 0.1.2 08:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:55 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:55 INFO - Using env: {'DISPLAY': ':0', 08:30:55 INFO - 'HOME': '/home/cltbld', 08:30:55 INFO - 'LANG': 'en_US.UTF-8', 08:30:55 INFO - 'LANGUAGE': 'en_US:en', 08:30:55 INFO - 'LOGNAME': 'cltbld', 08:30:55 INFO - 'MAIL': '/var/mail/cltbld', 08:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:55 INFO - 'MOZ_NO_REMOTE': '1', 08:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:55 INFO - 'NO_EM_RESTART': '1', 08:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:55 INFO - 'PWD': '/builds/slave/test', 08:30:55 INFO - 'SHELL': '/bin/bash', 08:30:55 INFO - 'SHLVL': '1', 08:30:55 INFO - 'TERM': 'linux', 08:30:55 INFO - 'TMOUT': '86400', 08:30:55 INFO - 'USER': 'cltbld', 08:30:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:55 INFO - '_': '/tools/buildbot/bin/python'} 08:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:30:55 INFO - Cleaning up... 08:30:55 INFO - Return code: 0 08:30:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:55 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:30:55 INFO - Using env: {'DISPLAY': ':0', 08:30:55 INFO - 'HOME': '/home/cltbld', 08:30:55 INFO - 'LANG': 'en_US.UTF-8', 08:30:55 INFO - 'LANGUAGE': 'en_US:en', 08:30:55 INFO - 'LOGNAME': 'cltbld', 08:30:55 INFO - 'MAIL': '/var/mail/cltbld', 08:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:55 INFO - 'MOZ_NO_REMOTE': '1', 08:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:55 INFO - 'NO_EM_RESTART': '1', 08:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:55 INFO - 'PWD': '/builds/slave/test', 08:30:55 INFO - 'SHELL': '/bin/bash', 08:30:55 INFO - 'SHLVL': '1', 08:30:55 INFO - 'TERM': 'linux', 08:30:55 INFO - 'TMOUT': '86400', 08:30:55 INFO - 'USER': 'cltbld', 08:30:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:55 INFO - '_': '/tools/buildbot/bin/python'} 08:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:55 INFO - Cleaning up... 08:30:55 INFO - Return code: 0 08:30:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:55 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 0x7f1103838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:30:55 INFO - Using env: {'DISPLAY': ':0', 08:30:55 INFO - 'HOME': '/home/cltbld', 08:30:55 INFO - 'LANG': 'en_US.UTF-8', 08:30:55 INFO - 'LANGUAGE': 'en_US:en', 08:30:55 INFO - 'LOGNAME': 'cltbld', 08:30:55 INFO - 'MAIL': '/var/mail/cltbld', 08:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:55 INFO - 'MOZ_NO_REMOTE': '1', 08:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:55 INFO - 'NO_EM_RESTART': '1', 08:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:55 INFO - 'PWD': '/builds/slave/test', 08:30:55 INFO - 'SHELL': '/bin/bash', 08:30:55 INFO - 'SHLVL': '1', 08:30:55 INFO - 'TERM': 'linux', 08:30:55 INFO - 'TMOUT': '86400', 08:30:55 INFO - 'USER': 'cltbld', 08:30:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:55 INFO - '_': '/tools/buildbot/bin/python'} 08:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:55 INFO - Downloading/unpacking flake8 08:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:30:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:30:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:30:58 INFO - no previously-included directories found matching 'docs/_build' 08:30:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:30:58 INFO - Running setup.py install for pep8 08:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:30:58 INFO - no previously-included directories found matching 'docs/_build' 08:30:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:30:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:30:58 INFO - Cleaning up... 08:30:58 INFO - Return code: 0 08:30:58 INFO - Running post-action listener: _resource_record_post_action 08:30:58 INFO - Running post-action listener: _start_resource_monitoring 08:30:58 INFO - Starting resource monitoring. 08:30:58 INFO - ##### 08:30:58 INFO - ##### Finished create-virtualenv step (success) 08:30:58 INFO - ##### 08:30:58 INFO - ##### 08:30:58 INFO - ##### Running install step. 08:30:58 INFO - ##### 08:30:58 INFO - Running pre-action listener: _resource_record_pre_action 08:30:58 INFO - Running main action method: install 08:30:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:59 INFO - Reading from file tmpfile_stdout 08:30:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:59 INFO - Reading from file tmpfile_stdout 08:30:59 INFO - Output received: 08:30:59 INFO - Usage: mozinstall [options] installer 08:30:59 INFO - Options: 08:30:59 INFO - -h, --help show this help message and exit 08:30:59 INFO - -d DEST, --destination=DEST 08:30:59 INFO - Directory to install application into. [default: 08:30:59 INFO - "/builds/slave/test"] 08:30:59 INFO - --app=APP Application being installed. [default: firefox] 08:30:59 INFO - mkdir: /builds/slave/test/build/application 08:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:31:15 INFO - Reading from file tmpfile_stdout 08:31:15 INFO - Output received: 08:31:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:31:15 INFO - Running post-action listener: _resource_record_post_action 08:31:15 INFO - ##### 08:31:15 INFO - ##### Finished install step (success) 08:31:15 INFO - ##### 08:31:15 INFO - ##### 08:31:15 INFO - ##### Running run-tests step. 08:31:15 INFO - ##### 08:31:15 INFO - Running pre-action listener: _resource_record_pre_action 08:31:15 INFO - Running main action method: run_tests 08:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:31:15 INFO - Python 2.7.3 08:31:15 INFO - Return code: 0 08:31:15 INFO - grabbing minidump binary from tooltool 08:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:15 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 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:31:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:31:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:31:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:31:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:31:15 INFO - Return code: 0 08:31:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:31:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:31:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:31:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:31:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:31:16 INFO - Return code: 0 08:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:31:16 INFO - Using env: {'DISPLAY': ':0', 08:31:16 INFO - 'HOME': '/home/cltbld', 08:31:16 INFO - 'LANG': 'en_US.UTF-8', 08:31:16 INFO - 'LANGUAGE': 'en_US:en', 08:31:16 INFO - 'LOGNAME': 'cltbld', 08:31:16 INFO - 'MAIL': '/var/mail/cltbld', 08:31:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:31:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:16 INFO - 'MOZ_NO_REMOTE': '1', 08:31:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:16 INFO - 'NO_EM_RESTART': '1', 08:31:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:16 INFO - 'PWD': '/builds/slave/test', 08:31:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:31:16 INFO - 'SHELL': '/bin/bash', 08:31:16 INFO - 'SHLVL': '1', 08:31:16 INFO - 'TERM': 'linux', 08:31:16 INFO - 'TMOUT': '86400', 08:31:16 INFO - 'USER': 'cltbld', 08:31:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787', 08:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:16 INFO - '_': '/tools/buildbot/bin/python'} 08:31:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:31:16 INFO - mozversion application_buildid: 20160627075158 08:31:16 INFO - mozversion application_changeset: 13aad7c0cfdaa970c2a57f9d03d9a0238c8519e3 08:31:16 INFO - mozversion application_display_name: Nightly 08:31:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:16 INFO - mozversion application_name: Firefox 08:31:16 INFO - mozversion application_remotingname: firefox 08:31:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:31:16 INFO - mozversion application_vendor: Mozilla 08:31:16 INFO - mozversion application_version: 50.0a1 08:31:16 INFO - mozversion platform_buildid: 20160627075158 08:31:16 INFO - mozversion platform_changeset: 13aad7c0cfdaa970c2a57f9d03d9a0238c8519e3 08:31:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:31:16 INFO - mozversion platform_version: 50.0a1 08:31:16 INFO - using testdate: 1467041476 08:31:16 INFO - actual date: 1467041476 08:31:16 INFO - starting webserver on 'localhost:45301' 08:31:16 INFO - SUITE-START | Running 2 tests 08:31:16 INFO - TEST-START | dromaeo_css 08:31:16 INFO - operating with platform_type : linux_ 08:31:16 INFO - Initialising browser for dromaeo_css test... 08:31:16 INFO - TEST-INFO | started process 2283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBtLyk/profile http://localhost:45301/getInfo.html) 08:31:21 INFO - PROCESS | 2283 | __metrics Screen width/height:1600/1200 08:31:21 INFO - PROCESS | 2283 | colorDepth:24 08:31:21 INFO - PROCESS | 2283 | Browser inner width/height: 1024/697 08:31:21 INFO - PROCESS | 2283 | __metrics 08:31:21 ERROR - PROCESS | 2283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:31:22 INFO - TEST-INFO | 2283: exit 0 08:31:22 INFO - Browser initialized. 08:31:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:31:22 INFO - TEST-INFO | started process 2400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBtLyk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:35 INFO - PROCESS | 2400 | RSS: Main: 186621952 08:31:35 INFO - PROCESS | 2400 | 08:32:24 INFO - PROCESS | 2400 | 1467041544629 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:34:36 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45301/tests/dromaeo/cssquery-ext.html) 08:34:37 INFO - PROCESS | 2400 | RSS: Main: 189612032 08:34:37 INFO - PROCESS | 2400 | 08:37:40 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-ext.html (next: http://localhost:45301/tests/dromaeo/cssquery-jquery.html) 08:37:40 INFO - PROCESS | 2400 | RSS: Main: 188133376 08:37:40 INFO - PROCESS | 2400 | 08:40:42 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45301/tests/dromaeo/cssquery-mootools.html) 08:40:43 INFO - PROCESS | 2400 | RSS: Main: 189177856 08:40:43 INFO - PROCESS | 2400 | 08:43:45 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45301/tests/dromaeo/cssquery-prototype.html) 08:43:45 INFO - PROCESS | 2400 | RSS: Main: 186818560 08:43:45 INFO - PROCESS | 2400 | 08:46:48 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45301/tests/dromaeo/cssquery-yui.html) 08:46:48 INFO - PROCESS | 2400 | RSS: Main: 188858368 08:46:48 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | Cycle 1(1): loaded http://localhost:45301/tests/dromaeo/cssquery-yui.html (next: http://localhost:45301/tests/dromaeo/cssquery-dojo.html) 08:49:51 INFO - PROCESS | 2400 | RSS: Main: 189845504 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | __start_tp_report 08:49:51 INFO - PROCESS | 2400 | _x_x_mozilla_page_load 08:49:51 INFO - PROCESS | 2400 | _x_x_mozilla_page_load_details 08:49:51 INFO - PROCESS | 2400 | |i|pagename|runs| 08:49:51 INFO - PROCESS | 2400 | |0;dojo.html;2677.6652918385203;2704.1617098699394;2714.307851497868;2733.562629979204;2740.4245108527207;4926.7536623168835;4931.53150450707;5006.699598024121;5014.42334131575;5052.393712754465;4868.878278043042;4896.510348965102;4937.827176048839;4962.801487940487;4970.378702662168;4519.322101684749;4533.659975501851;4644.2801365788355;4657.091867085919;4670.6497012724185;569.6243276501629;4483.34991426243;4597.954020459786;4605.4933957264675;4643.442786865564;4518.254488009475;4561.7491037992895;4592.977035114803;4606.631469482433;4652.185867473178;4507.143642707875;4598.448186217675;4615.492295847454;4635.0729854029;4652.906941861178;4505.977470112662;4535.365048893158;4547.79534920926;4576.405067341224;4578.633709303281;4895.167821470359;4933.80264789408;4962.826301079445;4966.826161084381;5034.84895453137;5232.633715639907;5303.204519322094;5348.652337598043;5370.865728356784;5445.210444485528;5405.891882162374;5444.156155795858;5445.992491389105;5461.18082287656;5507.394186639466;5016.3980322361185;5028.472010438852;5051.898962020776;5058.721770302595;5107.821226257063;5363.517283444508;5440.619156659075;5474.91787623178;5531.834044978657;5580.776768929279;5286;5289.761960711778;5294.444083371268;5302.92045619316;5340.412554618989;5345.786168553292;5381.73091345439;5387.81142660005;5389.380221274525;5428.185772134132;5107.489251074863;5242.868928276747;5259.027079990214;5313.468653134656;5342.358916929916;5131.230315452712;5229.790808367698;5231.398389185292;5241;5275.235090911796;4593.989322349078;4596.011857450664;4605.217113090783;4607.746573938465;4650.95349046512;3928.7839168845417;3933.567307596162;3942.15243722601;3991.201759648082;4023.3964905264443;4636.4899861015265;4642.628589712815;4653.046125544255;4675.76621168947;4721.3390125382475;5368.677879327252;5405.5135037846785;5407.810726624549;5425.186222066722;5462;4553.977230113828;4580.702254353523;4625.953740462553;4640.6751527393435;4658.883527911829;4832.4684284728655;4833.685810422311;4838.661293709407;4859.927101093486;4908.092002979461;4943.876403089952;4993.950060499421;5012.7994880205115;5020.171671674133;5074.289599456153;5317.521423071942;5337.6797392156595;5342.866428339323;5361.973190134025;5363.007843548799;4973.825916092919;4985.5762260208285;5008.073506401327;5017.498250174954;5044.697318160922;5095.949040509548;5151.665141765773;5254.422013578427;5256.658317209369;5274.261603375454;5251.684898906078;5264.15773476242;5292.629515934002;5293.497117773805;5335.226392173191;5129.743512824419;5162.561182299396;5176.301199338041;5178;5221.582273418041;5040.647154699136;5102.158143906214;5140.3831540215415;5177.611679124006;5181;4913.680610760289;4984.40187177541;5040.420351659606;5048.066107769928;5162.6902385856965;5207.817726379559;5210.687358758487;5228.424873263862;5233.267342571967;5278.261043453843;4896;5042.268871013609;5077.136886729339;5080.237964305384;5081.187010078517 08:49:51 INFO - PROCESS | 2400 | |1;ext.html;547.1713021491782;587.4125874125874;593.89013032589;602.6173379903762;611.8283487122161;34257.14357141073;37187.25625487488;37373.252534949315;37620.435693464555;37720.24559508808;38760.22479550407;39075;39107.804460977655;39149.608503914955;39238.80380598093;7709.383249340053;7855.921440785576;7869.13439521655;7880.448368614199;7880.487768295071;7760;7798.947142135824;7831.882521762178;7852.882206766903;7871.606419678993;7838.529688218697;7846.72536461224;7891.684332626717;7892.289693927545;7908.960455197716;7816.609169541529;7882.408819338572;7890.210978902092;7893.05283365994;7919.168487308865;7887.132415434297;7924.08872979609;7952.284294413473;7965.084015338252;7966.362690984707;37048;37398.626013739784;37483.62516374856;37568;37614.81192594047;2900.1879473747385;3034.6813584573742;3389.6440873708398;3407.335569563911;3680.5031320771623;28975.710242897723;29383.70616293831;29421.55867661987;29614.111576652736;30004.099877003726;3116.1274843043984;3234.7897386669792;3241.7082462578246;3261.624913134996;3280.6063272407223;262010;264103;265764;265771;267574;31987.52018719721;56025.71987140038;56488;56548;56570.15144772832;31824.681753182635;33267.16832079169;33505;33541.49687754686;33630.66369336275;13185.077044606976;13342.866571334162;13364.131331463424;13374.197548147142;13464.93267533656;10903.672889813319;10993.560257589766;11127.276727012719;11143.275687080313;11158.497867595977;7801.2198780121535;7863.056433228049;7896.210378962058;7940.404469664798;7941.563214023168;3109.595752552154;3110.1136176189675;3112.1752735525106;3167.2398624329994;3183.3474137801695;842.8609279468819;845.9746207613781;862.7627402464373;877.9385443018928;883.656811893157;27079.64601769943;27628.861855690593;27655;28305.29236769056;28457.430851382855;953.6233187890745;955.8231727130503;958.6357184269933;982.6560703753629;997.5411310796969;14614.196219208046;14739.484118055816;15087.924560377129;15147.166905820286;15201.087934723952;393098;395436;396323;397205;397747;48350.75824620925;48460.757696212;48792.756036219595;48878.51121488811;49010.75494622504;1166.4284500594817;1170.303669316755;1204.3015051270243;1205.8311836342918;1209.2925638501574;26087;27580.310492237855;27686.723132768413;27776;28098.719012810427;41347;41736.58263417448;41959.37060944027;42084.789576051924;42304.78847605742;307919;312156;313212;313983;313993;24909.62635560432;25161.24516264515;25488.10791622284;25606.487870242865;25772.613410798476;41885.16229675328;41955.7902210487;42054;42247.155056899304;42302;35319.646803531636;36017.819910900274;36986.63013369939;37560.24879502449;37684.43473347847;35920.28159436849;36316.45525317175;36739.08152296214;36809.44785828161;37352.62647373491;33443.83278083594;33744.83127584346;33942.66057339395;34196.31607367789;36204.27591448209;32102.839485802422;32840.50739238865;33205.813314688305;33529.49705754367;33853;25180.370490737147;25758.742412575633;25806.741932580433;25820;26077.478450430506 08:49:51 INFO - PROCESS | 2400 | |2;jquery.html;373.88222709846406;374.10028880542296;376.45978021539077;387.1869074942619;388.2119297825415;15631;16717.331306747732;17412.216450259737;17425.825741742578;17429.82570174301;15811.130387828665;15855.286512106954;16883.746743798823;16904.154792260368;16987.06571138587;5046.621503387251;5212.8436146915465;5252.317198764155;5253.7373131343475;5259.973700131494;3734.1411475360546;5719.914201286984;6155.599886007418;6162.5069994400565;6164.691765411734;6090.23872015998;6096.298925623543;6105.572609917308;6198.969005154968;6463.644499552546;6709.9329006709795;6784.423324017464;6849.075374824434;6884.105066341369;6904.620245886499;6804.829879253009;6952.756653517154;6982.546134501241;6991.440684745208;7004.684789184499;21467.355979320644;22642.886785565966;23218.14254859624;23425.06299748008;23912.402189945216;2093.822025127866;2187.464071302541;2671.545837207679;2739.328864428208;2755.7244275572484;13397.12918660284;14302.141871487744;14310.570682879426;14452.205128718022;14938.62653433662;1774.520879362565;1826.2877477783675;1873.7095750158746;1889.0743535667561;1905.2188602672977;60495;62391;69258.30741692569;76674.61662691706;82601.58699206465;15527.223638818014;16512.75230871538;16943.745843812354;17028.318867245172;17067.525208844647;28885;29200.41599168005;29352;29472.852635736683;29645.703542964293;8200.58997050145;9022.413543119676;9082.727518174466;9120.179183873483;9164.404313719588;7486.812829679302;7498.962505187439;7513.436492263102;7523.586202758901;7619.847603047908;8148.83702325962;8312.5428101455;8396.622152003174;8416.705415310435;8455.323574114056;1527.9388824446899;1593.6175317923614;1652.6942515634646;1654.8014238291482;1664.4008157063447;812.321711371;819.8114433680167;827.8634025385744;849.7238397520707;942.0532364973158;16742.83257167437;16961.830381696273;17032.659346812994;17173.57066073358;17253.137343133043;827.9461834980707;842.2125312832521;878.578282424427;879.1647934462286;895.5611750242465;9156.313276504156;9292.767680808034;9431.386959847589;9752.512374381253;9799.559019844124;375374;383730;385494;385940;389645;72616.63691681613;75629.24370756332;76113;88551;89367;917.7659696777413;927.8051609162152;941.1623654947102;978.5498670611456;983.5229913491951;15616.375344986074;15914.204289785695;15932.920335398248;16036.198190090216;16174.595635109217;26361.604575930993;27801.721982780724;36697;37189.81405092957;37900.2419951605;49711.25433118579;53347.4665253358;54150.72924635352;54262.18606720823;54783.45216547943;7512.812179695333;7583.810404739926;7644.732434364993;7699.6535155917;7946.205379462008;11151.275167114112;11694.122940779645;11719.648410547697;11721.941390292994;11785.941070294593;9779;9814.852777208205;9918.900810991798;9920.603175872884;10163.54264058134;10156.187504999434;10190.643327483502;10418;10453.216008799218;10565.471726413802;9659.565319560495;9775.85336219943;9832.311738178545;10021.39871607706;10031;7559.508631938907;7572.280633339824;7657.693692252247;7772.922270777446;7886.763397098096;8792.252658524098;9466.668666596635;9759.316847820584;9770.755731106496;10215.387076775418 08:49:51 INFO - PROCESS | 2400 | |3;mootools.html;1378.7035787305726;1407.9648008799782;1484.302377882395;1656.3954156732796;1667.9666406671868;6959.860802783941;7641.732539361124;7704.114026886909;8221.54781487018;8233.917660823397;7782.338501227388;8021.518708877471;8088.878666820003;8108.067572229195;8129.634166462509;2207.1171531387454;2221.7778222177812;2224.9777502225015;2230.821534277262;2245.0682966568857;2181.803637672609;2191.802737753602;2236;2249.3139592424304;2257.7855103765196;2201.6587428948537;2203.8787866667326;2220.455988282873;2229.1640634761966;2231.2971414004537;2136.1882484655885;2143.282000529832;2155.4395857077116;2158.816500597451;2159.4493404181912;2114.3551216878845;2124.6706760452153;2136.6688163334707;2141.9892900535397;2150.537634408594;8087.393445491612;8100.108988011314;8104.270615644561;8108.878366824502;8114.6754129834735;4596.49438561758;4705.529447055267;4707.45864225615;4719.292106184065;4722.433308003027;2761.3924936514136;2861.413410250894;2862.7852911031755;2866.4410439964217;2890.5519644455144;925.5557332480447;945.952702364879;959.6785076999214;966.8356379415446;974.1719538392381;10849.566017359297;10851.565937362497;10861.511231994578;10892.891071089347;10896.564137434492;4126.91746165075;4212.199682060399;4245.066085461193;4274.038341373166;4298.495526565677;9129.497877616795;9204.079592040742;9210.63157473707;9211.677591284408;9236.168744813;4623.86128416148;4630.189716799547;4633.166030114612;4642.955335049654;4643.2802915548145;3699.926001479955;3968.047668559525;4049.5747946465785;4173.853915112956;4327.285997810389;3618.348697234523;3658.8719394821055;3673.7244706647107;3708.2212735325343;3758.7744735315423;1160.6634076117832;1196.3778835005749;1204.2353105777895;1206.6530597987007;1228.2507670321097;763.6296396247816;802.4302745050962;809.1746418652941;811.9715809946623;822.9218224268685;4738.19450693383;4942.678725882806;5004.199328107486;5015.570562389701;5034.572061374751;794.9046114466186;838.128346519625;862.4221771413169;879.1516186879564;889.586342350797;3331.9666803332143;3415.3852306585054;3423.5378223939947;3470.219200679827;3507.964920350764;9543.141117299338;10012.24908131893;10014;10018.649347272956;10028.949855250678;9821.901780982098;9895.208383329316;9910.752231194134;9913.256505762096;9927.40435573868;7167.247439018932;7274.527155734966;7288.12542494904;7299.343059124704;7304.452166087564;4731.739754313546;4937.925931111108;4992.900141997067;5251;5353.919691204713;8923.41997770143;8968.955155224183;9031.638734450811;9114.316426267924;9150.816983660423;8767.386282960386;9013.143751343612;9330.720078397659;9360.906390936003;9363.297752668714;6963.9303606963285;7004;7057.752978645723;7109.537880037988;7152.284771522806;7546.207648196861;7567.31894129531;7604.619769011638;7619.847603047797;7664.34853037498;6898.517103802686;6904.551204171914;7043.119610048744;7124.5725256484775;7160.713571457083;6684.598924064571;6718.294579069127;6880.179126558087;6902.102726645504;6942.409895158968;5955.196048533566;5986.2517185351835;5990.041593345044;5998.25021872266;6000.249968753906;4323.675724320626;4419.602235798665;4447.599716025573;4469.687121901566;4471.731696098244;4363.005226828312;4367.825286988485;4442.244818380818;4451.643868490448;4482.529334419839 08:49:51 INFO - PROCESS | 2400 | |4;prototype.html;295.08082323562104;299.1593621922398;301.66515168163335;312.0684756003331;314.89471953443405;4927.630427717918;5052.898942021162;5071.644984851062;5205.557527610153;5239.921401178985;5059.949400505994;5085.5423011929015;5144.562712169461;5173.327467429238;5185.662931909433;4011.7994100295014;4054.3310353791735;4054.5945405459515;4063.390491426295;4072.574598890387;3954.604539546051;4060.3503439449696;4065.817038233272;4066.9389959150635;4074.7351422157467;3985.2228815381013;4031.717779755418;4035.9910022494378;4037.4347591337237;4042.3128068228325;3954.4266081418323;4013.8795836124964;4014.1971605678837;4024.959750402517;4042.8382864685377;3572.142685755426;3572.6070132285427;3587;3598.6941110005682;3602.4596310553366;4861.343718597979;5019.824306149304;5022.347094877679;5037.5214354636255;5134.897302053975;4576.8626941191815;4592.47186573545;4601.976990115028;4623.815047398134;4629.930551041737;5380.3274590676165;5397.973010134963;5400.513953744182;5405.459454054563;5415.918761218545;3778.4521244419407;3872.051347419872;3886.7667939923695;3888.997166459276;3892.961070389288;5624.971875140598;5671.120976248647;5672.602917795756;5673.602847800656;5690.687012214326;3970.1067259866877;3997.420374045747;4002.3796311571755;4016.979915100406;4028.5568587455355;3880.553736320303;4019.8392064317686;4065;4076.144009757925;4079.8164082616354;4504.684672072924;4557.5898169164275;4569.657275704336;4603.769811509411;4612.192866248461;5334.59990500714;5344.327836081959;5346.866328341823;5364.597655175878;5412.296401467784;1336.5522549945877;1359.6193065941552;1393.9512117075853;1396.4833011785704;1397.4200706706806;885.9202671759443;890.4879694175745;899.7930475990559;903.9683611073581;909.2998391238709;4203.768792716369;4211.1998720243055;4250.937265683579;4258.61672449481;4282.379055037002;4832.975835120872;4847.127517046965;4858.445297504764;4886.8724016629385;4889.559939605452;4187.874363769091;4196.622303992655;4235.073041766051;4240.957590424118;4258.829646814154;2398.70016247969;2610.538098664716;2622.662442154515;2633.604959256127;2656.309359566527;4571.794269257824;4590.242609969385;4592.517785632527;4629.8148074077335;4639.675222734444;4919.90160196794;4938.8022330063495;4974.303597496353;4983.626228032912;5060.974695126574;4847.781849816767;5234.502722241381;5241.423443421144;5248.685078895202;5251.947480525146;5554.638948468337;5556.944180605672;5591.720413979204;5602.551795856403;5638.182463542681;5284.044903385618;5490.203920431595;5501.752421140978;5526.91709624364;5547.916781248366;5100.311457953128;5173.793048278027;5182.740862956913;5219.791208351623;5252.238425428215;3871.399933010388;3888.3195440798313;3893.3381325175355;3896.883093507199;3936.980315098406;5274.050670879278;5553.666779993213;5574.665520068809;5580.916286255629;5590.105583106683;5359.571234301168;5372.355317361941;5389.622726409114;5392.622516423813;5398.676079435247;5385.919211211756;5388.407275199804;5423.511883930465;5426.755795989111;5437.640589852537;5123.923141152811;5319.643490909793;5322.627416080837;5323.893522129613;5359.812406565908;5424.674519528841;5432.429594892637;5434.728263586884;5439.48324909133;5468.3711373191;5144.922826157535;5282.81510147143;5291.470852914677;5296.788128474972;5330.534103121672 08:49:51 INFO - PROCESS | 2400 | |5;yui.html;641.9165508483896;647.6729251727877;650.7884937395347;658.3679667519184;681.3254877671105;10936.234463587552;11358.716032099202;11373.658790236295;11373.829392559108;12532.937335313334;14268.4292628295;14900.478483253088;14953.252337383141;14953.327100280487;14969.775453368207;606.2664176346626;766.6473422225782;783.694359199914;794.7337641889974;802.3500964219002;798.5049269452918;798.5967086621248;799.3205775091184;801.1627848897915;805.6414895371562;841.9326453883674;842.9873551896726;846.0608724316004;846.124261389462;846.9280111190557;831.8627426474685;835.173178553231;836.2599099796663;838.0781140745131;840.697348954379;609.3236507476697;610.0391882784631;611.2817439508559;615.1449485215554;615.3876892491999;12221;12239.93880030603;12241.20432171906;12280.815787763191;12283.324417157053;12678.112532122756;12847.486100555967;12893.419796109103;13541;13570.198857256937;10222;10241.948790256076;10244.28290019699;10289.639862604772;10399.636012739518;3441.5698037745283;3465.6187819339852;3482.9303413931834;3490.947635785465;3546.4857595648746;51231;53070.14254501113;53082;59374.70312648452;60122.69938650279;10184.236182286359;10288.897111028793;10549.578016879392;10939.617113400993;11200.271982321286;19893.10481028357;20168.193272268945;20195.899020504803;20197;20202.595948080954;7215.422766178693;7263.673134708951;7368.8894666580045;7376.336129748348;7431.29402706742;3679.2457546202963;3682.5396825396824;3743.082944678517;3746.550413950343;3754.0614846288427;2974.6876577959;3010.909672709822;3039.9088027359217;3051.2676957530475;3082.1678146900213;511.69809812210974;518.2123172777357;519.794681100963;554.1715135871817;554.1798138754585;508.788852626156;535.5287347134574;538.4588488569042;542.9619926605179;556.349071586245;7685.42359323053;8225.79435514105;8315.667373305121;8373.204545568162;8743;426.6075210806066;452.5180682573049;497.572088004316;517.0770175237184;531.646455107357;3831.7892515911335;3932.7640341579595;3959.821808018646;4079.9592004079577;4127.525334586501;60094.39905600975;60347.09479357726;74200;108279.45860270805;108987;91406.54296728474;94155.52922235345;94313;94671;94905;49120;72953.06945840243;73866.6306668474;74153;75881;7751.302382785577;7990.400719946144;8238.258556729923;8535.786605334668;8747.737567872973;31910.680893190773;42431.575684242765;43388;43649.56350436455;43692.56307436885;61004.389956101644;63495.6825215871;63916;64028;64526;10270.07569318765;10445;10491.003354681294;10677.89322106769;10746.946265268623;12051.156419050581;12156.696082597651;12178.330191839534;12260.570880019157;12291.201071930296;10986.176036797431;11031.338119712522;11058.778824423627;11976.640700778991;11983.580574679845;10948.726281843017;11071.944640276746;11289.322640641587;11546.076313895037;11607.941960290482;11360.715982100513;11369.4883730234;11418.771624567296;11630.767384652429;11787.882121178678;9453.480058596842;9662.806743864943;9689;9711.805763884824;9842.311038227255;9813;10110.646127385506;10146.644867429604;10167.7458063549;10252.794944101226 08:49:51 INFO - PROCESS | 2400 | __end_tp_report 08:49:51 INFO - PROCESS | 2400 | __start_cc_report 08:49:51 INFO - PROCESS | 2400 | _x_x_mozilla_cycle_collect,394 08:49:51 INFO - PROCESS | 2400 | __end_cc_report 08:49:51 INFO - PROCESS | 2400 | __startTimestamp1467042591736__endTimestamp 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | ------- Summary: start ------- 08:49:51 INFO - PROCESS | 2400 | Number of tests: 6 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#0] dojo.html Cycles:165 Average:4902.12 Median:5040.65 stddev:621.66 (12.3%) stddev-sans-first:598.58 08:49:51 INFO - PROCESS | 2400 | Values: 2677.7 2704.2 2714.3 2733.6 2740.4 4926.8 4931.5 5006.7 5014.4 5052.4 4868.9 4896.5 4937.8 4962.8 4970.4 4519.3 4533.7 4644.3 4657.1 4670.6 569.6 4483.3 4598.0 4605.5 4643.4 4518.3 4561.7 4593.0 4606.6 4652.2 4507.1 4598.4 4615.5 4635.1 4652.9 4506.0 4535.4 4547.8 4576.4 4578.6 4895.2 4933.8 4962.8 4966.8 5034.8 5232.6 5303.2 5348.7 5370.9 5445.2 5405.9 5444.2 5446.0 5461.2 5507.4 5016.4 5028.5 5051.9 5058.7 5107.8 5363.5 5440.6 5474.9 5531.8 5580.8 5286.0 5289.8 5294.4 5302.9 5340.4 5345.8 5381.7 5387.8 5389.4 5428.2 5107.5 5242.9 5259.0 5313.5 5342.4 5131.2 5229.8 5231.4 5241.0 5275.2 4594.0 4596.0 4605.2 4607.7 4651.0 3928.8 3933.6 3942.2 3991.2 4023.4 4636.5 4642.6 4653.0 4675.8 4721.3 5368.7 5405.5 5407.8 5425.2 5462.0 4554.0 4580.7 4626.0 4640.7 4658.9 4832.5 4833.7 4838.7 4859.9 4908.1 4943.9 4994.0 5012.8 5020.2 5074.3 5317.5 5337.7 5342.9 5362.0 5363.0 4973.8 4985.6 5008.1 5017.5 5044.7 5095.9 5151.7 5254.4 5256.7 5274.3 5251.7 5264.2 5292.6 5293.5 5335.2 5129.7 5162.6 5176.3 5178.0 5221.6 5040.6 5102.2 5140.4 5177.6 5181.0 4913.7 4984.4 5040.4 5048.1 5162.7 5207.8 5210.7 5228.4 5233.3 5278.3 4896.0 5042.3 5077.1 5080.2 5081.2 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#1] ext.html Cycles:180 Average:46678.48 Median:20209.79 stddev:86802.28 (429.5%) stddev-sans-first:86976.68 08:49:51 INFO - PROCESS | 2400 | Values: 547.2 587.4 593.9 602.6 611.8 34257.1 37187.3 37373.3 37620.4 37720.2 38760.2 39075.0 39107.8 39149.6 39238.8 7709.4 7855.9 7869.1 7880.4 7880.5 7760.0 7798.9 7831.9 7852.9 7871.6 7838.5 7846.7 7891.7 7892.3 7909.0 7816.6 7882.4 7890.2 7893.1 7919.2 7887.1 7924.1 7952.3 7965.1 7966.4 37048.0 37398.6 37483.6 37568.0 37614.8 2900.2 3034.7 3389.6 3407.3 3680.5 28975.7 29383.7 29421.6 29614.1 30004.1 3116.1 3234.8 3241.7 3261.6 3280.6 262010.0 264103.0 265764.0 265771.0 267574.0 31987.5 56025.7 56488.0 56548.0 56570.2 31824.7 33267.2 33505.0 33541.5 33630.7 13185.1 13342.9 13364.1 13374.2 13464.9 10903.7 10993.6 11127.3 11143.3 11158.5 7801.2 7863.1 7896.2 7940.4 7941.6 3109.6 3110.1 3112.2 3167.2 3183.3 842.9 846.0 862.8 877.9 883.7 27079.6 27628.9 27655.0 28305.3 28457.4 953.6 955.8 958.6 982.7 997.5 14614.2 14739.5 15087.9 15147.2 15201.1 393098.0 395436.0 396323.0 397205.0 397747.0 48350.8 48460.8 48792.8 48878.5 49010.8 1166.4 1170.3 1204.3 1205.8 1209.3 26087.0 27580.3 27686.7 27776.0 28098.7 41347.0 41736.6 41959.4 42084.8 42304.8 307919.0 312156.0 313212.0 313983.0 313993.0 24909.6 25161.2 25488.1 25606.5 25772.6 41885.2 41955.8 42054.0 42247.2 42302.0 35319.6 36017.8 36986.6 37560.2 37684.4 35920.3 36316.5 36739.1 36809.4 37352.6 33443.8 33744.8 33942.7 34196.3 36204.3 32102.8 32840.5 33205.8 33529.5 33853.0 25180.4 25758.7 25806.7 25820.0 26077.5 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#2] jquery.html Cycles:180 Average:25319.52 Median:29303.72 stddev:63432.54 (216.5%) stddev-sans-first:63582.83 08:49:51 INFO - PROCESS | 2400 | Values: 373.9 374.1 376.5 387.2 388.2 15631.0 16717.3 17412.2 17425.8 17429.8 15811.1 15855.3 16883.7 16904.2 16987.1 5046.6 5212.8 5252.3 5253.7 5260.0 3734.1 5719.9 6155.6 6162.5 6164.7 6090.2 6096.3 6105.6 6199.0 6463.6 6709.9 6784.4 6849.1 6884.1 6904.6 6804.8 6952.8 6982.5 6991.4 7004.7 21467.4 22642.9 23218.1 23425.1 23912.4 2093.8 2187.5 2671.5 2739.3 2755.7 13397.1 14302.1 14310.6 14452.2 14938.6 1774.5 1826.3 1873.7 1889.1 1905.2 60495.0 62391.0 69258.3 76674.6 82601.6 15527.2 16512.8 16943.7 17028.3 17067.5 28885.0 29200.4 29352.0 29472.9 29645.7 8200.6 9022.4 9082.7 9120.2 9164.4 7486.8 7499.0 7513.4 7523.6 7619.8 8148.8 8312.5 8396.6 8416.7 8455.3 1527.9 1593.6 1652.7 1654.8 1664.4 812.3 819.8 827.9 849.7 942.1 16742.8 16961.8 17032.7 17173.6 17253.1 827.9 842.2 878.6 879.2 895.6 9156.3 9292.8 9431.4 9752.5 9799.6 375374.0 383730.0 385494.0 385940.0 389645.0 72616.6 75629.2 76113.0 88551.0 89367.0 917.8 927.8 941.2 978.5 983.5 15616.4 15914.2 15932.9 16036.2 16174.6 26361.6 27801.7 36697.0 37189.8 37900.2 49711.3 53347.5 54150.7 54262.2 54783.5 7512.8 7583.8 7644.7 7699.7 7946.2 11151.3 11694.1 11719.6 11721.9 11785.9 9779.0 9814.9 9918.9 9920.6 10163.5 10156.2 10190.6 10418.0 10453.2 10565.5 9659.6 9775.9 9832.3 10021.4 10031.0 7559.5 7572.3 7657.7 7772.9 7886.8 8792.3 9466.7 9759.3 9770.8 10215.4 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#3] mootools.html Cycles:180 Average:5178.43 Median:4838.06 stddev:2955.37 (61.1%) stddev-sans-first:2949.87 08:49:51 INFO - PROCESS | 2400 | Values: 1378.7 1408.0 1484.3 1656.4 1668.0 6959.9 7641.7 7704.1 8221.5 8233.9 7782.3 8021.5 8088.9 8108.1 8129.6 2207.1 2221.8 2225.0 2230.8 2245.1 2181.8 2191.8 2236.0 2249.3 2257.8 2201.7 2203.9 2220.5 2229.2 2231.3 2136.2 2143.3 2155.4 2158.8 2159.4 2114.4 2124.7 2136.7 2142.0 2150.5 8087.4 8100.1 8104.3 8108.9 8114.7 4596.5 4705.5 4707.5 4719.3 4722.4 2761.4 2861.4 2862.8 2866.4 2890.6 925.6 946.0 959.7 966.8 974.2 10849.6 10851.6 10861.5 10892.9 10896.6 4126.9 4212.2 4245.1 4274.0 4298.5 9129.5 9204.1 9210.6 9211.7 9236.2 4623.9 4630.2 4633.2 4643.0 4643.3 3699.9 3968.0 4049.6 4173.9 4327.3 3618.3 3658.9 3673.7 3708.2 3758.8 1160.7 1196.4 1204.2 1206.7 1228.3 763.6 802.4 809.2 812.0 822.9 4738.2 4942.7 5004.2 5015.6 5034.6 794.9 838.1 862.4 879.2 889.6 3332.0 3415.4 3423.5 3470.2 3508.0 9543.1 10012.2 10014.0 10018.6 10028.9 9821.9 9895.2 9910.8 9913.3 9927.4 7167.2 7274.5 7288.1 7299.3 7304.5 4731.7 4937.9 4992.9 5251.0 5353.9 8923.4 8969.0 9031.6 9114.3 9150.8 8767.4 9013.1 9330.7 9360.9 9363.3 6963.9 7004.0 7057.8 7109.5 7152.3 7546.2 7567.3 7604.6 7619.8 7664.3 6898.5 6904.6 7043.1 7124.6 7160.7 6684.6 6718.3 6880.2 6902.1 6942.4 5955.2 5986.3 5990.0 5998.3 6000.2 4323.7 4419.6 4447.6 4469.7 4471.7 4363.0 4367.8 4442.2 4451.6 4482.5 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#4] prototype.html Cycles:180 Average:4392.91 Median:4888.22 stddev:1282.61 (26.2%) stddev-sans-first:1248.79 08:49:51 INFO - PROCESS | 2400 | Values: 295.1 299.2 301.7 312.1 314.9 4927.6 5052.9 5071.6 5205.6 5239.9 5059.9 5085.5 5144.6 5173.3 5185.7 4011.8 4054.3 4054.6 4063.4 4072.6 3954.6 4060.4 4065.8 4066.9 4074.7 3985.2 4031.7 4036.0 4037.4 4042.3 3954.4 4013.9 4014.2 4025.0 4042.8 3572.1 3572.6 3587.0 3598.7 3602.5 4861.3 5019.8 5022.3 5037.5 5134.9 4576.9 4592.5 4602.0 4623.8 4629.9 5380.3 5398.0 5400.5 5405.5 5415.9 3778.5 3872.1 3886.8 3889.0 3893.0 5625.0 5671.1 5672.6 5673.6 5690.7 3970.1 3997.4 4002.4 4017.0 4028.6 3880.6 4019.8 4065.0 4076.1 4079.8 4504.7 4557.6 4569.7 4603.8 4612.2 5334.6 5344.3 5346.9 5364.6 5412.3 1336.6 1359.6 1394.0 1396.5 1397.4 885.9 890.5 899.8 904.0 909.3 4203.8 4211.2 4250.9 4258.6 4282.4 4833.0 4847.1 4858.4 4886.9 4889.6 4187.9 4196.6 4235.1 4241.0 4258.8 2398.7 2610.5 2622.7 2633.6 2656.3 4571.8 4590.2 4592.5 4629.8 4639.7 4919.9 4938.8 4974.3 4983.6 5061.0 4847.8 5234.5 5241.4 5248.7 5251.9 5554.6 5556.9 5591.7 5602.6 5638.2 5284.0 5490.2 5501.8 5526.9 5547.9 5100.3 5173.8 5182.7 5219.8 5252.2 3871.4 3888.3 3893.3 3896.9 3937.0 5274.1 5553.7 5574.7 5580.9 5590.1 5359.6 5372.4 5389.6 5392.6 5398.7 5385.9 5388.4 5423.5 5426.8 5437.6 5123.9 5319.6 5322.6 5323.9 5359.8 5424.7 5432.4 5434.7 5439.5 5468.4 5144.9 5282.8 5291.5 5296.8 5330.5 08:49:51 INFO - PROCESS | 2400 | 08:49:51 INFO - PROCESS | 2400 | [#5] yui.html Cycles:180 Average:17189.07 Median:43671.06 stddev:24526.27 (56.2%) stddev-sans-first:24563.60 08:49:51 INFO - PROCESS | 2400 | Values: 641.9 647.7 650.8 658.4 681.3 10936.2 11358.7 11373.7 11373.8 12532.9 14268.4 14900.5 14953.3 14953.3 14969.8 606.3 766.6 783.7 794.7 802.4 798.5 798.6 799.3 801.2 805.6 841.9 843.0 846.1 846.1 846.9 831.9 835.2 836.3 838.1 840.7 609.3 610.0 611.3 615.1 615.4 12221.0 12239.9 12241.2 12280.8 12283.3 12678.1 12847.5 12893.4 13541.0 13570.2 10222.0 10241.9 10244.3 10289.6 10399.6 3441.6 3465.6 3482.9 3490.9 3546.5 51231.0 53070.1 53082.0 59374.7 60122.7 10184.2 10288.9 10549.6 10939.6 11200.3 19893.1 20168.2 20195.9 20197.0 20202.6 7215.4 7263.7 7368.9 7376.3 7431.3 3679.2 3682.5 3743.1 3746.6 3754.1 2974.7 3010.9 3039.9 3051.3 3082.2 511.7 518.2 519.8 554.2 554.2 508.8 535.5 538.5 543.0 556.3 7685.4 8225.8 8315.7 8373.2 8743.0 426.6 452.5 497.6 517.1 531.6 3831.8 3932.8 3959.8 4080.0 4127.5 60094.4 60347.1 74200.0 108279.5 108987.0 91406.5 94155.5 94313.0 94671.0 94905.0 49120.0 72953.1 73866.6 74153.0 75881.0 7751.3 7990.4 8238.3 8535.8 8747.7 31910.7 42431.6 43388.0 43649.6 43692.6 61004.4 63495.7 63916.0 64028.0 64526.0 10270.1 10445.0 10491.0 10677.9 10746.9 12051.2 12156.7 12178.3 12260.6 12291.2 10986.2 11031.3 11058.8 11976.6 11983.6 10948.7 11071.9 11289.3 11546.1 11607.9 11360.7 11369.5 11418.8 11630.8 11787.9 9453.5 9662.8 9689.0 9711.8 9842.3 9813.0 10110.6 10146.6 10167.7 10252.8 08:49:51 INFO - PROCESS | 2400 | -------- Summary: end -------- 08:49:51 INFO - PROCESS | 2400 | 08:49:52 INFO - TEST-INFO | 2400: exit 0 08:49:52 INFO - TEST-OK | dromaeo_css | took 1115977ms 08:49:52 INFO - TEST-START | kraken 08:49:52 INFO - operating with platform_type : linux_ 08:49:52 INFO - Initialising browser for kraken test... 08:49:52 INFO - TEST-INFO | started process 2727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0gO_S/profile http://localhost:45301/getInfo.html) 08:49:57 INFO - PROCESS | 2727 | __metrics Screen width/height:1600/1200 08:49:57 INFO - PROCESS | 2727 | colorDepth:24 08:49:57 INFO - PROCESS | 2727 | Browser inner width/height: 1024/697 08:49:57 INFO - PROCESS | 2727 | __metrics 08:49:57 ERROR - PROCESS | 2727 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:49:58 INFO - TEST-INFO | 2727: exit 0 08:49:58 INFO - Browser initialized. 08:49:58 INFO - Running cycle 1/1 for kraken test... 08:49:58 INFO - TEST-INFO | started process 2943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0gO_S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:10 INFO - PROCESS | 2943 | RSS: Main: 186429440 08:50:10 INFO - PROCESS | 2943 | 08:50:13 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45301/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:14 INFO - PROCESS | 2943 | RSS: Main: 190357504 08:50:14 INFO - PROCESS | 2943 | 08:50:17 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45301/tests/kraken/driver.html?testName=audio-dft) 08:50:17 INFO - PROCESS | 2943 | RSS: Main: 190148608 08:50:17 INFO - PROCESS | 2943 | 08:50:20 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45301/tests/kraken/driver.html?testName=audio-fft) 08:50:21 INFO - PROCESS | 2943 | RSS: Main: 185982976 08:50:21 INFO - PROCESS | 2943 | 08:50:23 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45301/tests/kraken/driver.html?testName=audio-oscillator) 08:50:24 INFO - PROCESS | 2943 | RSS: Main: 186228736 08:50:24 INFO - PROCESS | 2943 | 08:50:26 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:27 INFO - PROCESS | 2943 | RSS: Main: 186654720 08:50:27 INFO - PROCESS | 2943 | 08:50:30 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45301/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:30 INFO - PROCESS | 2943 | RSS: Main: 187224064 08:50:30 INFO - PROCESS | 2943 | 08:50:34 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45301/tests/kraken/driver.html?testName=imaging-desaturate) 08:50:35 INFO - PROCESS | 2943 | RSS: Main: 184938496 08:50:35 INFO - PROCESS | 2943 | 08:50:38 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45301/tests/kraken/driver.html?testName=json-parse-financial) 08:50:38 INFO - PROCESS | 2943 | RSS: Main: 186253312 08:50:38 INFO - PROCESS | 2943 | 08:50:40 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:50:41 INFO - PROCESS | 2943 | RSS: Main: 186568704 08:50:41 INFO - PROCESS | 2943 | 08:50:43 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:50:43 INFO - PROCESS | 2943 | RSS: Main: 186957824 08:50:43 INFO - PROCESS | 2943 | 08:50:45 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:50:46 INFO - PROCESS | 2943 | RSS: Main: 187154432 08:50:46 INFO - PROCESS | 2943 | 08:50:49 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:50:50 INFO - PROCESS | 2943 | RSS: Main: 187359232 08:50:50 INFO - PROCESS | 2943 | 08:50:53 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:50:53 INFO - PROCESS | 2943 | RSS: Main: 186933248 08:50:53 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:45301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45301/tests/kraken/driver.html?testName=ai-astar) 08:50:55 INFO - PROCESS | 2943 | RSS: Main: 187437056 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | __start_tp_report 08:50:55 INFO - PROCESS | 2943 | _x_x_mozilla_page_load 08:50:55 INFO - PROCESS | 2943 | _x_x_mozilla_page_load_details 08:50:55 INFO - PROCESS | 2943 | |i|pagename|runs| 08:50:55 INFO - PROCESS | 2943 | |0;ai-astar;103;114;108;114;114;121;113;112;113;113 08:50:55 INFO - PROCESS | 2943 | |1;audio-beat-detection;155;130;159;178;132;157;160;133;188;131 08:50:55 INFO - PROCESS | 2943 | |2;audio-dft;166;163;167;169;163;163;164;163;163;164 08:50:55 INFO - PROCESS | 2943 | |3;audio-fft;75;75;76;155;77;77;75;75;159;79 08:50:55 INFO - PROCESS | 2943 | |4;audio-oscillator;87;87;148;87;87;95;133;87;89;145 08:50:55 INFO - PROCESS | 2943 | |5;imaging-gaussian-blur;117;117;118;117;117;118;118;118;118;118 08:50:55 INFO - PROCESS | 2943 | |6;imaging-darkroom;147;148;149;148;147;147;148;148;146;148 08:50:55 INFO - PROCESS | 2943 | |7;imaging-desaturate;95;95;96;96;96;95;97;95;97;95 08:50:55 INFO - PROCESS | 2943 | |8;json-parse-financial;65;65;63;66;65;64;65;64;64;63 08:50:55 INFO - PROCESS | 2943 | |9;json-stringify-tinderbox;65;66;64;66;65;64;65;65;65;65 08:50:55 INFO - PROCESS | 2943 | |10;stanford-crypto-aes;82;81;83;86;84;84;84;84;85;83 08:50:55 INFO - PROCESS | 2943 | |11;stanford-crypto-ccm;135;141;130;136;133;136;135;140;143;133 08:50:55 INFO - PROCESS | 2943 | |12;stanford-crypto-pbkdf2;172;179;174;169;169;171;167;172;172;173 08:50:55 INFO - PROCESS | 2943 | |13;stanford-crypto-sha256-iterative;68;67;67;66;67;67;68;66;70;66 08:50:55 INFO - PROCESS | 2943 | __end_tp_report 08:50:55 INFO - PROCESS | 2943 | __start_cc_report 08:50:55 INFO - PROCESS | 2943 | _x_x_mozilla_cycle_collect,1009 08:50:55 INFO - PROCESS | 2943 | __end_cc_report 08:50:55 INFO - PROCESS | 2943 | __startTimestamp1467042655638__endTimestamp 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | ------- Summary: start ------- 08:50:55 INFO - PROCESS | 2943 | Number of tests: 14 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:4.60 (4.1%) stddev-sans-first:3.36 08:50:55 INFO - PROCESS | 2943 | Values: 103.0 114.0 108.0 114.0 114.0 121.0 113.0 112.0 113.0 113.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.00 stddev:20.56 (13.0%) stddev-sans-first:21.78 08:50:55 INFO - PROCESS | 2943 | Values: 155.0 130.0 159.0 178.0 132.0 157.0 160.0 133.0 188.0 131.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.18 08:50:55 INFO - PROCESS | 2943 | Values: 166.0 163.0 167.0 169.0 163.0 163.0 164.0 163.0 163.0 164.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:34.14 (45.2%) stddev-sans-first:35.63 08:50:55 INFO - PROCESS | 2943 | Values: 75.0 75.0 76.0 155.0 77.0 77.0 75.0 75.0 159.0 79.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:87.00 stddev:26.26 (30.2%) stddev-sans-first:27.08 08:50:55 INFO - PROCESS | 2943 | Values: 87.0 87.0 148.0 87.0 87.0 95.0 133.0 87.0 89.0 145.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:50:55 INFO - PROCESS | 2943 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 08:50:55 INFO - PROCESS | 2943 | Values: 147.0 148.0 149.0 148.0 147.0 147.0 148.0 148.0 146.0 148.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 08:50:55 INFO - PROCESS | 2943 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 97.0 95.0 97.0 95.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 08:50:55 INFO - PROCESS | 2943 | Values: 65.0 65.0 63.0 66.0 65.0 64.0 65.0 64.0 64.0 63.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:50:55 INFO - PROCESS | 2943 | Values: 65.0 66.0 64.0 66.0 65.0 64.0 65.0 65.0 65.0 65.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.43 (1.7%) stddev-sans-first:1.39 08:50:55 INFO - PROCESS | 2943 | Values: 82.0 81.0 83.0 86.0 84.0 84.0 84.0 84.0 85.0 83.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.00 stddev:4.02 (3.0%) stddev-sans-first:4.24 08:50:55 INFO - PROCESS | 2943 | Values: 135.0 141.0 130.0 136.0 133.0 136.0 135.0 140.0 143.0 133.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:3.29 (1.9%) stddev-sans-first:3.49 08:50:55 INFO - PROCESS | 2943 | Values: 172.0 179.0 174.0 169.0 169.0 171.0 167.0 172.0 172.0 173.0 08:50:55 INFO - PROCESS | 2943 | 08:50:55 INFO - PROCESS | 2943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 08:50:55 INFO - PROCESS | 2943 | Values: 68.0 67.0 67.0 66.0 67.0 67.0 68.0 66.0 70.0 66.0 08:50:55 INFO - PROCESS | 2943 | -------- Summary: end -------- 08:50:55 INFO - PROCESS | 2943 | 08:50:56 INFO - TEST-INFO | 2943: exit 0 08:50:56 INFO - TEST-OK | kraken | took 64363ms 08:50:56 INFO - SUITE-END | took 1180s 08:50:57 INFO - Completed test suite (00:19:40) 08:50:57 INFO - javascript benchmark 08:50:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6530.595251242856, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2677.6652918385203, 2704.1617098699394, 2714.307851497868, 2733.562629979204, 2740.4245108527207, 4926.7536623168835, 4931.53150450707, 5006.699598024121, 5014.42334131575, 5052.393712754465, 4868.878278043042, 4896.510348965102, 4937.827176048839, 4962.801487940487, 4970.378702662168, 4519.322101684749, 4533.659975501851, 4644.2801365788355, 4657.091867085919, 4670.6497012724185, 569.6243276501629, 4483.34991426243, 4597.954020459786, 4605.4933957264675, 4643.442786865564, 4518.254488009475, 4561.7491037992895, 4592.977035114803, 4606.631469482433, 4652.185867473178, 4507.143642707875, 4598.448186217675, 4615.492295847454, 4635.0729854029, 4652.906941861178, 4505.977470112662, 4535.365048893158, 4547.79534920926, 4576.405067341224, 4578.633709303281, 4895.167821470359, 4933.80264789408, 4962.826301079445, 4966.826161084381, 5034.84895453137, 5232.633715639907, 5303.204519322094, 5348.652337598043, 5370.865728356784, 5445.210444485528, 5405.891882162374, 5444.156155795858, 5445.992491389105, 5461.18082287656, 5507.394186639466, 5016.3980322361185, 5028.472010438852, 5051.898962020776, 5058.721770302595, 5107.821226257063, 5363.517283444508, 5440.619156659075, 5474.91787623178, 5531.834044978657, 5580.776768929279, 5286.0, 5289.761960711778, 5294.444083371268, 5302.92045619316, 5340.412554618989, 5345.786168553292, 5381.73091345439, 5387.81142660005, 5389.380221274525, 5428.185772134132, 5107.489251074863, 5242.868928276747, 5259.027079990214, 5313.468653134656, 5342.358916929916, 5131.230315452712, 5229.790808367698, 5231.398389185292, 5241.0, 5275.235090911796, 4593.989322349078, 4596.011857450664, 4605.217113090783, 4607.746573938465, 4650.95349046512, 3928.7839168845417, 3933.567307596162, 3942.15243722601, 3991.201759648082, 4023.3964905264443, 4636.4899861015265, 4642.628589712815, 4653.046125544255, 4675.76621168947, 4721.3390125382475, 5368.677879327252, 5405.5135037846785, 5407.810726624549, 5425.186222066722, 5462.0, 4553.977230113828, 4580.702254353523, 4625.953740462553, 4640.6751527393435, 4658.883527911829, 4832.4684284728655, 4833.685810422311, 4838.661293709407, 4859.927101093486, 4908.092002979461, 4943.876403089952, 4993.950060499421, 5012.7994880205115, 5020.171671674133, 5074.289599456153, 5317.521423071942, 5337.6797392156595, 5342.866428339323, 5361.973190134025, 5363.007843548799, 4973.825916092919, 4985.5762260208285, 5008.073506401327, 5017.498250174954, 5044.697318160922, 5095.949040509548, 5151.665141765773, 5254.422013578427, 5256.658317209369, 5274.261603375454, 5251.684898906078, 5264.15773476242, 5292.629515934002, 5293.497117773805, 5335.226392173191, 5129.743512824419, 5162.561182299396, 5176.301199338041, 5178.0, 5221.582273418041, 5040.647154699136, 5102.158143906214, 5140.3831540215415, 5177.611679124006, 5181.0, 4913.680610760289, 4984.40187177541, 5040.420351659606, 5048.066107769928, 5162.6902385856965, 5207.817726379559, 5210.687358758487, 5228.424873263862, 5233.267342571967, 5278.261043453843, 4896.0, 5042.268871013609, 5077.136886729339, 5080.237964305384, 5081.187010078517], "value": 4863.77540528762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.1713021491782, 587.4125874125874, 593.89013032589, 602.6173379903762, 611.8283487122161, 34257.14357141073, 37187.25625487488, 37373.252534949315, 37620.435693464555, 37720.24559508808, 38760.22479550407, 39075.0, 39107.804460977655, 39149.608503914955, 39238.80380598093, 7709.383249340053, 7855.921440785576, 7869.13439521655, 7880.448368614199, 7880.487768295071, 7760.0, 7798.947142135824, 7831.882521762178, 7852.882206766903, 7871.606419678993, 7838.529688218697, 7846.72536461224, 7891.684332626717, 7892.289693927545, 7908.960455197716, 7816.609169541529, 7882.408819338572, 7890.210978902092, 7893.05283365994, 7919.168487308865, 7887.132415434297, 7924.08872979609, 7952.284294413473, 7965.084015338252, 7966.362690984707, 37048.0, 37398.626013739784, 37483.62516374856, 37568.0, 37614.81192594047, 2900.1879473747385, 3034.6813584573742, 3389.6440873708398, 3407.335569563911, 3680.5031320771623, 28975.710242897723, 29383.70616293831, 29421.55867661987, 29614.111576652736, 30004.099877003726, 3116.1274843043984, 3234.7897386669792, 3241.7082462578246, 3261.624913134996, 3280.6063272407223, 262010.0, 264103.0, 265764.0, 265771.0, 267574.0, 31987.52018719721, 56025.71987140038, 56488.0, 56548.0, 56570.15144772832, 31824.681753182635, 33267.16832079169, 33505.0, 33541.49687754686, 33630.66369336275, 13185.077044606976, 13342.866571334162, 13364.131331463424, 13374.197548147142, 13464.93267533656, 10903.672889813319, 10993.560257589766, 11127.276727012719, 11143.275687080313, 11158.497867595977, 7801.2198780121535, 7863.056433228049, 7896.210378962058, 7940.404469664798, 7941.563214023168, 3109.595752552154, 3110.1136176189675, 3112.1752735525106, 3167.2398624329994, 3183.3474137801695, 842.8609279468819, 845.9746207613781, 862.7627402464373, 877.9385443018928, 883.656811893157, 27079.64601769943, 27628.861855690593, 27655.0, 28305.29236769056, 28457.430851382855, 953.6233187890745, 955.8231727130503, 958.6357184269933, 982.6560703753629, 997.5411310796969, 14614.196219208046, 14739.484118055816, 15087.924560377129, 15147.166905820286, 15201.087934723952, 393098.0, 395436.0, 396323.0, 397205.0, 397747.0, 48350.75824620925, 48460.757696212, 48792.756036219595, 48878.51121488811, 49010.75494622504, 1166.4284500594817, 1170.303669316755, 1204.3015051270243, 1205.8311836342918, 1209.2925638501574, 26087.0, 27580.310492237855, 27686.723132768413, 27776.0, 28098.719012810427, 41347.0, 41736.58263417448, 41959.37060944027, 42084.789576051924, 42304.78847605742, 307919.0, 312156.0, 313212.0, 313983.0, 313993.0, 24909.62635560432, 25161.24516264515, 25488.10791622284, 25606.487870242865, 25772.613410798476, 41885.16229675328, 41955.7902210487, 42054.0, 42247.155056899304, 42302.0, 35319.646803531636, 36017.819910900274, 36986.63013369939, 37560.24879502449, 37684.43473347847, 35920.28159436849, 36316.45525317175, 36739.08152296214, 36809.44785828161, 37352.62647373491, 33443.83278083594, 33744.83127584346, 33942.66057339395, 34196.31607367789, 36204.27591448209, 32102.839485802422, 32840.50739238865, 33205.813314688305, 33529.49705754367, 33853.0, 25180.370490737147, 25758.742412575633, 25806.741932580433, 25820.0, 26077.478450430506], "value": 16445.409680806602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.88222709846406, 374.10028880542296, 376.45978021539077, 387.1869074942619, 388.2119297825415, 15631.0, 16717.331306747732, 17412.216450259737, 17425.825741742578, 17429.82570174301, 15811.130387828665, 15855.286512106954, 16883.746743798823, 16904.154792260368, 16987.06571138587, 5046.621503387251, 5212.8436146915465, 5252.317198764155, 5253.7373131343475, 5259.973700131494, 3734.1411475360546, 5719.914201286984, 6155.599886007418, 6162.5069994400565, 6164.691765411734, 6090.23872015998, 6096.298925623543, 6105.572609917308, 6198.969005154968, 6463.644499552546, 6709.9329006709795, 6784.423324017464, 6849.075374824434, 6884.105066341369, 6904.620245886499, 6804.829879253009, 6952.756653517154, 6982.546134501241, 6991.440684745208, 7004.684789184499, 21467.355979320644, 22642.886785565966, 23218.14254859624, 23425.06299748008, 23912.402189945216, 2093.822025127866, 2187.464071302541, 2671.545837207679, 2739.328864428208, 2755.7244275572484, 13397.12918660284, 14302.141871487744, 14310.570682879426, 14452.205128718022, 14938.62653433662, 1774.520879362565, 1826.2877477783675, 1873.7095750158746, 1889.0743535667561, 1905.2188602672977, 60495.0, 62391.0, 69258.30741692569, 76674.61662691706, 82601.58699206465, 15527.223638818014, 16512.75230871538, 16943.745843812354, 17028.318867245172, 17067.525208844647, 28885.0, 29200.41599168005, 29352.0, 29472.852635736683, 29645.703542964293, 8200.58997050145, 9022.413543119676, 9082.727518174466, 9120.179183873483, 9164.404313719588, 7486.812829679302, 7498.962505187439, 7513.436492263102, 7523.586202758901, 7619.847603047908, 8148.83702325962, 8312.5428101455, 8396.622152003174, 8416.705415310435, 8455.323574114056, 1527.9388824446899, 1593.6175317923614, 1652.6942515634646, 1654.8014238291482, 1664.4008157063447, 812.321711371, 819.8114433680167, 827.8634025385744, 849.7238397520707, 942.0532364973158, 16742.83257167437, 16961.830381696273, 17032.659346812994, 17173.57066073358, 17253.137343133043, 827.9461834980707, 842.2125312832521, 878.578282424427, 879.1647934462286, 895.5611750242465, 9156.313276504156, 9292.767680808034, 9431.386959847589, 9752.512374381253, 9799.559019844124, 375374.0, 383730.0, 385494.0, 385940.0, 389645.0, 72616.63691681613, 75629.24370756332, 76113.0, 88551.0, 89367.0, 917.7659696777413, 927.8051609162152, 941.1623654947102, 978.5498670611456, 983.5229913491951, 15616.375344986074, 15914.204289785695, 15932.920335398248, 16036.198190090216, 16174.595635109217, 26361.604575930993, 27801.721982780724, 36697.0, 37189.81405092957, 37900.2419951605, 49711.25433118579, 53347.4665253358, 54150.72924635352, 54262.18606720823, 54783.45216547943, 7512.812179695333, 7583.810404739926, 7644.732434364993, 7699.6535155917, 7946.205379462008, 11151.275167114112, 11694.122940779645, 11719.648410547697, 11721.941390292994, 11785.941070294593, 9779.0, 9814.852777208205, 9918.900810991798, 9920.603175872884, 10163.54264058134, 10156.187504999434, 10190.643327483502, 10418.0, 10453.216008799218, 10565.471726413802, 9659.565319560495, 9775.85336219943, 9832.311738178545, 10021.39871607706, 10031.0, 7559.508631938907, 7572.280633339824, 7657.693692252247, 7772.922270777446, 7886.763397098096, 8792.252658524098, 9466.668666596635, 9759.316847820584, 9770.755731106496, 10215.387076775418], "value": 9054.538057900189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.7035787305726, 1407.9648008799782, 1484.302377882395, 1656.3954156732796, 1667.9666406671868, 6959.860802783941, 7641.732539361124, 7704.114026886909, 8221.54781487018, 8233.917660823397, 7782.338501227388, 8021.518708877471, 8088.878666820003, 8108.067572229195, 8129.634166462509, 2207.1171531387454, 2221.7778222177812, 2224.9777502225015, 2230.821534277262, 2245.0682966568857, 2181.803637672609, 2191.802737753602, 2236.0, 2249.3139592424304, 2257.7855103765196, 2201.6587428948537, 2203.8787866667326, 2220.455988282873, 2229.1640634761966, 2231.2971414004537, 2136.1882484655885, 2143.282000529832, 2155.4395857077116, 2158.816500597451, 2159.4493404181912, 2114.3551216878845, 2124.6706760452153, 2136.6688163334707, 2141.9892900535397, 2150.537634408594, 8087.393445491612, 8100.108988011314, 8104.270615644561, 8108.878366824502, 8114.6754129834735, 4596.49438561758, 4705.529447055267, 4707.45864225615, 4719.292106184065, 4722.433308003027, 2761.3924936514136, 2861.413410250894, 2862.7852911031755, 2866.4410439964217, 2890.5519644455144, 925.5557332480447, 945.952702364879, 959.6785076999214, 966.8356379415446, 974.1719538392381, 10849.566017359297, 10851.565937362497, 10861.511231994578, 10892.891071089347, 10896.564137434492, 4126.91746165075, 4212.199682060399, 4245.066085461193, 4274.038341373166, 4298.495526565677, 9129.497877616795, 9204.079592040742, 9210.63157473707, 9211.677591284408, 9236.168744813, 4623.86128416148, 4630.189716799547, 4633.166030114612, 4642.955335049654, 4643.2802915548145, 3699.926001479955, 3968.047668559525, 4049.5747946465785, 4173.853915112956, 4327.285997810389, 3618.348697234523, 3658.8719394821055, 3673.7244706647107, 3708.2212735325343, 3758.7744735315423, 1160.6634076117832, 1196.3778835005749, 1204.2353105777895, 1206.6530597987007, 1228.2507670321097, 763.6296396247816, 802.4302745050962, 809.1746418652941, 811.9715809946623, 822.9218224268685, 4738.19450693383, 4942.678725882806, 5004.199328107486, 5015.570562389701, 5034.572061374751, 794.9046114466186, 838.128346519625, 862.4221771413169, 879.1516186879564, 889.586342350797, 3331.9666803332143, 3415.3852306585054, 3423.5378223939947, 3470.219200679827, 3507.964920350764, 9543.141117299338, 10012.24908131893, 10014.0, 10018.649347272956, 10028.949855250678, 9821.901780982098, 9895.208383329316, 9910.752231194134, 9913.256505762096, 9927.40435573868, 7167.247439018932, 7274.527155734966, 7288.12542494904, 7299.343059124704, 7304.452166087564, 4731.739754313546, 4937.925931111108, 4992.900141997067, 5251.0, 5353.919691204713, 8923.41997770143, 8968.955155224183, 9031.638734450811, 9114.316426267924, 9150.816983660423, 8767.386282960386, 9013.143751343612, 9330.720078397659, 9360.906390936003, 9363.297752668714, 6963.9303606963285, 7004.0, 7057.752978645723, 7109.537880037988, 7152.284771522806, 7546.207648196861, 7567.31894129531, 7604.619769011638, 7619.847603047797, 7664.34853037498, 6898.517103802686, 6904.551204171914, 7043.119610048744, 7124.5725256484775, 7160.713571457083, 6684.598924064571, 6718.294579069127, 6880.179126558087, 6902.102726645504, 6942.409895158968, 5955.196048533566, 5986.2517185351835, 5990.041593345044, 5998.25021872266, 6000.249968753906, 4323.675724320626, 4419.602235798665, 4447.599716025573, 4469.687121901566, 4471.731696098244, 4363.005226828312, 4367.825286988485, 4442.244818380818, 4451.643868490448, 4482.529334419839], "value": 4151.8105444977755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.08082323562104, 299.1593621922398, 301.66515168163335, 312.0684756003331, 314.89471953443405, 4927.630427717918, 5052.898942021162, 5071.644984851062, 5205.557527610153, 5239.921401178985, 5059.949400505994, 5085.5423011929015, 5144.562712169461, 5173.327467429238, 5185.662931909433, 4011.7994100295014, 4054.3310353791735, 4054.5945405459515, 4063.390491426295, 4072.574598890387, 3954.604539546051, 4060.3503439449696, 4065.817038233272, 4066.9389959150635, 4074.7351422157467, 3985.2228815381013, 4031.717779755418, 4035.9910022494378, 4037.4347591337237, 4042.3128068228325, 3954.4266081418323, 4013.8795836124964, 4014.1971605678837, 4024.959750402517, 4042.8382864685377, 3572.142685755426, 3572.6070132285427, 3587.0, 3598.6941110005682, 3602.4596310553366, 4861.343718597979, 5019.824306149304, 5022.347094877679, 5037.5214354636255, 5134.897302053975, 4576.8626941191815, 4592.47186573545, 4601.976990115028, 4623.815047398134, 4629.930551041737, 5380.3274590676165, 5397.973010134963, 5400.513953744182, 5405.459454054563, 5415.918761218545, 3778.4521244419407, 3872.051347419872, 3886.7667939923695, 3888.997166459276, 3892.961070389288, 5624.971875140598, 5671.120976248647, 5672.602917795756, 5673.602847800656, 5690.687012214326, 3970.1067259866877, 3997.420374045747, 4002.3796311571755, 4016.979915100406, 4028.5568587455355, 3880.553736320303, 4019.8392064317686, 4065.0, 4076.144009757925, 4079.8164082616354, 4504.684672072924, 4557.5898169164275, 4569.657275704336, 4603.769811509411, 4612.192866248461, 5334.59990500714, 5344.327836081959, 5346.866328341823, 5364.597655175878, 5412.296401467784, 1336.5522549945877, 1359.6193065941552, 1393.9512117075853, 1396.4833011785704, 1397.4200706706806, 885.9202671759443, 890.4879694175745, 899.7930475990559, 903.9683611073581, 909.2998391238709, 4203.768792716369, 4211.1998720243055, 4250.937265683579, 4258.61672449481, 4282.379055037002, 4832.975835120872, 4847.127517046965, 4858.445297504764, 4886.8724016629385, 4889.559939605452, 4187.874363769091, 4196.622303992655, 4235.073041766051, 4240.957590424118, 4258.829646814154, 2398.70016247969, 2610.538098664716, 2622.662442154515, 2633.604959256127, 2656.309359566527, 4571.794269257824, 4590.242609969385, 4592.517785632527, 4629.8148074077335, 4639.675222734444, 4919.90160196794, 4938.8022330063495, 4974.303597496353, 4983.626228032912, 5060.974695126574, 4847.781849816767, 5234.502722241381, 5241.423443421144, 5248.685078895202, 5251.947480525146, 5554.638948468337, 5556.944180605672, 5591.720413979204, 5602.551795856403, 5638.182463542681, 5284.044903385618, 5490.203920431595, 5501.752421140978, 5526.91709624364, 5547.916781248366, 5100.311457953128, 5173.793048278027, 5182.740862956913, 5219.791208351623, 5252.238425428215, 3871.399933010388, 3888.3195440798313, 3893.3381325175355, 3896.883093507199, 3936.980315098406, 5274.050670879278, 5553.666779993213, 5574.665520068809, 5580.916286255629, 5590.105583106683, 5359.571234301168, 5372.355317361941, 5389.622726409114, 5392.622516423813, 5398.676079435247, 5385.919211211756, 5388.407275199804, 5423.511883930465, 5426.755795989111, 5437.640589852537, 5123.923141152811, 5319.643490909793, 5322.627416080837, 5323.893522129613, 5359.812406565908, 5424.674519528841, 5432.429594892637, 5434.728263586884, 5439.48324909133, 5468.3711373191, 5144.922826157535, 5282.81510147143, 5291.470852914677, 5296.788128474972, 5330.534103121672], "value": 3983.0310729323837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9165508483896, 647.6729251727877, 650.7884937395347, 658.3679667519184, 681.3254877671105, 10936.234463587552, 11358.716032099202, 11373.658790236295, 11373.829392559108, 12532.937335313334, 14268.4292628295, 14900.478483253088, 14953.252337383141, 14953.327100280487, 14969.775453368207, 606.2664176346626, 766.6473422225782, 783.694359199914, 794.7337641889974, 802.3500964219002, 798.5049269452918, 798.5967086621248, 799.3205775091184, 801.1627848897915, 805.6414895371562, 841.9326453883674, 842.9873551896726, 846.0608724316004, 846.124261389462, 846.9280111190557, 831.8627426474685, 835.173178553231, 836.2599099796663, 838.0781140745131, 840.697348954379, 609.3236507476697, 610.0391882784631, 611.2817439508559, 615.1449485215554, 615.3876892491999, 12221.0, 12239.93880030603, 12241.20432171906, 12280.815787763191, 12283.324417157053, 12678.112532122756, 12847.486100555967, 12893.419796109103, 13541.0, 13570.198857256937, 10222.0, 10241.948790256076, 10244.28290019699, 10289.639862604772, 10399.636012739518, 3441.5698037745283, 3465.6187819339852, 3482.9303413931834, 3490.947635785465, 3546.4857595648746, 51231.0, 53070.14254501113, 53082.0, 59374.70312648452, 60122.69938650279, 10184.236182286359, 10288.897111028793, 10549.578016879392, 10939.617113400993, 11200.271982321286, 19893.10481028357, 20168.193272268945, 20195.899020504803, 20197.0, 20202.595948080954, 7215.422766178693, 7263.673134708951, 7368.8894666580045, 7376.336129748348, 7431.29402706742, 3679.2457546202963, 3682.5396825396824, 3743.082944678517, 3746.550413950343, 3754.0614846288427, 2974.6876577959, 3010.909672709822, 3039.9088027359217, 3051.2676957530475, 3082.1678146900213, 511.69809812210974, 518.2123172777357, 519.794681100963, 554.1715135871817, 554.1798138754585, 508.788852626156, 535.5287347134574, 538.4588488569042, 542.9619926605179, 556.349071586245, 7685.42359323053, 8225.79435514105, 8315.667373305121, 8373.204545568162, 8743.0, 426.6075210806066, 452.5180682573049, 497.572088004316, 517.0770175237184, 531.646455107357, 3831.7892515911335, 3932.7640341579595, 3959.821808018646, 4079.9592004079577, 4127.525334586501, 60094.39905600975, 60347.09479357726, 74200.0, 108279.45860270805, 108987.0, 91406.54296728474, 94155.52922235345, 94313.0, 94671.0, 94905.0, 49120.0, 72953.06945840243, 73866.6306668474, 74153.0, 75881.0, 7751.302382785577, 7990.400719946144, 8238.258556729923, 8535.786605334668, 8747.737567872973, 31910.680893190773, 42431.575684242765, 43388.0, 43649.56350436455, 43692.56307436885, 61004.389956101644, 63495.6825215871, 63916.0, 64028.0, 64526.0, 10270.07569318765, 10445.0, 10491.003354681294, 10677.89322106769, 10746.946265268623, 12051.156419050581, 12156.696082597651, 12178.330191839534, 12260.570880019157, 12291.201071930296, 10986.176036797431, 11031.338119712522, 11058.778824423627, 11976.640700778991, 11983.580574679845, 10948.726281843017, 11071.944640276746, 11289.322640641587, 11546.076313895037, 11607.941960290482, 11360.715982100513, 11369.4883730234, 11418.771624567296, 11630.767384652429, 11787.882121178678, 9453.480058596842, 9662.806743864943, 9689.0, 9711.805763884824, 9842.311038227255, 9813.0, 10110.646127385506, 10146.644867429604, 10167.7458063549, 10252.794944101226], "value": 6476.427978757505, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 108.0, 114.0, 114.0, 121.0, 113.0, 112.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 159.0, 178.0, 132.0, 157.0, 160.0, 133.0, 188.0, 131.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 167.0, 169.0, 163.0, 163.0, 164.0, 163.0, 163.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 155.0, 77.0, 77.0, 75.0, 75.0, 159.0, 79.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 148.0, 87.0, 87.0, 95.0, 133.0, 87.0, 89.0, 145.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 130.0, 136.0, 133.0, 136.0, 135.0, 140.0, 143.0, 133.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 174.0, 169.0, 169.0, 171.0, 167.0, 172.0, 172.0, 173.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 66.0, 70.0, 66.0], "value": 67.2, "unit": "score"}]}]} 08:50:57 INFO - Return code: 0 08:50:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:57 ERROR - # TBPL SUCCESS # 08:50:57 INFO - Running post-action listener: _resource_record_post_action 08:50:57 INFO - ##### 08:50:57 INFO - ##### Finished run-tests step (success) 08:50:57 INFO - ##### 08:50:57 INFO - Running post-run listener: _resource_record_post_run 08:50:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554442752; Read time: 20; Write time: 472324 08:50:57 INFO - TinderboxPrint: CPU usage
13.5% 08:50:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 08:50:57 INFO - TinderboxPrint: I/O write bytes / time
554,442,752 / 472,324 08:50:57 INFO - TinderboxPrint: CPU idle
8,265.5 (86.5%) 08:50:57 INFO - TinderboxPrint: CPU user
1,233.3 (12.9%) 08:50:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253751296; Read time: 0; Write time: 262340 08:50:57 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300105728; Read time: 20; Write time: 209972 08:50:58 INFO - Running post-run listener: _upload_blobber_files 08:50:58 INFO - Blob upload gear active. 08:50:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:50:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:50:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:59 INFO - (blobuploader) - INFO - Done attempting. 08:50:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:03 INFO - (blobuploader) - INFO - Done attempting. 08:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:03 INFO - (blobuploader) - INFO - Done attempting. 08:51:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:03 INFO - Return code: 0 08:51:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:51:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63fae83290fcd4336b12a7e93b545ab4d8afc8660a2a5fc475f07b359124834594f9d80819629bdea350678f8473572b7fb175ff7782edf4dfd357f18f17de5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990ea57b3375facc418a5fb894d7c06605f7d0f92b644d735770a34968ae173c244878fc4dc74e446773270efe75fea71660fd3ddbe5070aab92361c56561e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0acc1adf9859680705a61ff2d3756e72d10700699b7994276699165b5c374b226df4c1248018f85aea704f439cece901dd4ba5b3208031f915daf48b22895803"} 08:51:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:51:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:51:03 INFO - Contents: 08:51:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63fae83290fcd4336b12a7e93b545ab4d8afc8660a2a5fc475f07b359124834594f9d80819629bdea350678f8473572b7fb175ff7782edf4dfd357f18f17de5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990ea57b3375facc418a5fb894d7c06605f7d0f92b644d735770a34968ae173c244878fc4dc74e446773270efe75fea71660fd3ddbe5070aab92361c56561e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0acc1adf9859680705a61ff2d3756e72d10700699b7994276699165b5c374b226df4c1248018f85aea704f439cece901dd4ba5b3208031f915daf48b22895803"} 08:51:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:03 INFO - Copying logs to upload dir... 08:51:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:51:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.070925 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 08:51:03.738434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:51:03.742516) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63fae83290fcd4336b12a7e93b545ab4d8afc8660a2a5fc475f07b359124834594f9d80819629bdea350678f8473572b7fb175ff7782edf4dfd357f18f17de5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990ea57b3375facc418a5fb894d7c06605f7d0f92b644d735770a34968ae173c244878fc4dc74e446773270efe75fea71660fd3ddbe5070aab92361c56561e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0acc1adf9859680705a61ff2d3756e72d10700699b7994276699165b5c374b226df4c1248018f85aea704f439cece901dd4ba5b3208031f915daf48b22895803"} build_url:https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/cpI8oRJJSpm19Es6p39wyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63fae83290fcd4336b12a7e93b545ab4d8afc8660a2a5fc475f07b359124834594f9d80819629bdea350678f8473572b7fb175ff7782edf4dfd357f18f17de5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/990ea57b3375facc418a5fb894d7c06605f7d0f92b644d735770a34968ae173c244878fc4dc74e446773270efe75fea71660fd3ddbe5070aab92361c56561e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0acc1adf9859680705a61ff2d3756e72d10700699b7994276699165b5c374b226df4c1248018f85aea704f439cece901dd4ba5b3208031f915daf48b22895803"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:51:03.769676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:51:03.770039) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467041422.384879-1579905787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:51:03.851944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:51:03.852318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:51:03.852694) ========= ========= Total master_lag: 0.18 =========