builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1465041437.93 results: success (0) buildid: 20160604023008 builduid: b00c519d82954b4fa1ae72a7bd5a5204 revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:17.928587) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:17.929167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:17.929672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.011880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.012154) ========= 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=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 04:57:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-06-04 04:57:18 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.109821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.110151) ========= 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=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016006 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.159432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.159810) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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 e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 04:57:18,330 truncating revision to first 12 chars 2016-06-04 04:57:18,330 Setting DEBUG logging. 2016-06-04 04:57:18,331 attempt 1/10 2016-06-04 04:57:18,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1fb7ee96e4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 04:57:18,653 unpacking tar archive at: fx-team-e1fb7ee96e4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.834881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.835190) ========= script_repo_revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.835598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.835875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:57:18.848382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 04:57:18.848762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:19 INFO - MultiFileLogger online at 20160604 04:57:19 in /builds/slave/test 04:57:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:57:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:19 INFO - {'append_to_log': False, 04:57:19 INFO - 'base_work_dir': '/builds/slave/test', 04:57:19 INFO - 'blob_upload_branch': 'Fx-Team', 04:57:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:19 INFO - 'branch': 'Fx-Team', 04:57:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:19 INFO - 'config_files': ('talos/linux_config.py',), 04:57:19 INFO - 'default_actions': ('clobber', 04:57:19 INFO - 'read-buildbot-config', 04:57:19 INFO - 'download-and-extract', 04:57:19 INFO - 'populate-webroot', 04:57:19 INFO - 'create-virtualenv', 04:57:19 INFO - 'install', 04:57:19 INFO - 'run-tests'), 04:57:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:19 INFO - 'download_minidump_stackwalk': True, 04:57:19 INFO - 'download_symbols': 'ondemand', 04:57:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:19 INFO - 'installer_path': 'installer.exe', 04:57:19 INFO - 'log_level': 'info', 04:57:19 INFO - 'log_name': 'talos', 04:57:19 INFO - 'log_to_console': True, 04:57:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:19 INFO - 'opt_config_files': (), 04:57:19 INFO - 'pip_index': False, 04:57:19 INFO - 'sps_profile': False, 04:57:19 INFO - 'sps_profile_interval': 0, 04:57:19 INFO - 'suite': 'dromaeojs-e10s', 04:57:19 INFO - 'system_bits': '32', 04:57:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:19 INFO - 'title': 'talos-linux64-ix-025', 04:57:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:19 INFO - 'use_talos_json': True, 04:57:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:19 INFO - 'work_dir': 'build'} 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running clobber step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: clobber 04:57:19 INFO - rmtree: /builds/slave/test/build 04:57:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:19 INFO - Running post-action listener: _resource_record_post_action 04:57:19 INFO - ##### 04:57:19 INFO - ##### Finished clobber step (success) 04:57:19 INFO - ##### 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running read-buildbot-config step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: read_buildbot_config 04:57:19 INFO - Using buildbot properties: 04:57:19 INFO - { 04:57:19 INFO - "project": "", 04:57:19 INFO - "product": "firefox", 04:57:19 INFO - "script_repo_revision": "production", 04:57:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:57:19 INFO - "repository": "", 04:57:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:57:19 INFO - "buildid": "20160604023008", 04:57:19 INFO - "pgo_build": "True", 04:57:19 INFO - "basedir": "/builds/slave/test", 04:57:19 INFO - "buildnumber": 419, 04:57:19 INFO - "slavename": "talos-linux64-ix-025", 04:57:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:57:19 INFO - "platform": "ubuntu64_hw", 04:57:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:57:19 INFO - "branch": "fx-team", 04:57:19 INFO - "repo_path": "integration/fx-team", 04:57:19 INFO - "revision": "e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe", 04:57:19 INFO - "stage_platform": "linux64-pgo", 04:57:19 INFO - "builduid": "b00c519d82954b4fa1ae72a7bd5a5204", 04:57:19 INFO - "slavebuilddir": "test" 04:57:19 INFO - } 04:57:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:57:19 INFO - Running post-action listener: _resource_record_post_action 04:57:19 INFO - ##### 04:57:19 INFO - ##### Finished read-buildbot-config step (success) 04:57:19 INFO - ##### 04:57:19 INFO - ##### 04:57:19 INFO - ##### Running download-and-extract step. 04:57:19 INFO - ##### 04:57:19 INFO - Running pre-action listener: _resource_record_pre_action 04:57:19 INFO - Running main action method: download_and_extract 04:57:19 INFO - mkdir: /builds/slave/test/build/tests 04:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:19 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:57:22 INFO - Downloaded 1361 bytes. 04:57:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:57:22 INFO - Using the following test package requirements: 04:57:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:57:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'jsshell-linux-x86_64.zip'], 04:57:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:22 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:57:24 INFO - Downloaded 24440840 bytes. 04:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:57:25 INFO - Return code: 0 04:57:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:25 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:57:26 INFO - Downloaded 24440840 bytes. 04:57:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:57:28 INFO - Return code: 0 04:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:28 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:57:29 INFO - Downloaded 10833369 bytes. 04:57:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:57:30 INFO - Return code: 0 04:57: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')]} 04:57:30 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:57:34 INFO - Downloaded 59083666 bytes. 04:57:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:34 INFO - mkdir: /builds/slave/test/properties 04:57:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:34 INFO - Contents: 04:57:34 INFO - build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:57:34 INFO - Running post-action listener: _resource_record_post_action 04:57:34 INFO - Running post-action listener: set_extra_try_arguments 04:57:34 INFO - ##### 04:57:34 INFO - ##### Finished download-and-extract step (success) 04:57:34 INFO - ##### 04:57:34 INFO - ##### 04:57:34 INFO - ##### Running populate-webroot step. 04:57:34 INFO - ##### 04:57:34 INFO - Running pre-action listener: _resource_record_pre_action 04:57:34 INFO - Running main action method: populate_webroot 04:57:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:34 INFO - '--tppagecycles', 04:57:34 INFO - '7'], 04:57:34 INFO - 'tests': ['tsvgm']}}, 04:57:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['damp', 'tps']}, 04:57:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'tests': ['damp', 'tps']}, 04:57:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['dromaeo_dom']}, 04:57:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['a11yr', 04:57:34 INFO - 'ts_paint', 04:57:34 INFO - 'tpaint', 04:57:34 INFO - 'sessionrestore', 04:57:34 INFO - 'sessionrestore_no_auto_restore', 04:57:34 INFO - 'tabpaint']}, 04:57:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['tsvgx', 04:57:34 INFO - 'tsvgr_opacity', 04:57:34 INFO - 'tart', 04:57:34 INFO - 'tscrollx', 04:57:34 INFO - 'cart']}, 04:57:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:34 INFO - 'tsvgr_opacity', 04:57:34 INFO - 'tart', 04:57:34 INFO - 'tscrollx', 04:57:34 INFO - 'cart']}, 04:57:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'talos_options': ['--disable-e10s'], 04:57:34 INFO - 'tests': ['tp5o']}, 04:57:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'tests': ['tp5o']}, 04:57:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'talos_options': ['--disable-e10s', 04:57:34 INFO - '--xperf_path', 04:57:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:34 INFO - 'tests': ['tp5n']}, 04:57:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:34 INFO - 'talos_options': ['--xperf_path', 04:57:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:34 INFO - 'tests': ['tp5n']}}, 04:57:34 INFO - 'talos.zip': {'path': '', 04:57:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:34 INFO - Running post-action listener: _resource_record_post_action 04:57:34 INFO - ##### 04:57:34 INFO - ##### Finished populate-webroot step (success) 04:57:34 INFO - ##### 04:57:34 INFO - ##### 04:57:34 INFO - ##### Running create-virtualenv step. 04:57:34 INFO - ##### 04:57:34 INFO - Running pre-action listener: _resource_record_pre_action 04:57:34 INFO - Running main action method: create_virtualenv 04:57:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57: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 04:57:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:34 INFO - Using real prefix '/usr' 04:57:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:37 INFO - Installing pip.................done. 04:57:37 INFO - Return code: 0 04:57:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57: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', 'pip>=1.5'] in /builds/slave/test/build 04:57: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 pip>=1.5 04:57:37 INFO - Using env: {'DISPLAY': ':0', 04:57:37 INFO - 'HOME': '/home/cltbld', 04:57:37 INFO - 'LANG': 'en_US.UTF-8', 04:57:37 INFO - 'LANGUAGE': 'en_US:en', 04:57:37 INFO - 'LOGNAME': 'cltbld', 04:57:37 INFO - 'MAIL': '/var/mail/cltbld', 04:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:37 INFO - 'MOZ_NO_REMOTE': '1', 04:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:37 INFO - 'NO_EM_RESTART': '1', 04:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:37 INFO - 'PWD': '/builds/slave/test', 04:57:37 INFO - 'SHELL': '/bin/bash', 04:57:37 INFO - 'SHLVL': '1', 04:57:37 INFO - 'TERM': 'linux', 04:57:37 INFO - 'TMOUT': '86400', 04:57:37 INFO - 'USER': 'cltbld', 04:57:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:37 INFO - '_': '/tools/buildbot/bin/python'} 04:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57: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 04:57:37 INFO - Cleaning up... 04:57:37 INFO - Return code: 0 04:57:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57: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 04:57: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 04:57:37 INFO - Using env: {'DISPLAY': ':0', 04:57:37 INFO - 'HOME': '/home/cltbld', 04:57:37 INFO - 'LANG': 'en_US.UTF-8', 04:57:37 INFO - 'LANGUAGE': 'en_US:en', 04:57:37 INFO - 'LOGNAME': 'cltbld', 04:57:37 INFO - 'MAIL': '/var/mail/cltbld', 04:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:37 INFO - 'MOZ_NO_REMOTE': '1', 04:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:37 INFO - 'NO_EM_RESTART': '1', 04:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:37 INFO - 'PWD': '/builds/slave/test', 04:57:37 INFO - 'SHELL': '/bin/bash', 04:57:37 INFO - 'SHLVL': '1', 04:57:37 INFO - 'TERM': 'linux', 04:57:37 INFO - 'TMOUT': '86400', 04:57:37 INFO - 'USER': 'cltbld', 04:57:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:37 INFO - '_': '/tools/buildbot/bin/python'} 04:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:37 INFO - Downloading/unpacking psutil>=3.1.1 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:40 INFO - Installing collected packages: psutil 04:57:40 INFO - Running setup.py install for psutil 04:57:40 INFO - building 'psutil._psutil_linux' extension 04:57:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:57:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:57:40 INFO - building 'psutil._psutil_posix' extension 04:57:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:57:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:57:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:40 INFO - Successfully installed psutil 04:57:40 INFO - Cleaning up... 04:57:40 INFO - Return code: 0 04:57:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:57:40 INFO - Using env: {'DISPLAY': ':0', 04:57:40 INFO - 'HOME': '/home/cltbld', 04:57:40 INFO - 'LANG': 'en_US.UTF-8', 04:57:40 INFO - 'LANGUAGE': 'en_US:en', 04:57:40 INFO - 'LOGNAME': 'cltbld', 04:57:40 INFO - 'MAIL': '/var/mail/cltbld', 04:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:40 INFO - 'MOZ_NO_REMOTE': '1', 04:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:40 INFO - 'NO_EM_RESTART': '1', 04:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:40 INFO - 'PWD': '/builds/slave/test', 04:57:40 INFO - 'SHELL': '/bin/bash', 04:57:40 INFO - 'SHLVL': '1', 04:57:40 INFO - 'TERM': 'linux', 04:57:40 INFO - 'TMOUT': '86400', 04:57:40 INFO - 'USER': 'cltbld', 04:57:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:40 INFO - '_': '/tools/buildbot/bin/python'} 04:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:43 INFO - Installing collected packages: mozsystemmonitor 04:57:43 INFO - Running setup.py install for mozsystemmonitor 04:57:43 INFO - Successfully installed mozsystemmonitor 04:57:43 INFO - Cleaning up... 04:57:43 INFO - Return code: 0 04:57:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:57:43 INFO - Using env: {'DISPLAY': ':0', 04:57:43 INFO - 'HOME': '/home/cltbld', 04:57:43 INFO - 'LANG': 'en_US.UTF-8', 04:57:43 INFO - 'LANGUAGE': 'en_US:en', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MAIL': '/var/mail/cltbld', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SHLVL': '1', 04:57:43 INFO - 'TERM': 'linux', 04:57:43 INFO - 'TMOUT': '86400', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - '_': '/tools/buildbot/bin/python'} 04:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:45 INFO - warning: no files found matching '*.txt' 04:57:45 INFO - no previously-included directories found matching 'build' 04:57:45 INFO - no previously-included directories found matching 'dist' 04:57:45 INFO - no previously-included directories found matching '.git*' 04:57:45 INFO - Installing collected packages: jsonschema, functools32 04:57:45 INFO - Running setup.py install for functools32 04:57:45 INFO - warning: no files found matching '*.txt' 04:57:45 INFO - no previously-included directories found matching 'build' 04:57:45 INFO - no previously-included directories found matching 'dist' 04:57:45 INFO - no previously-included directories found matching '.git*' 04:57:45 INFO - Successfully installed jsonschema functools32 04:57:45 INFO - Cleaning up... 04:57:45 INFO - Return code: 0 04:57:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:45 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:45 INFO - Using env: {'DISPLAY': ':0', 04:57:45 INFO - 'HOME': '/home/cltbld', 04:57:45 INFO - 'LANG': 'en_US.UTF-8', 04:57:45 INFO - 'LANGUAGE': 'en_US:en', 04:57:45 INFO - 'LOGNAME': 'cltbld', 04:57:45 INFO - 'MAIL': '/var/mail/cltbld', 04:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:45 INFO - 'MOZ_NO_REMOTE': '1', 04:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:45 INFO - 'NO_EM_RESTART': '1', 04:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:45 INFO - 'PWD': '/builds/slave/test', 04:57:45 INFO - 'SHELL': '/bin/bash', 04:57:45 INFO - 'SHLVL': '1', 04:57:45 INFO - 'TERM': 'linux', 04:57:45 INFO - 'TMOUT': '86400', 04:57:45 INFO - 'USER': 'cltbld', 04:57:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:45 INFO - '_': '/tools/buildbot/bin/python'} 04:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:48 INFO - Downloading docopt-0.6.1.tar.gz 04:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:48 INFO - Running setup.py install for blobuploader 04:57:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:48 INFO - Running setup.py install for requests 04:57:49 INFO - Running setup.py install for docopt 04:57:49 INFO - Successfully installed blobuploader requests docopt 04:57:49 INFO - Cleaning up... 04:57:49 INFO - Return code: 0 04:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:49 INFO - Using env: {'DISPLAY': ':0', 04:57:49 INFO - 'HOME': '/home/cltbld', 04:57:49 INFO - 'LANG': 'en_US.UTF-8', 04:57:49 INFO - 'LANGUAGE': 'en_US:en', 04:57:49 INFO - 'LOGNAME': 'cltbld', 04:57:49 INFO - 'MAIL': '/var/mail/cltbld', 04:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:49 INFO - 'MOZ_NO_REMOTE': '1', 04:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:49 INFO - 'NO_EM_RESTART': '1', 04:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:49 INFO - 'PWD': '/builds/slave/test', 04:57:49 INFO - 'SHELL': '/bin/bash', 04:57:49 INFO - 'SHLVL': '1', 04:57:49 INFO - 'TERM': 'linux', 04:57:49 INFO - 'TMOUT': '86400', 04:57:49 INFO - 'USER': 'cltbld', 04:57:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:49 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:49 INFO - Running setup.py (path:/tmp/pip-QH5_B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:49 INFO - Running setup.py (path:/tmp/pip-2Rfs1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:49 INFO - Running setup.py (path:/tmp/pip-V972VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:49 INFO - Running setup.py (path:/tmp/pip-YrUWgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:49 INFO - Running setup.py (path:/tmp/pip-HlDXHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:49 INFO - Running setup.py (path:/tmp/pip-HtWnkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:49 INFO - Running setup.py (path:/tmp/pip-cdv_Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:49 INFO - Running setup.py (path:/tmp/pip-gNMXdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:50 INFO - Running setup.py (path:/tmp/pip-l6yYs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:50 INFO - Running setup.py (path:/tmp/pip-33MvsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:50 INFO - Running setup.py (path:/tmp/pip-8cLMQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:50 INFO - Running setup.py (path:/tmp/pip-JUy1lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:50 INFO - Running setup.py (path:/tmp/pip-tsoGys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:50 INFO - Running setup.py (path:/tmp/pip-HzgXr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:50 INFO - Running setup.py (path:/tmp/pip-f0xAal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:50 INFO - Running setup.py (path:/tmp/pip-31tM35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:50 INFO - Running setup.py (path:/tmp/pip-o16GrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:50 INFO - Running setup.py install for manifestparser 04:57:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:50 INFO - Running setup.py install for mozcrash 04:57:50 INFO - Running setup.py install for mozdebug 04:57:50 INFO - Running setup.py install for mozdevice 04:57:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for mozfile 04:57:51 INFO - Running setup.py install for mozhttpd 04:57:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for mozinfo 04:57:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for mozInstall 04:57:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for mozleak 04:57:51 INFO - Running setup.py install for mozlog 04:57:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for moznetwork 04:57:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:51 INFO - Running setup.py install for mozprocess 04:57:51 INFO - Running setup.py install for mozprofile 04:57:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:52 INFO - Running setup.py install for mozrunner 04:57:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:52 INFO - Running setup.py install for mozscreenshot 04:57:52 INFO - Running setup.py install for moztest 04:57:52 INFO - Running setup.py install for mozversion 04:57:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:52 INFO - Cleaning up... 04:57:52 INFO - Return code: 0 04:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:52 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:52 INFO - Using env: {'DISPLAY': ':0', 04:57:52 INFO - 'HOME': '/home/cltbld', 04:57:52 INFO - 'LANG': 'en_US.UTF-8', 04:57:52 INFO - 'LANGUAGE': 'en_US:en', 04:57:52 INFO - 'LOGNAME': 'cltbld', 04:57:52 INFO - 'MAIL': '/var/mail/cltbld', 04:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:52 INFO - 'MOZ_NO_REMOTE': '1', 04:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:52 INFO - 'NO_EM_RESTART': '1', 04:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:52 INFO - 'PWD': '/builds/slave/test', 04:57:52 INFO - 'SHELL': '/bin/bash', 04:57:52 INFO - 'SHLVL': '1', 04:57:52 INFO - 'TERM': 'linux', 04:57:52 INFO - 'TMOUT': '86400', 04:57:52 INFO - 'USER': 'cltbld', 04:57:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:52 INFO - '_': '/tools/buildbot/bin/python'} 04:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:52 INFO - Running setup.py (path:/tmp/pip-XnL_3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:52 INFO - Running setup.py (path:/tmp/pip-LLjAva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:52 INFO - Running setup.py (path:/tmp/pip-v4been-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:52 INFO - Running setup.py (path:/tmp/pip-sG7Rq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:52 INFO - Running setup.py (path:/tmp/pip-mHK7HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:53 INFO - Running setup.py (path:/tmp/pip-gx6J8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:53 INFO - Running setup.py (path:/tmp/pip-ZVfgsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:53 INFO - Running setup.py (path:/tmp/pip-vXf7wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:53 INFO - Running setup.py (path:/tmp/pip-3Gw13q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:53 INFO - Running setup.py (path:/tmp/pip-yErZ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:53 INFO - Running setup.py (path:/tmp/pip-NEzKaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:53 INFO - Running setup.py (path:/tmp/pip-YBxZp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:53 INFO - Running setup.py (path:/tmp/pip-0FKEVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:53 INFO - Running setup.py (path:/tmp/pip-YsbuJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:53 INFO - Running setup.py (path:/tmp/pip-ceqrji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:53 INFO - Running setup.py (path:/tmp/pip-1SmW75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:53 INFO - Running setup.py (path:/tmp/pip-svFjal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:55 INFO - Downloading blessings-1.6.tar.gz 04:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:55 INFO - Installing collected packages: blessings 04:57:55 INFO - Running setup.py install for blessings 04:57:55 INFO - Successfully installed blessings 04:57:55 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:56 INFO - Reading from file tmpfile_stdout 04:57:56 INFO - Current package versions: 04:57:56 INFO - argparse == 1.2.1 04:57:56 INFO - blessings == 1.6 04:57:56 INFO - blobuploader == 1.2.4 04:57:56 INFO - docopt == 0.6.1 04:57:56 INFO - functools32 == 3.2.3-2 04:57:56 INFO - jsonschema == 2.5.1 04:57:56 INFO - manifestparser == 1.1 04:57:56 INFO - mozInstall == 1.12 04:57:56 INFO - mozcrash == 0.17 04:57:56 INFO - mozdebug == 0.1 04:57:56 INFO - mozdevice == 0.48 04:57:56 INFO - mozfile == 1.2 04:57:56 INFO - mozhttpd == 0.7 04:57:56 INFO - mozinfo == 0.9 04:57:56 INFO - mozleak == 0.1 04:57:56 INFO - mozlog == 3.2 04:57:56 INFO - moznetwork == 0.27 04:57:56 INFO - mozprocess == 0.22 04:57:56 INFO - mozprofile == 0.28 04:57:56 INFO - mozrunner == 6.11 04:57:56 INFO - mozscreenshot == 0.1 04:57:56 INFO - mozsystemmonitor == 0.3 04:57:56 INFO - moztest == 0.7 04:57:56 INFO - mozversion == 1.4 04:57:56 INFO - psutil == 3.1.1 04:57:56 INFO - requests == 1.2.3 04:57:56 INFO - wsgiref == 0.1.2 04:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:56 INFO - Using env: {'DISPLAY': ':0', 04:57:56 INFO - 'HOME': '/home/cltbld', 04:57:56 INFO - 'LANG': 'en_US.UTF-8', 04:57:56 INFO - 'LANGUAGE': 'en_US:en', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MAIL': '/var/mail/cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SHLVL': '1', 04:57:56 INFO - 'TERM': 'linux', 04:57:56 INFO - 'TMOUT': '86400', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - '_': '/tools/buildbot/bin/python'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:57:56 INFO - Using env: {'DISPLAY': ':0', 04:57:56 INFO - 'HOME': '/home/cltbld', 04:57:56 INFO - 'LANG': 'en_US.UTF-8', 04:57:56 INFO - 'LANGUAGE': 'en_US:en', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MAIL': '/var/mail/cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SHLVL': '1', 04:57:56 INFO - 'TERM': 'linux', 04:57:56 INFO - 'TMOUT': '86400', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - '_': '/tools/buildbot/bin/python'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x7ffade042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd89350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, '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': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:57:56 INFO - Using env: {'DISPLAY': ':0', 04:57:56 INFO - 'HOME': '/home/cltbld', 04:57:56 INFO - 'LANG': 'en_US.UTF-8', 04:57:56 INFO - 'LANGUAGE': 'en_US:en', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MAIL': '/var/mail/cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SHLVL': '1', 04:57:56 INFO - 'TERM': 'linux', 04:57:56 INFO - 'TMOUT': '86400', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - '_': '/tools/buildbot/bin/python'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Downloading/unpacking flake8 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:59 INFO - no previously-included directories found matching 'docs/_build' 04:57:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:59 INFO - Running setup.py install for pep8 04:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:59 INFO - no previously-included directories found matching 'docs/_build' 04:57:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:59 INFO - Cleaning up... 04:57:59 INFO - Return code: 0 04:57:59 INFO - Running post-action listener: _resource_record_post_action 04:57:59 INFO - Running post-action listener: _start_resource_monitoring 04:57:59 INFO - Starting resource monitoring. 04:57:59 INFO - ##### 04:57:59 INFO - ##### Finished create-virtualenv step (success) 04:57:59 INFO - ##### 04:57:59 INFO - ##### 04:57:59 INFO - ##### Running install step. 04:57:59 INFO - ##### 04:57:59 INFO - Running pre-action listener: _resource_record_pre_action 04:57:59 INFO - Running main action method: install 04:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:00 INFO - Reading from file tmpfile_stdout 04:58:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:00 INFO - Reading from file tmpfile_stdout 04:58:00 INFO - Output received: 04:58:00 INFO - Usage: mozinstall [options] installer 04:58:00 INFO - Options: 04:58:00 INFO - -h, --help show this help message and exit 04:58:00 INFO - -d DEST, --destination=DEST 04:58:00 INFO - Directory to install application into. [default: 04:58:00 INFO - "/builds/slave/test"] 04:58:00 INFO - --app=APP Application being installed. [default: firefox] 04:58:00 INFO - mkdir: /builds/slave/test/build/application 04:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:58:16 INFO - Reading from file tmpfile_stdout 04:58:16 INFO - Output received: 04:58:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:58:16 INFO - Running post-action listener: _resource_record_post_action 04:58:16 INFO - ##### 04:58:16 INFO - ##### Finished install step (success) 04:58:16 INFO - ##### 04:58:16 INFO - ##### 04:58:16 INFO - ##### Running run-tests step. 04:58:16 INFO - ##### 04:58:16 INFO - Running pre-action listener: _resource_record_pre_action 04:58:16 INFO - Running main action method: run_tests 04:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:16 INFO - Python 2.7.3 04:58:16 INFO - Return code: 0 04:58:16 INFO - grabbing minidump binary from tooltool 04:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:16 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 0xe181c0>, '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 0xe190c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:58:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:58:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:58:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:16 INFO - Return code: 0 04:58:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:58:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:58:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:58:17 INFO - Return code: 0 04:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:58:17 INFO - Using env: {'DISPLAY': ':0', 04:58:17 INFO - 'HOME': '/home/cltbld', 04:58:17 INFO - 'LANG': 'en_US.UTF-8', 04:58:17 INFO - 'LANGUAGE': 'en_US:en', 04:58:17 INFO - 'LOGNAME': 'cltbld', 04:58:17 INFO - 'MAIL': '/var/mail/cltbld', 04:58:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:17 INFO - 'MOZ_NO_REMOTE': '1', 04:58:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:17 INFO - 'NO_EM_RESTART': '1', 04:58:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:17 INFO - 'PWD': '/builds/slave/test', 04:58:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:17 INFO - 'SHELL': '/bin/bash', 04:58:17 INFO - 'SHLVL': '1', 04:58:17 INFO - 'TERM': 'linux', 04:58:17 INFO - 'TMOUT': '86400', 04:58:17 INFO - 'USER': 'cltbld', 04:58:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465039796.301079-151718172', 04:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:17 INFO - '_': '/tools/buildbot/bin/python'} 04:58:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:58:18 INFO - mozversion application_buildid: 20160604023008 04:58:18 INFO - mozversion application_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 04:58:18 INFO - mozversion application_display_name: Nightly 04:58:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:18 INFO - mozversion application_name: Firefox 04:58:18 INFO - mozversion application_remotingname: firefox 04:58:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:58:18 INFO - mozversion application_vendor: Mozilla 04:58:18 INFO - mozversion application_version: 49.0a1 04:58:18 INFO - mozversion platform_buildid: 20160604023008 04:58:18 INFO - mozversion platform_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 04:58:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:58:18 INFO - mozversion platform_version: 49.0a1 04:58:18 INFO - using testdate: 1465041498 04:58:18 INFO - actual date: 1465041498 04:58:18 INFO - starting webserver on 'localhost:45575' 04:58:18 INFO - SUITE-START | Running 2 tests 04:58:18 INFO - TEST-START | dromaeo_css 04:58:18 INFO - operating with platform_type : linux_ 04:58:18 INFO - Initialising browser for dromaeo_css test... 04:58:18 INFO - TEST-INFO | started process 5409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBlbeH/profile http://localhost:45575/getInfo.html) 04:58:22 INFO - PROCESS | 5409 | __metrics Screen width/height:1600/1200 04:58:22 INFO - PROCESS | 5409 | colorDepth:24 04:58:22 INFO - PROCESS | 5409 | Browser inner width/height: 1024/697 04:58:22 INFO - PROCESS | 5409 | __metrics 04:58:23 ERROR - PROCESS | 5409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:58:24 INFO - TEST-INFO | 5409: exit 0 04:58:24 INFO - Browser initialized. 04:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:24 INFO - TEST-INFO | started process 5529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBlbeH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:36 INFO - PROCESS | 5529 | RSS: Main: 167231488 04:58:36 INFO - PROCESS | 5529 | 04:59:25 INFO - PROCESS | 5529 | 1465041565643 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:01:32 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45575/tests/dromaeo/cssquery-ext.html) 05:01:33 INFO - PROCESS | 5529 | RSS: Main: 170917888 05:01:33 INFO - PROCESS | 5529 | 05:04:35 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-ext.html (next: http://localhost:45575/tests/dromaeo/cssquery-jquery.html) 05:04:36 INFO - PROCESS | 5529 | RSS: Main: 170160128 05:04:36 INFO - PROCESS | 5529 | 05:07:38 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45575/tests/dromaeo/cssquery-mootools.html) 05:07:38 INFO - PROCESS | 5529 | RSS: Main: 170893312 05:07:38 INFO - PROCESS | 5529 | 05:10:40 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45575/tests/dromaeo/cssquery-prototype.html) 05:10:41 INFO - PROCESS | 5529 | RSS: Main: 168886272 05:10:41 INFO - PROCESS | 5529 | 05:13:43 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45575/tests/dromaeo/cssquery-yui.html) 05:13:44 INFO - PROCESS | 5529 | RSS: Main: 170876928 05:13:44 INFO - PROCESS | 5529 | 05:16:46 INFO - PROCESS | 5529 | Cycle 1(1): loaded http://localhost:45575/tests/dromaeo/cssquery-yui.html (next: http://localhost:45575/tests/dromaeo/cssquery-dojo.html) 05:16:47 INFO - PROCESS | 5529 | RSS: Main: 172228608 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | __start_tp_report 05:16:47 INFO - PROCESS | 5529 | _x_x_mozilla_page_load 05:16:47 INFO - PROCESS | 5529 | _x_x_mozilla_page_load_details 05:16:47 INFO - PROCESS | 5529 | |i|pagename|runs| 05:16:47 INFO - PROCESS | 5529 | |0;dojo.html;3105.953410698839;3128.5150801625755;3144.7326977206944;3165.905022849314;3175.3014336845886;5308.601854860891;5319.680819150849;5345.1982202669615;5349.197620356938;5395.649282796625;5225.320708307924;5296.496832800878;5317.255584218213;5399.9730001349935;5405.4324295948945;4784.808607655698;4812.566868981791;4829.372181616385;4875.756212189394;4992.725400102993;508.71929520408963;4875.512448755132;4897.534734200263;4924.655274130812;4965.205567109263;4702.036082603058;4826.083044221604;4846.975765121169;4893.853184404474;4938.728369939652;4904.411470623548;4933.654644174909;4941.678790878582;4942.332785074041;4973.055119527278;4778.068276686047;4852.902941941176;4879.1461494238365;4891.779869905863;4895.290182923492;5276.709780962045;5288.391834938954;5316.069687804618;5320.388155362144;5340.973295133538;5742.253507044099;5747.425257474261;5769.278840144982;5771.047777116771;5810.5932584719085;5570.3315602127595;5660.264165658479;5707.1153971134545;5727;5755.654660720328;5310.522053015208;5316.20256961455;5320.228566857822;5354.651947623392;5360.115580929181;5694.800681976111;5845.1232315153065;5857.677827719431;5863.120531920161;5866.882662346729;5513.448655134454;5538.667679939136;5568.693721845338;5571.60998730085;5575.665460072409;5623.915641265385;5709.885802283931;5714.142878568165;5721.456461636138;5734.569907256972;5555.083411237181;5570.108782594846;5678.488935995781;5684.317881854204;5710.086386178275;5669.177969194444;5683.914741278884;5704.1443783432815;5712.542996560265;5756.798512052058;4317.935230971538;4320.956790432056;4335.089631177425;4335.588119128678;4349.499807522112;3822.980885095557;3847.9038024049623;3851.171998020439;3877.166409222031;3894.337962546374;5314.840554783363;5369.731513424314;5403.189521571717;5455.672659640355;5509.063459211943;5787.623804452697;5790;5790.449907258803;5796.072628379439;5799.449052340021;5272.762725677277;5368.409474957752;5425.26758887553;5454.854480559047;5509.724513774376;4915.8033678652455;4921.7785199666105;4926.926096108561;4929.06347793918;4944.233643785219;5882.617629854046;5900.350961394243;5901.232839730894;5905.320888097924;5968.074948383008;5529.640573362719;5705.058665320259;5732;5744.368119506935;5811.738471768866;5941.524678025834;5942.64344139353;5956.106584012433;5971.91042134377;5978.342382338026;5448.700321482356;5687.573431992534;5690.886182276248;5694.345150307768;5706.572007099401;5611.466910643482;5692.971535142297;5713.371529131709;5727.799527016535;5731.083026715705;5575.135853942646;5616.297962754656;5630.127330263816;5636.915446268227;5665.291838520185;5464.535514481314;5544.445555444423;5653.293338332708;5657.12314591239;5660.773569057192;5543.8891222176135;5549.694766787704;5550.861228469321;5589.524890384363;5592.440755924375;5655.88688226225;5667.801626943037;5669.234653321749;5685.374608792947;5690.9430905690415;5357.116075847442;5480.890382192413;5515.09001014828;5532.114861622121;5616.017196990592 05:16:47 INFO - PROCESS | 5529 | |1;ext.html;580.8199458167968;607.1712112965802;620.2556931681981;627.8555932135612;631.3717850738514;33009;36710.082247943814;42889;43900.12199756003;44291.77854110733;45023.32465013027;45580.088398232016;45617.7719111404;45627.54372456275;45691;8633.266172375355;8760.167784060504;8760.386772925898;8789.208971192591;8792.47245165289;8680.696175633853;8807.07525709801;8807.207351338378;8827.249683776887;8841.071687472788;8864.645414183457;8895.555222238894;8903.465792052466;8929.062448442917;8954.507502087383;8785.209331160226;8839.867401988975;8865;8922.509261990588;8930.062343453941;8696.739097827076;8759.737207883774;8786.692465763732;8797.692080777206;8807.383483156182;42284.15431691349;42681.146377072284;42756.57243427557;42795;42805;3571.624979377154;3572.4105522588743;4159.292920203573;4219.978900105511;4297.871063868089;32378.514322285184;32422.189445264055;32838;32986.6701332986;33004.66995330064;3798.620137986179;3843.423486477023;3874.5350557932948;3963.346047902093;4037.899052523681;380548;382820;383906;386159.9999999972;386485;51220.74389628103;55336.72331638316;56849;57885.421145788845;58247.41752582505;57559.84880302454;57951;58162;58486.7075664619;58676.41323586795;16400.589985250226;16401.917990409973;16489.175541222892;16557.08936008507;16594.336226550804;12732.299723515296;12894.80657790134;12925.547605833939;12931.870681293067;12937.159084659466;15723.606909827116;15866.20668966547;15880.920595396949;15936.36254549805;15982.36070557188;6428.839279018062;6483.157189565326;6499;6505.8698826024165;6587.80236592903;995.6664517386612;1083.8482612434266;1128.1313388690662;1154.0709728668503;1154.3131836557236;31144.377112457623;31568.368632627218;31578.36843263168;31962.360752784814;32118;1125.611663975927;1155.9768804623861;1174.4362705901215;1191.666333426642;1232.9827891989146;16305.836941630669;16772.832271677373;16895.91552042232;16941.322347106223;16968.660626787394;535058;540166;542752;543034;544263;57636.711816441486;58054.4194558049;58116.41883581194;58533.122003169985;58594.707026464595;1345.3744009035845;1376.504458394957;1389.215093472185;1396.9092009019382;1400.404827948118;29617.703822961495;31168.688313117487;31575.684243157273;31576.842115789274;32409.35181296408;50001.49998499968;53690.73154634202;54971.450285498235;55529.16706249329;59416.405835941085;493638;497788;499758;504171;504362;27633.171004869888;27802.16593502198;28066.85966570236;28144.43711125807;28173.295667608472;48439;49277.507224928726;49504.75247623739;50148;50530.74734626304;41433;42190;42259;42795.5720442804;42987.3551896728;41610.05383842489;41737.79131104325;42486;42605.36091958561;42768.358474622284;38090.61909380871;39263.2147357057;40120.79939600283;41434.1713165741;41756.164876702904;33954.32091358209;37627;37713;38537.614623853406;38774.80612596919;28613.713862861936;28623;28728.56357182174;28889.71110288954;29096.7090329094 05:16:47 INFO - PROCESS | 5529 | |2;jquery.html;398.8942930123518;398.97007724420666;405.7504634649688;411.74677573292416;426.97865106744655;17490.07609162991;18909.24363025481;19233.134508947096;19338.806611933876;19731.112099955502;15618.921905390485;15799.447019354326;16866.24101915414;19510.512237194078;19752.90123549384;5615.185798059279;5649.519790817775;5747.856303592423;5751.079827227644;5865.853353666171;5691.715414229293;5737.713114344266;5744.368119506851;5751;5756.683382413966;5577.386487486373;5650.180723795047;5703.116017017369;5825.067989121741;5834.183214349994;5792.247007888989;5800.0719884818645;5806.622569532967;5819.62172458791;5837.50381217597;5029.1450453423;5165.354330708661;5176.741162941876;5205.947940520584;5210.609204309654;22651.54696906069;22819;22969.42576435586;23478;23526.52946941069;2101.989490052555;2523.4574566468295;3028.0764366868098;3035.848207589612;3069.5395690646583;10244.02681745233;10397.116245119174;10533.683989480327;10789.62236321725;10948.507317170666;1900.4963684623585;1962.077823422989;1971.6648169811167;1975.5159985803427;1980.9306674266475;62316;83425.58287208586;83712.16287837166;83811.5809420949;84491;10988.285761425483;11058.336499810037;11187.160962927814;11278.436078196057;11330.60342887995;15534.067955922681;15627.531174064796;15740.291686874118;15744.763828542582;15782.289796959165;8055.677772889136;8210.261076503024;8347.29048030912;8378.162183781695;8655.221030107321;8174.468659537111;8261.917380826235;8263.338932885355;8335.7913102601;8383.16168383169;4653.976730116327;4758.095961767253;4816.659391245654;4853.878653033702;4863.294822250754;1904.6285974235168;1965.862389632712;1990.164131064956;2012.8590998630248;2014.8992550372423;913.6847787513298;954.6801821389773;976.3263348289657;986.0927946289431;1068.791585640808;19307.710384344246;19567.119479623452;19618.607627847363;19865.205391784166;20190.293339733333;966.709987003896;993.2897977945803;1001.5793366785967;1035.7307100153864;1040.95836166554;10852.837207441895;11227.607033753779;11234.269772464764;11274.661760147208;11320.660380188607;492552;497668;502300;502612;502863;70484;80803.19196807957;81209;96127.75169613953;100175.49912250538;992.9900700993043;993.9155171810332;1013.9036791504795;1016.4307987527009;1022.8465730140539;17313.913430432767;17548.91225543864;17775.377861774778;17819.287228510715;17951.820481795014;40571.59428405678;40962.79518602388;41289;41356;41441.58558414498;54195.458045420615;56680;56684.14973775314;56791.14813277721;57229.713851430475;8494.617742201492;8583.65665373378;8780.604872780868;8799.47203167812;8888.955555222183;9678.467684277432;12955.5465558705;13224.404901779635;13436.261005644783;13548.458061677422;11431;11458.19792614509;11718.121140914294;11772.17594768358;11840.230385024946;10408.375497470177;11531.942340288246;11592.47833847462;11768.52925882955;11803.82294265604;11652.126090543074;11720.472578733807;11729.941350293195;11823.645290641294;12232.143749937419;8426.452280601741;8644;8701.564921753761;8756.168164024408;8937.28501719874;8898.4660920345;10869.759987257736;12103.515859365527;12324.32216228116;12458 05:16:47 INFO - PROCESS | 5529 | |3;mootools.html;1463.4000059975413;1487.8735307498862;1630.3560093762965;1779.5906941403484;1782.777152855893;7358.411327093833;8297.709580164696;8299.792505187374;8788.384813063089;8805.867911981317;8510;8628.09405012474;8640.611172497236;8656.567171641409;8715.91284087159;2227.086894373307;2277.8861056947085;2286.874221917794;2292.323764489471;2295.540891821634;2166.80498755112;2191.561687662466;2209.591225623257;2213.1147540983575;2217.81148602369;2273.0566814771933;2277.123307526606;2347.5187586544716;2355.3875992242056;2374.548835721216;2256.311824893407;2295.426143464134;2332.650102484624;2334.0313769785603;2343.4727186383097;2223.5886361023263;2238;2250.5161390301164;2250.9437264068365;2257.7290725113094;8594.054653988056;8607;8643.049264580892;8702.738917832476;8706.042335343107;5158.587313014988;5239.1093514102695;5244.39689435716;5277.86805329866;5304.522592966651;3237.8542965566608;3293.077938177314;3382.2220889195623;3451.6030656474327;3460.359833430798;1087.478010554938;1127.8421021057059;1139.3562637110006;1148;1163.2613290560555;11899.88100119005;11941.64175074749;11950.880491195063;11958.880411195863;11963.282203067844;4509.1658043262105;4550.658700597469;4656.4877863434995;4657.301404789241;4659;10089.394636321844;10156.035176658206;10160.898391016142;10166.135878450266;10168.28821982454;5191.143461328914;5193.506616871391;5217.295665085165;5245.213218017251;5256.185291279858;4154.875353739392;4588.632909367243;4672.32251323563;4718.764061796896;4737.905241895142;3875.3411919973673;3930.7051971102283;3961.9009524761536;4025.2352053109817;4196.118815048813;1210.5218438716659;1285.7235694325766;1289.2457912121326;1290.2581015915887;1311.5344052861287;955.7467271173006;957.818014577228;962.3071388600197;965.3676841668719;982.0768477631004;5761.251037365116;5770.105633626795;5789.652620842763;5800.216970708901;5868.941310586925;1002.7443002034435;1037.5590374090982;1040.5889673578895;1047.7799662070897;1067.7490789664423;3828.349180639298;3881.728279020498;3882.5535063467496;3899.1811719538646;3948.1511475033008;10212.591496340063;10718.08896243828;10774.515146818412;10790.460476976119;10792.082672972729;10360.378377297386;10567.207459440573;10660.786784264426;10668.093212077061;10679.359238445719;8012.679492820222;8031.277185053374;8042.195780421911;8114.107448180695;8115.229053239933;5568.610197286151;5639.407862174577;5670.688112153871;5696.316442026983;5791.507721843691;9720.75698107553;9737.123658870452;9754.024597540189;9771.609135634495;9823.115919567274;9558.61765529371;9756.756081098029;9806.21550275962;9848.06443387877;9887.85168222463;6655.434288085567;6988.650567471708;7225.096862892138;7347.448941329315;7494.437917156344;8255.793605159679;8273.255407013397;8284.875726863982;8291.295239904675;8303.1281715419;7312.963435183003;7515.6242187891485;7587.772366829004;7597.468177227762;7709.460337776526;7359.264073592598;7374.705011799468;7383.040204773345;7436.256374362521;7450.552966822008;6604.306547812411;6647.302033286629;6655.201375834931;6660.300668429939;6687.130673012672;4823.083614113307;4864.294677271847;4958.6281028923695;5004.899902002013;5042.647014708935;5066.6200034998255;5158.123119069692;5173.81891633791;5182.766775495036;5183.403908550565 05:16:47 INFO - PROCESS | 5529 | |4;prototype.html;330.34921205225714;336.3676288577474;337.65896444590965;337.84796841421365;345.25941854721606;5405.4324295948945;5472.972635136819;5689.402612725661;5691.345495268046;5751.137329400592;5530.917036244459;5597.552195824334;5599.888002239953;5629.198656429944;5629.662220266777;4290.914181716364;4293.742375457467;4347.108842687241;4363.170997510479;4373.4095897053885;4097.815598298083;4323.935140972888;4329.264025115722;4398.802053907566;4403.933940990888;4271.9572804271875;4272.1028583997395;4279.068837846085;4283.479364825489;4310.224159651277;4304.5910638489295;4309;4315.525292217853;4326.718763280408;4337.132573485284;3589.7128229741556;3803.82882770276;3806.543214814212;3809.4095415210686;3822.6368494993208;5367.845913128696;5400.621956463049;5408.756605952703;5432.2123292122815;5442.510174084351;4905.23968784839;4914.680545764514;4932.284818701304;4934.259861020875;4946.2580612908;5522.779088836442;5829.562782791308;5831.57126504005;5844.766209351621;5850.3564607893095;4062.6546743526837;4106.445629839964;4117.258893399187;4118.91762164758;4164.354525048622;6056.849818314479;6073.423024812636;6082.847928801771;6089.756409743605;6115.541334399938;4128.938065929014;4223.092035212383;4234.8142520094425;4236.559569746301;4241.681873859411;4287.228298906227;4293.828246870153;4308.202982448257;4318.201132790444;4320.805563749639;4759.547842954914;4853.956399374081;4903;4924.507549245047;4986.202207646759;5815.73829177688;5844.649321040752;5846.367085641344;5926.4666180044005;5927.555433342431;1471.6615178509003;1482.9406823726931;1483.4437086092714;1495.4765831958728;1497.6779992301708;928.8095940332215;951.1582249709057;954.8997355277735;961.8316794561064;962.8459446488528;4993.876377814962;5052.267421223902;5068.189089745623;5135.281060651511;5199.714015729096;5364.892702146013;5372.543333816591;5373.9731301343245;5466.398696143421;5482.588805839578;4870.975645121752;4904.966278356831;5061.746912654353;5083.966872795905;5099.209622508517;2884.298264024236;2889.8699558519916;2905.5932169496286;2908.88364465419;2935.530315149566;5506.64206826555;5544.91682624761;5551.611387202938;5575.553955683536;5578.163275508625;5429.864253393618;5693.658380497183;6181.96909015452;6192.318844927055;6199.535034872402;6282.151909492251;6288.308286088527;6293.433590976742;6321.873562528724;6325.177726895567;6027.005544085352;6107.267127944675;6159.907601386072;6174.567780255339;6177.81466556004;5871.706414679335;6044.727987240497;6048.697565121638;6067.575269731076;6103.176071230327;5688.687122208318;6212.378762123752;6221.471174949999;6304.014235515798;6317.652529110759;4229.577042295746;4243.239055791812;4268.91462170761;4273.551277115858;4273.700840941105;6095.2685677718955;6115.969420152871;6119.265688117454;6166.845828854135;6169.722362493609;5789.45000224978;5906.881862362815;5929.466348028698;5977.491913187428;5998.910016349845;5872.442117998783;5873.2658417697785;5884.499452639549;5908.527317814479;5934.881302373842;5769.711514424178;5816.982028145142;5832.066869300891;5834.679092649775;5835.7373918174635;5596.328440586993;5939.821805345847;5957.8084383124415;5969.432903874125;5998.550108741774;5768.278965129359;5816.680082595498;5851.239338885917;5853.268341457318;5889.911651325147 05:16:47 INFO - PROCESS | 5529 | |5;yui.html;768.7808974442285;777.3625626985873;797.3222760653446;811.2536466450864;848.6817443458701;15200.92399538002;15269.312880920357;15419.768703469457;15731.84268157318;15749.84250157498;13923.37344819483;13937.372818223179;13971.930140349285;14039.789403158935;14063.718725625482;808.9514629122257;818.4271010292789;820.1347578304886;820.9753707388788;822.2640736540792;678.3182901184302;792.3859009267806;808.7533302342783;811.4887620798918;817.5626040068564;856.8714692796068;857.652650676477;864.4813112132701;866.4801119328384;866.5970323799432;854.1159899504046;856.9271611912994;857.3912522109279;859.1794835931702;860.1054902900976;618.832915112917;619.894617914951;622.4273668225244;625.8998560230386;626.0140279060453;14289.142651440947;14325.426982920671;14377.209253491053;14378.928105359511;14391.78412323816;15559.611009724847;15608.687826243411;15660.530184094496;15757.369705211893;15858.60353491172;12382.677588557903;12416.503339866395;12459.252444853339;12777.425015874307;12834.101612887102;3827.6937844972335;3834.0798208430056;3878.941815872764;4002.7998600070173;4027.0939038716347;74548.99999999946;75223;77687.22312776913;78092.60953695195;78743.99999999943;11334.886651133384;11338.773224535464;12123.515059397701;12248.632541023784;12398.690032749253;23053.654195187086;23276.41808954756;23458.413539661644;23560.175393861133;23694.644580331307;8925.419847709878;8976.551172441352;9095.135962083592;9154.130357616015;9364;4951.900961980812;5025.422076461181;5105.897882042413;5115.1559992600805;5139.434662187156;3699.741018128705;3812.599677033927;3815.904602384907;3816.1795214029116;3825.3305671507374;628.8082134948885;630.9936900631027;632.4150161100963;645.7223393940557;652.7128063651978;662.3078882567728;680.357062575861;687.0141347166832;739.7216572955285;759.4107369758573;9879.456629885282;9901.306908516479;10116.342437741523;10119.797604047877;10352.585896564053;559.6502186133666;590.8818236352747;668.8963210702349;698.5180225644289;734.1997223026926;4702.412198475191;4810.542998415145;4872.829450969199;4886.682365646222;4907.828226012072;61716.38283617106;63082.684586576775;67521;68157.65921170362;68220.6588967052;98089;100459.49770251248;101904.49047754862;102197.48901255446;102257.48871255596;79411.60294198492;80617;81071.59464202759;90150;90660.92025858852;9966.252531060345;10370.792584148125;10579.15366770672;10663.200259980378;10697.14422846186;37840.43239351357;38138.80930595329;52142;56998.7150064247;57094;75657.62171189109;80639.59680201796;83637;86350;86782;13469.12450690702;13573.11774734639;13664.795028074786;13795.448182073007;13826.516071937434;14764.63088422798;14918.328675209425;14946.551603451913;15008.699826003638;15021.549353519413;13714.17714937107;13886.444542218198;14150.78773818373;14254.643633909236;14609.853901460849;14515.129092254498;14661.120332780067;14965.850341496882;15108.106764749564;15181.16503592313;14027.438902443788;14169.858301416854;14360.210188439736;14508.709825803637;14608;10792;10799.838002430128;10909.236353455182;11101.722456938642;11650.941745291218;9569.90430095718;9941.552630131517;10060.84908726355;10277.84583231267;10409.178393781209 05:16:47 INFO - PROCESS | 5529 | __end_tp_report 05:16:47 INFO - PROCESS | 5529 | __start_cc_report 05:16:47 INFO - PROCESS | 5529 | _x_x_mozilla_cycle_collect,362 05:16:47 INFO - PROCESS | 5529 | __end_cc_report 05:16:47 INFO - PROCESS | 5529 | __startTimestamp1465042607087__endTimestamp 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | ------- Summary: start ------- 05:16:47 INFO - PROCESS | 5529 | Number of tests: 6 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#0] dojo.html Cycles:165 Average:5286.99 Median:5532.11 stddev:707.71 (12.8%) stddev-sans-first:688.89 05:16:47 INFO - PROCESS | 5529 | Values: 3106.0 3128.5 3144.7 3165.9 3175.3 5308.6 5319.7 5345.2 5349.2 5395.6 5225.3 5296.5 5317.3 5400.0 5405.4 4784.8 4812.6 4829.4 4875.8 4992.7 508.7 4875.5 4897.5 4924.7 4965.2 4702.0 4826.1 4847.0 4893.9 4938.7 4904.4 4933.7 4941.7 4942.3 4973.1 4778.1 4852.9 4879.1 4891.8 4895.3 5276.7 5288.4 5316.1 5320.4 5341.0 5742.3 5747.4 5769.3 5771.0 5810.6 5570.3 5660.3 5707.1 5727.0 5755.7 5310.5 5316.2 5320.2 5354.7 5360.1 5694.8 5845.1 5857.7 5863.1 5866.9 5513.4 5538.7 5568.7 5571.6 5575.7 5623.9 5709.9 5714.1 5721.5 5734.6 5555.1 5570.1 5678.5 5684.3 5710.1 5669.2 5683.9 5704.1 5712.5 5756.8 4317.9 4321.0 4335.1 4335.6 4349.5 3823.0 3847.9 3851.2 3877.2 3894.3 5314.8 5369.7 5403.2 5455.7 5509.1 5787.6 5790.0 5790.4 5796.1 5799.4 5272.8 5368.4 5425.3 5454.9 5509.7 4915.8 4921.8 4926.9 4929.1 4944.2 5882.6 5900.4 5901.2 5905.3 5968.1 5529.6 5705.1 5732.0 5744.4 5811.7 5941.5 5942.6 5956.1 5971.9 5978.3 5448.7 5687.6 5690.9 5694.3 5706.6 5611.5 5693.0 5713.4 5727.8 5731.1 5575.1 5616.3 5630.1 5636.9 5665.3 5464.5 5544.4 5653.3 5657.1 5660.8 5543.9 5549.7 5550.9 5589.5 5592.4 5655.9 5667.8 5669.2 5685.4 5690.9 5357.1 5480.9 5515.1 5532.1 5616.0 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#1] ext.html Cycles:180 Average:63030.27 Median:42385.08 stddev:127361.94 (300.5%) stddev-sans-first:127632.92 05:16:47 INFO - PROCESS | 5529 | Values: 580.8 607.2 620.3 627.9 631.4 33009.0 36710.1 42889.0 43900.1 44291.8 45023.3 45580.1 45617.8 45627.5 45691.0 8633.3 8760.2 8760.4 8789.2 8792.5 8680.7 8807.1 8807.2 8827.2 8841.1 8864.6 8895.6 8903.5 8929.1 8954.5 8785.2 8839.9 8865.0 8922.5 8930.1 8696.7 8759.7 8786.7 8797.7 8807.4 42284.2 42681.1 42756.6 42795.0 42805.0 3571.6 3572.4 4159.3 4220.0 4297.9 32378.5 32422.2 32838.0 32986.7 33004.7 3798.6 3843.4 3874.5 3963.3 4037.9 380548.0 382820.0 383906.0 386160.0 386485.0 51220.7 55336.7 56849.0 57885.4 58247.4 57559.8 57951.0 58162.0 58486.7 58676.4 16400.6 16401.9 16489.2 16557.1 16594.3 12732.3 12894.8 12925.5 12931.9 12937.2 15723.6 15866.2 15880.9 15936.4 15982.4 6428.8 6483.2 6499.0 6505.9 6587.8 995.7 1083.8 1128.1 1154.1 1154.3 31144.4 31568.4 31578.4 31962.4 32118.0 1125.6 1156.0 1174.4 1191.7 1233.0 16305.8 16772.8 16895.9 16941.3 16968.7 535058.0 540166.0 542752.0 543034.0 544263.0 57636.7 58054.4 58116.4 58533.1 58594.7 1345.4 1376.5 1389.2 1396.9 1400.4 29617.7 31168.7 31575.7 31576.8 32409.4 50001.5 53690.7 54971.5 55529.2 59416.4 493638.0 497788.0 499758.0 504171.0 504362.0 27633.2 27802.2 28066.9 28144.4 28173.3 48439.0 49277.5 49504.8 50148.0 50530.7 41433.0 42190.0 42259.0 42795.6 42987.4 41610.1 41737.8 42486.0 42605.4 42768.4 38090.6 39263.2 40120.8 41434.2 41756.2 33954.3 37627.0 37713.0 38537.6 38774.8 28613.7 28623.0 28728.6 28889.7 29096.7 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#2] jquery.html Cycles:180 Average:28992.82 Median:1734.22 stddev:82182.62 (4738.9%) stddev-sans-first:82385.11 05:16:47 INFO - PROCESS | 5529 | Values: 398.9 399.0 405.8 411.7 427.0 17490.1 18909.2 19233.1 19338.8 19731.1 15618.9 15799.4 16866.2 19510.5 19752.9 5615.2 5649.5 5747.9 5751.1 5865.9 5691.7 5737.7 5744.4 5751.0 5756.7 5577.4 5650.2 5703.1 5825.1 5834.2 5792.2 5800.1 5806.6 5819.6 5837.5 5029.1 5165.4 5176.7 5205.9 5210.6 22651.5 22819.0 22969.4 23478.0 23526.5 2102.0 2523.5 3028.1 3035.8 3069.5 10244.0 10397.1 10533.7 10789.6 10948.5 1900.5 1962.1 1971.7 1975.5 1980.9 62316.0 83425.6 83712.2 83811.6 84491.0 10988.3 11058.3 11187.2 11278.4 11330.6 15534.1 15627.5 15740.3 15744.8 15782.3 8055.7 8210.3 8347.3 8378.2 8655.2 8174.5 8261.9 8263.3 8335.8 8383.2 4654.0 4758.1 4816.7 4853.9 4863.3 1904.6 1965.9 1990.2 2012.9 2014.9 913.7 954.7 976.3 986.1 1068.8 19307.7 19567.1 19618.6 19865.2 20190.3 966.7 993.3 1001.6 1035.7 1041.0 10852.8 11227.6 11234.3 11274.7 11320.7 492552.0 497668.0 502300.0 502612.0 502863.0 70484.0 80803.2 81209.0 96127.8 100175.5 993.0 993.9 1013.9 1016.4 1022.8 17313.9 17548.9 17775.4 17819.3 17951.8 40571.6 40962.8 41289.0 41356.0 41441.6 54195.5 56680.0 56684.1 56791.1 57229.7 8494.6 8583.7 8780.6 8799.5 8889.0 9678.5 12955.5 13224.4 13436.3 13548.5 11431.0 11458.2 11718.1 11772.2 11840.2 10408.4 11531.9 11592.5 11768.5 11803.8 11652.1 11720.5 11729.9 11823.6 12232.1 8426.5 8644.0 8701.6 8756.2 8937.3 8898.5 10869.8 12103.5 12324.3 12458.0 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#3] mootools.html Cycles:180 Average:5650.12 Median:4843.69 stddev:3178.85 (65.6%) stddev-sans-first:3172.20 05:16:47 INFO - PROCESS | 5529 | Values: 1463.4 1487.9 1630.4 1779.6 1782.8 7358.4 8297.7 8299.8 8788.4 8805.9 8510.0 8628.1 8640.6 8656.6 8715.9 2227.1 2277.9 2286.9 2292.3 2295.5 2166.8 2191.6 2209.6 2213.1 2217.8 2273.1 2277.1 2347.5 2355.4 2374.5 2256.3 2295.4 2332.7 2334.0 2343.5 2223.6 2238.0 2250.5 2250.9 2257.7 8594.1 8607.0 8643.0 8702.7 8706.0 5158.6 5239.1 5244.4 5277.9 5304.5 3237.9 3293.1 3382.2 3451.6 3460.4 1087.5 1127.8 1139.4 1148.0 1163.3 11899.9 11941.6 11950.9 11958.9 11963.3 4509.2 4550.7 4656.5 4657.3 4659.0 10089.4 10156.0 10160.9 10166.1 10168.3 5191.1 5193.5 5217.3 5245.2 5256.2 4154.9 4588.6 4672.3 4718.8 4737.9 3875.3 3930.7 3961.9 4025.2 4196.1 1210.5 1285.7 1289.2 1290.3 1311.5 955.7 957.8 962.3 965.4 982.1 5761.3 5770.1 5789.7 5800.2 5868.9 1002.7 1037.6 1040.6 1047.8 1067.7 3828.3 3881.7 3882.6 3899.2 3948.2 10212.6 10718.1 10774.5 10790.5 10792.1 10360.4 10567.2 10660.8 10668.1 10679.4 8012.7 8031.3 8042.2 8114.1 8115.2 5568.6 5639.4 5670.7 5696.3 5791.5 9720.8 9737.1 9754.0 9771.6 9823.1 9558.6 9756.8 9806.2 9848.1 9887.9 6655.4 6988.7 7225.1 7347.4 7494.4 8255.8 8273.3 8284.9 8291.3 8303.1 7313.0 7515.6 7587.8 7597.5 7709.5 7359.3 7374.7 7383.0 7436.3 7450.6 6604.3 6647.3 6655.2 6660.3 6687.1 4823.1 4864.3 4958.6 5004.9 5042.6 5066.6 5158.1 5173.8 5182.8 5183.4 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#4] prototype.html Cycles:180 Average:4856.57 Median:5469.69 stddev:1452.36 (26.6%) stddev-sans-first:1416.14 05:16:47 INFO - PROCESS | 5529 | Values: 330.3 336.4 337.7 337.8 345.3 5405.4 5473.0 5689.4 5691.3 5751.1 5530.9 5597.6 5599.9 5629.2 5629.7 4290.9 4293.7 4347.1 4363.2 4373.4 4097.8 4323.9 4329.3 4398.8 4403.9 4272.0 4272.1 4279.1 4283.5 4310.2 4304.6 4309.0 4315.5 4326.7 4337.1 3589.7 3803.8 3806.5 3809.4 3822.6 5367.8 5400.6 5408.8 5432.2 5442.5 4905.2 4914.7 4932.3 4934.3 4946.3 5522.8 5829.6 5831.6 5844.8 5850.4 4062.7 4106.4 4117.3 4118.9 4164.4 6056.8 6073.4 6082.8 6089.8 6115.5 4128.9 4223.1 4234.8 4236.6 4241.7 4287.2 4293.8 4308.2 4318.2 4320.8 4759.5 4854.0 4903.0 4924.5 4986.2 5815.7 5844.6 5846.4 5926.5 5927.6 1471.7 1482.9 1483.4 1495.5 1497.7 928.8 951.2 954.9 961.8 962.8 4993.9 5052.3 5068.2 5135.3 5199.7 5364.9 5372.5 5374.0 5466.4 5482.6 4871.0 4905.0 5061.7 5084.0 5099.2 2884.3 2889.9 2905.6 2908.9 2935.5 5506.6 5544.9 5551.6 5575.6 5578.2 5429.9 5693.7 6182.0 6192.3 6199.5 6282.2 6288.3 6293.4 6321.9 6325.2 6027.0 6107.3 6159.9 6174.6 6177.8 5871.7 6044.7 6048.7 6067.6 6103.2 5688.7 6212.4 6221.5 6304.0 6317.7 4229.6 4243.2 4268.9 4273.6 4273.7 6095.3 6116.0 6119.3 6166.8 6169.7 5789.5 5906.9 5929.5 5977.5 5998.9 5872.4 5873.3 5884.5 5908.5 5934.9 5769.7 5817.0 5832.1 5834.7 5835.7 5596.3 5939.8 5957.8 5969.4 5998.6 5768.3 5816.7 5851.2 5853.3 5889.9 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - PROCESS | 5529 | [#5] yui.html Cycles:180 Average:19817.20 Median:4364.75 stddev:26992.34 (618.4%) stddev-sans-first:27030.17 05:16:47 INFO - PROCESS | 5529 | Values: 768.8 777.4 797.3 811.3 848.7 15200.9 15269.3 15419.8 15731.8 15749.8 13923.4 13937.4 13971.9 14039.8 14063.7 809.0 818.4 820.1 821.0 822.3 678.3 792.4 808.8 811.5 817.6 856.9 857.7 864.5 866.5 866.6 854.1 856.9 857.4 859.2 860.1 618.8 619.9 622.4 625.9 626.0 14289.1 14325.4 14377.2 14378.9 14391.8 15559.6 15608.7 15660.5 15757.4 15858.6 12382.7 12416.5 12459.3 12777.4 12834.1 3827.7 3834.1 3878.9 4002.8 4027.1 74549.0 75223.0 77687.2 78092.6 78744.0 11334.9 11338.8 12123.5 12248.6 12398.7 23053.7 23276.4 23458.4 23560.2 23694.6 8925.4 8976.6 9095.1 9154.1 9364.0 4951.9 5025.4 5105.9 5115.2 5139.4 3699.7 3812.6 3815.9 3816.2 3825.3 628.8 631.0 632.4 645.7 652.7 662.3 680.4 687.0 739.7 759.4 9879.5 9901.3 10116.3 10119.8 10352.6 559.7 590.9 668.9 698.5 734.2 4702.4 4810.5 4872.8 4886.7 4907.8 61716.4 63082.7 67521.0 68157.7 68220.7 98089.0 100459.5 101904.5 102197.5 102257.5 79411.6 80617.0 81071.6 90150.0 90660.9 9966.3 10370.8 10579.2 10663.2 10697.1 37840.4 38138.8 52142.0 56998.7 57094.0 75657.6 80639.6 83637.0 86350.0 86782.0 13469.1 13573.1 13664.8 13795.4 13826.5 14764.6 14918.3 14946.6 15008.7 15021.5 13714.2 13886.4 14150.8 14254.6 14609.9 14515.1 14661.1 14965.9 15108.1 15181.2 14027.4 14169.9 14360.2 14508.7 14608.0 10792.0 10799.8 10909.2 11101.7 11650.9 9569.9 9941.6 10060.8 10277.8 10409.2 05:16:47 INFO - PROCESS | 5529 | -------- Summary: end -------- 05:16:47 INFO - PROCESS | 5529 | 05:16:47 INFO - TEST-INFO | 5529: exit 0 05:16:47 INFO - TEST-OK | dromaeo_css | took 1109698ms 05:16:47 INFO - TEST-START | kraken 05:16:47 INFO - operating with platform_type : linux_ 05:16:47 INFO - Initialising browser for kraken test... 05:16:47 INFO - TEST-INFO | started process 5762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCxdk6/profile http://localhost:45575/getInfo.html) 05:16:52 INFO - PROCESS | 5762 | __metrics Screen width/height:1600/1200 05:16:52 INFO - PROCESS | 5762 | colorDepth:24 05:16:52 INFO - PROCESS | 5762 | Browser inner width/height: 1024/697 05:16:52 INFO - PROCESS | 5762 | __metrics 05:16:52 ERROR - PROCESS | 5762 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:16:53 INFO - TEST-INFO | 5762: exit 0 05:16:53 INFO - Browser initialized. 05:16:53 INFO - Running cycle 1/1 for kraken test... 05:16:53 INFO - TEST-INFO | started process 5880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCxdk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:05 INFO - PROCESS | 5880 | RSS: Main: 167378944 05:17:05 INFO - PROCESS | 5880 | 05:17:08 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45575/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:08 INFO - PROCESS | 5880 | RSS: Main: 172584960 05:17:08 INFO - PROCESS | 5880 | 05:17:11 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45575/tests/kraken/driver.html?testName=audio-dft) 05:17:12 INFO - PROCESS | 5880 | RSS: Main: 171847680 05:17:12 INFO - PROCESS | 5880 | 05:17:15 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45575/tests/kraken/driver.html?testName=audio-fft) 05:17:15 INFO - PROCESS | 5880 | RSS: Main: 166735872 05:17:15 INFO - PROCESS | 5880 | 05:17:18 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45575/tests/kraken/driver.html?testName=audio-oscillator) 05:17:18 INFO - PROCESS | 5880 | RSS: Main: 167469056 05:17:18 INFO - PROCESS | 5880 | 05:17:20 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:21 INFO - PROCESS | 5880 | RSS: Main: 167956480 05:17:21 INFO - PROCESS | 5880 | 05:17:24 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45575/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:25 INFO - PROCESS | 5880 | RSS: Main: 168427520 05:17:25 INFO - PROCESS | 5880 | 05:17:28 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45575/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:29 INFO - PROCESS | 5880 | RSS: Main: 165748736 05:17:29 INFO - PROCESS | 5880 | 05:17:32 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45575/tests/kraken/driver.html?testName=json-parse-financial) 05:17:32 INFO - PROCESS | 5880 | RSS: Main: 166662144 05:17:32 INFO - PROCESS | 5880 | 05:17:34 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:35 INFO - PROCESS | 5880 | RSS: Main: 167677952 05:17:35 INFO - PROCESS | 5880 | 05:17:36 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:37 INFO - PROCESS | 5880 | RSS: Main: 168099840 05:17:37 INFO - PROCESS | 5880 | 05:17:39 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:40 INFO - PROCESS | 5880 | RSS: Main: 168550400 05:17:40 INFO - PROCESS | 5880 | 05:17:42 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:43 INFO - PROCESS | 5880 | RSS: Main: 168509440 05:17:43 INFO - PROCESS | 5880 | 05:17:46 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:46 INFO - PROCESS | 5880 | RSS: Main: 168198144 05:17:46 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | Cycle 1(1): loaded http://localhost:45575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45575/tests/kraken/driver.html?testName=ai-astar) 05:17:48 INFO - PROCESS | 5880 | RSS: Main: 169062400 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | __start_tp_report 05:17:48 INFO - PROCESS | 5880 | _x_x_mozilla_page_load 05:17:48 INFO - PROCESS | 5880 | _x_x_mozilla_page_load_details 05:17:48 INFO - PROCESS | 5880 | |i|pagename|runs| 05:17:48 INFO - PROCESS | 5880 | |0;ai-astar;113;108;112;112;111;113;111;111;113;113 05:17:48 INFO - PROCESS | 5880 | |1;audio-beat-detection;154;127;161;185;125;162;159;130;189;126 05:17:48 INFO - PROCESS | 5880 | |2;audio-dft;160;161;162;162;165;171;164;162;162;161 05:17:48 INFO - PROCESS | 5880 | |3;audio-fft;75;75;76;152;76;75;74;76;155;75 05:17:48 INFO - PROCESS | 5880 | |4;audio-oscillator;85;85;146;85;86;86;138;85;85;138 05:17:48 INFO - PROCESS | 5880 | |5;imaging-gaussian-blur;117;117;118;117;117;118;118;117;117;118 05:17:48 INFO - PROCESS | 5880 | |6;imaging-darkroom;146;148;147;148;147;147;148;148;147;146 05:17:48 INFO - PROCESS | 5880 | |7;imaging-desaturate;96;96;95;95;95;96;95;96;95;96 05:17:48 INFO - PROCESS | 5880 | |8;json-parse-financial;60;61;62;57;59;59;59;58;57;59 05:17:48 INFO - PROCESS | 5880 | |9;json-stringify-tinderbox;63;63;65;63;63;63;62;62;63;63 05:17:48 INFO - PROCESS | 5880 | |10;stanford-crypto-aes;80;80;86;87;81;81;81;81;102;87 05:17:48 INFO - PROCESS | 5880 | |11;stanford-crypto-ccm;133;131;129;131;128;120;122;129;128;133 05:17:48 INFO - PROCESS | 5880 | |12;stanford-crypto-pbkdf2;172;170;167;160;162;168;164;168;169;167 05:17:48 INFO - PROCESS | 5880 | |13;stanford-crypto-sha256-iterative;69;72;69;64;69;65;65;64;63;62 05:17:48 INFO - PROCESS | 5880 | __end_tp_report 05:17:48 INFO - PROCESS | 5880 | __start_cc_report 05:17:48 INFO - PROCESS | 5880 | _x_x_mozilla_cycle_collect,889 05:17:48 INFO - PROCESS | 5880 | __end_cc_report 05:17:48 INFO - PROCESS | 5880 | __startTimestamp1465042668793__endTimestamp 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | ------- Summary: start ------- 05:17:48 INFO - PROCESS | 5880 | Number of tests: 14 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:1.57 (1.4%) stddev-sans-first:1.59 05:17:48 INFO - PROCESS | 5880 | Values: 113.0 108.0 112.0 112.0 111.0 113.0 111.0 111.0 113.0 113.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:160.00 stddev:24.05 (15.0%) stddev-sans-first:25.50 05:17:48 INFO - PROCESS | 5880 | Values: 154.0 127.0 161.0 185.0 125.0 162.0 159.0 130.0 189.0 126.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:3.16 (2.0%) stddev-sans-first:3.16 05:17:48 INFO - PROCESS | 5880 | Values: 160.0 161.0 162.0 162.0 165.0 171.0 164.0 162.0 162.0 161.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.00 stddev:33.01 (44.0%) stddev-sans-first:34.50 05:17:48 INFO - PROCESS | 5880 | Values: 75.0 75.0 76.0 152.0 76.0 75.0 74.0 76.0 155.0 75.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:85.00 stddev:26.84 (31.6%) stddev-sans-first:27.77 05:17:48 INFO - PROCESS | 5880 | Values: 85.0 85.0 146.0 85.0 86.0 86.0 138.0 85.0 85.0 138.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:17:48 INFO - PROCESS | 5880 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 05:17:48 INFO - PROCESS | 5880 | Values: 146.0 148.0 147.0 148.0 147.0 147.0 148.0 148.0 147.0 146.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:17:48 INFO - PROCESS | 5880 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:1.60 (2.7%) stddev-sans-first:1.66 05:17:48 INFO - PROCESS | 5880 | Values: 60.0 61.0 62.0 57.0 59.0 59.0 59.0 58.0 57.0 59.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:17:48 INFO - PROCESS | 5880 | Values: 63.0 63.0 65.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.00 stddev:6.75 (8.3%) stddev-sans-first:6.95 05:17:48 INFO - PROCESS | 5880 | Values: 80.0 80.0 86.0 87.0 81.0 81.0 81.0 81.0 102.0 87.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:130.00 stddev:4.33 (3.3%) stddev-sans-first:4.26 05:17:48 INFO - PROCESS | 5880 | Values: 133.0 131.0 129.0 131.0 128.0 120.0 122.0 129.0 128.0 133.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.00 stddev:3.68 (2.2%) stddev-sans-first:3.37 05:17:48 INFO - PROCESS | 5880 | Values: 172.0 170.0 167.0 160.0 162.0 168.0 164.0 168.0 169.0 167.0 05:17:48 INFO - PROCESS | 5880 | 05:17:48 INFO - PROCESS | 5880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:3.29 (4.9%) stddev-sans-first:3.33 05:17:48 INFO - PROCESS | 5880 | Values: 69.0 72.0 69.0 64.0 69.0 65.0 65.0 64.0 63.0 62.0 05:17:48 INFO - PROCESS | 5880 | -------- Summary: end -------- 05:17:48 INFO - PROCESS | 5880 | 05:17:49 INFO - TEST-INFO | 5880: exit 0 05:17:49 INFO - TEST-OK | kraken | took 61947ms 05:17:49 INFO - SUITE-END | took 1171s 05:17:49 INFO - Completed test suite (00:19:31) 05:17:49 INFO - javascript benchmark 05:17:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7278.771624939419, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.953410698839, 3128.5150801625755, 3144.7326977206944, 3165.905022849314, 3175.3014336845886, 5308.601854860891, 5319.680819150849, 5345.1982202669615, 5349.197620356938, 5395.649282796625, 5225.320708307924, 5296.496832800878, 5317.255584218213, 5399.9730001349935, 5405.4324295948945, 4784.808607655698, 4812.566868981791, 4829.372181616385, 4875.756212189394, 4992.725400102993, 508.71929520408963, 4875.512448755132, 4897.534734200263, 4924.655274130812, 4965.205567109263, 4702.036082603058, 4826.083044221604, 4846.975765121169, 4893.853184404474, 4938.728369939652, 4904.411470623548, 4933.654644174909, 4941.678790878582, 4942.332785074041, 4973.055119527278, 4778.068276686047, 4852.902941941176, 4879.1461494238365, 4891.779869905863, 4895.290182923492, 5276.709780962045, 5288.391834938954, 5316.069687804618, 5320.388155362144, 5340.973295133538, 5742.253507044099, 5747.425257474261, 5769.278840144982, 5771.047777116771, 5810.5932584719085, 5570.3315602127595, 5660.264165658479, 5707.1153971134545, 5727.0, 5755.654660720328, 5310.522053015208, 5316.20256961455, 5320.228566857822, 5354.651947623392, 5360.115580929181, 5694.800681976111, 5845.1232315153065, 5857.677827719431, 5863.120531920161, 5866.882662346729, 5513.448655134454, 5538.667679939136, 5568.693721845338, 5571.60998730085, 5575.665460072409, 5623.915641265385, 5709.885802283931, 5714.142878568165, 5721.456461636138, 5734.569907256972, 5555.083411237181, 5570.108782594846, 5678.488935995781, 5684.317881854204, 5710.086386178275, 5669.177969194444, 5683.914741278884, 5704.1443783432815, 5712.542996560265, 5756.798512052058, 4317.935230971538, 4320.956790432056, 4335.089631177425, 4335.588119128678, 4349.499807522112, 3822.980885095557, 3847.9038024049623, 3851.171998020439, 3877.166409222031, 3894.337962546374, 5314.840554783363, 5369.731513424314, 5403.189521571717, 5455.672659640355, 5509.063459211943, 5787.623804452697, 5790.0, 5790.449907258803, 5796.072628379439, 5799.449052340021, 5272.762725677277, 5368.409474957752, 5425.26758887553, 5454.854480559047, 5509.724513774376, 4915.8033678652455, 4921.7785199666105, 4926.926096108561, 4929.06347793918, 4944.233643785219, 5882.617629854046, 5900.350961394243, 5901.232839730894, 5905.320888097924, 5968.074948383008, 5529.640573362719, 5705.058665320259, 5732.0, 5744.368119506935, 5811.738471768866, 5941.524678025834, 5942.64344139353, 5956.106584012433, 5971.91042134377, 5978.342382338026, 5448.700321482356, 5687.573431992534, 5690.886182276248, 5694.345150307768, 5706.572007099401, 5611.466910643482, 5692.971535142297, 5713.371529131709, 5727.799527016535, 5731.083026715705, 5575.135853942646, 5616.297962754656, 5630.127330263816, 5636.915446268227, 5665.291838520185, 5464.535514481314, 5544.445555444423, 5653.293338332708, 5657.12314591239, 5660.773569057192, 5543.8891222176135, 5549.694766787704, 5550.861228469321, 5589.524890384363, 5592.440755924375, 5655.88688226225, 5667.801626943037, 5669.234653321749, 5685.374608792947, 5690.9430905690415, 5357.116075847442, 5480.890382192413, 5515.09001014828, 5532.114861622121, 5616.017196990592], "value": 5241.9404029196985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8199458167968, 607.1712112965802, 620.2556931681981, 627.8555932135612, 631.3717850738514, 33009.0, 36710.082247943814, 42889.0, 43900.12199756003, 44291.77854110733, 45023.32465013027, 45580.088398232016, 45617.7719111404, 45627.54372456275, 45691.0, 8633.266172375355, 8760.167784060504, 8760.386772925898, 8789.208971192591, 8792.47245165289, 8680.696175633853, 8807.07525709801, 8807.207351338378, 8827.249683776887, 8841.071687472788, 8864.645414183457, 8895.555222238894, 8903.465792052466, 8929.062448442917, 8954.507502087383, 8785.209331160226, 8839.867401988975, 8865.0, 8922.509261990588, 8930.062343453941, 8696.739097827076, 8759.737207883774, 8786.692465763732, 8797.692080777206, 8807.383483156182, 42284.15431691349, 42681.146377072284, 42756.57243427557, 42795.0, 42805.0, 3571.624979377154, 3572.4105522588743, 4159.292920203573, 4219.978900105511, 4297.871063868089, 32378.514322285184, 32422.189445264055, 32838.0, 32986.6701332986, 33004.66995330064, 3798.620137986179, 3843.423486477023, 3874.5350557932948, 3963.346047902093, 4037.899052523681, 380548.0, 382820.0, 383906.0, 386159.9999999972, 386485.0, 51220.74389628103, 55336.72331638316, 56849.0, 57885.421145788845, 58247.41752582505, 57559.84880302454, 57951.0, 58162.0, 58486.7075664619, 58676.41323586795, 16400.589985250226, 16401.917990409973, 16489.175541222892, 16557.08936008507, 16594.336226550804, 12732.299723515296, 12894.80657790134, 12925.547605833939, 12931.870681293067, 12937.159084659466, 15723.606909827116, 15866.20668966547, 15880.920595396949, 15936.36254549805, 15982.36070557188, 6428.839279018062, 6483.157189565326, 6499.0, 6505.8698826024165, 6587.80236592903, 995.6664517386612, 1083.8482612434266, 1128.1313388690662, 1154.0709728668503, 1154.3131836557236, 31144.377112457623, 31568.368632627218, 31578.36843263168, 31962.360752784814, 32118.0, 1125.611663975927, 1155.9768804623861, 1174.4362705901215, 1191.666333426642, 1232.9827891989146, 16305.836941630669, 16772.832271677373, 16895.91552042232, 16941.322347106223, 16968.660626787394, 535058.0, 540166.0, 542752.0, 543034.0, 544263.0, 57636.711816441486, 58054.4194558049, 58116.41883581194, 58533.122003169985, 58594.707026464595, 1345.3744009035845, 1376.504458394957, 1389.215093472185, 1396.9092009019382, 1400.404827948118, 29617.703822961495, 31168.688313117487, 31575.684243157273, 31576.842115789274, 32409.35181296408, 50001.49998499968, 53690.73154634202, 54971.450285498235, 55529.16706249329, 59416.405835941085, 493638.0, 497788.0, 499758.0, 504171.0, 504362.0, 27633.171004869888, 27802.16593502198, 28066.85966570236, 28144.43711125807, 28173.295667608472, 48439.0, 49277.507224928726, 49504.75247623739, 50148.0, 50530.74734626304, 41433.0, 42190.0, 42259.0, 42795.5720442804, 42987.3551896728, 41610.05383842489, 41737.79131104325, 42486.0, 42605.36091958561, 42768.358474622284, 38090.61909380871, 39263.2147357057, 40120.79939600283, 41434.1713165741, 41756.164876702904, 33954.32091358209, 37627.0, 37713.0, 38537.614623853406, 38774.80612596919, 28613.713862861936, 28623.0, 28728.56357182174, 28889.71110288954, 29096.7090329094], "value": 20194.64746865565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8942930123518, 398.97007724420666, 405.7504634649688, 411.74677573292416, 426.97865106744655, 17490.07609162991, 18909.24363025481, 19233.134508947096, 19338.806611933876, 19731.112099955502, 15618.921905390485, 15799.447019354326, 16866.24101915414, 19510.512237194078, 19752.90123549384, 5615.185798059279, 5649.519790817775, 5747.856303592423, 5751.079827227644, 5865.853353666171, 5691.715414229293, 5737.713114344266, 5744.368119506851, 5751.0, 5756.683382413966, 5577.386487486373, 5650.180723795047, 5703.116017017369, 5825.067989121741, 5834.183214349994, 5792.247007888989, 5800.0719884818645, 5806.622569532967, 5819.62172458791, 5837.50381217597, 5029.1450453423, 5165.354330708661, 5176.741162941876, 5205.947940520584, 5210.609204309654, 22651.54696906069, 22819.0, 22969.42576435586, 23478.0, 23526.52946941069, 2101.989490052555, 2523.4574566468295, 3028.0764366868098, 3035.848207589612, 3069.5395690646583, 10244.02681745233, 10397.116245119174, 10533.683989480327, 10789.62236321725, 10948.507317170666, 1900.4963684623585, 1962.077823422989, 1971.6648169811167, 1975.5159985803427, 1980.9306674266475, 62316.0, 83425.58287208586, 83712.16287837166, 83811.5809420949, 84491.0, 10988.285761425483, 11058.336499810037, 11187.160962927814, 11278.436078196057, 11330.60342887995, 15534.067955922681, 15627.531174064796, 15740.291686874118, 15744.763828542582, 15782.289796959165, 8055.677772889136, 8210.261076503024, 8347.29048030912, 8378.162183781695, 8655.221030107321, 8174.468659537111, 8261.917380826235, 8263.338932885355, 8335.7913102601, 8383.16168383169, 4653.976730116327, 4758.095961767253, 4816.659391245654, 4853.878653033702, 4863.294822250754, 1904.6285974235168, 1965.862389632712, 1990.164131064956, 2012.8590998630248, 2014.8992550372423, 913.6847787513298, 954.6801821389773, 976.3263348289657, 986.0927946289431, 1068.791585640808, 19307.710384344246, 19567.119479623452, 19618.607627847363, 19865.205391784166, 20190.293339733333, 966.709987003896, 993.2897977945803, 1001.5793366785967, 1035.7307100153864, 1040.95836166554, 10852.837207441895, 11227.607033753779, 11234.269772464764, 11274.661760147208, 11320.660380188607, 492552.0, 497668.0, 502300.0, 502612.0, 502863.0, 70484.0, 80803.19196807957, 81209.0, 96127.75169613953, 100175.49912250538, 992.9900700993043, 993.9155171810332, 1013.9036791504795, 1016.4307987527009, 1022.8465730140539, 17313.913430432767, 17548.91225543864, 17775.377861774778, 17819.287228510715, 17951.820481795014, 40571.59428405678, 40962.79518602388, 41289.0, 41356.0, 41441.58558414498, 54195.458045420615, 56680.0, 56684.14973775314, 56791.14813277721, 57229.713851430475, 8494.617742201492, 8583.65665373378, 8780.604872780868, 8799.47203167812, 8888.955555222183, 9678.467684277432, 12955.5465558705, 13224.404901779635, 13436.261005644783, 13548.458061677422, 11431.0, 11458.19792614509, 11718.121140914294, 11772.17594768358, 11840.230385024946, 10408.375497470177, 11531.942340288246, 11592.47833847462, 11768.52925882955, 11803.82294265604, 11652.126090543074, 11720.472578733807, 11729.941350293195, 11823.645290641294, 12232.143749937419, 8426.452280601741, 8644.0, 8701.564921753761, 8756.168164024408, 8937.28501719874, 8898.4660920345, 10869.759987257736, 12103.515859365527, 12324.32216228116, 12458.0], "value": 9248.425816582398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.4000059975413, 1487.8735307498862, 1630.3560093762965, 1779.5906941403484, 1782.777152855893, 7358.411327093833, 8297.709580164696, 8299.792505187374, 8788.384813063089, 8805.867911981317, 8510.0, 8628.09405012474, 8640.611172497236, 8656.567171641409, 8715.91284087159, 2227.086894373307, 2277.8861056947085, 2286.874221917794, 2292.323764489471, 2295.540891821634, 2166.80498755112, 2191.561687662466, 2209.591225623257, 2213.1147540983575, 2217.81148602369, 2273.0566814771933, 2277.123307526606, 2347.5187586544716, 2355.3875992242056, 2374.548835721216, 2256.311824893407, 2295.426143464134, 2332.650102484624, 2334.0313769785603, 2343.4727186383097, 2223.5886361023263, 2238.0, 2250.5161390301164, 2250.9437264068365, 2257.7290725113094, 8594.054653988056, 8607.0, 8643.049264580892, 8702.738917832476, 8706.042335343107, 5158.587313014988, 5239.1093514102695, 5244.39689435716, 5277.86805329866, 5304.522592966651, 3237.8542965566608, 3293.077938177314, 3382.2220889195623, 3451.6030656474327, 3460.359833430798, 1087.478010554938, 1127.8421021057059, 1139.3562637110006, 1148.0, 1163.2613290560555, 11899.88100119005, 11941.64175074749, 11950.880491195063, 11958.880411195863, 11963.282203067844, 4509.1658043262105, 4550.658700597469, 4656.4877863434995, 4657.301404789241, 4659.0, 10089.394636321844, 10156.035176658206, 10160.898391016142, 10166.135878450266, 10168.28821982454, 5191.143461328914, 5193.506616871391, 5217.295665085165, 5245.213218017251, 5256.185291279858, 4154.875353739392, 4588.632909367243, 4672.32251323563, 4718.764061796896, 4737.905241895142, 3875.3411919973673, 3930.7051971102283, 3961.9009524761536, 4025.2352053109817, 4196.118815048813, 1210.5218438716659, 1285.7235694325766, 1289.2457912121326, 1290.2581015915887, 1311.5344052861287, 955.7467271173006, 957.818014577228, 962.3071388600197, 965.3676841668719, 982.0768477631004, 5761.251037365116, 5770.105633626795, 5789.652620842763, 5800.216970708901, 5868.941310586925, 1002.7443002034435, 1037.5590374090982, 1040.5889673578895, 1047.7799662070897, 1067.7490789664423, 3828.349180639298, 3881.728279020498, 3882.5535063467496, 3899.1811719538646, 3948.1511475033008, 10212.591496340063, 10718.08896243828, 10774.515146818412, 10790.460476976119, 10792.082672972729, 10360.378377297386, 10567.207459440573, 10660.786784264426, 10668.093212077061, 10679.359238445719, 8012.679492820222, 8031.277185053374, 8042.195780421911, 8114.107448180695, 8115.229053239933, 5568.610197286151, 5639.407862174577, 5670.688112153871, 5696.316442026983, 5791.507721843691, 9720.75698107553, 9737.123658870452, 9754.024597540189, 9771.609135634495, 9823.115919567274, 9558.61765529371, 9756.756081098029, 9806.21550275962, 9848.06443387877, 9887.85168222463, 6655.434288085567, 6988.650567471708, 7225.096862892138, 7347.448941329315, 7494.437917156344, 8255.793605159679, 8273.255407013397, 8284.875726863982, 8291.295239904675, 8303.1281715419, 7312.963435183003, 7515.6242187891485, 7587.772366829004, 7597.468177227762, 7709.460337776526, 7359.264073592598, 7374.705011799468, 7383.040204773345, 7436.256374362521, 7450.552966822008, 6604.306547812411, 6647.302033286629, 6655.201375834931, 6660.300668429939, 6687.130673012672, 4823.083614113307, 4864.294677271847, 4958.6281028923695, 5004.899902002013, 5042.647014708935, 5066.6200034998255, 5158.123119069692, 5173.81891633791, 5182.766775495036, 5183.403908550565], "value": 4557.683349931052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.34921205225714, 336.3676288577474, 337.65896444590965, 337.84796841421365, 345.25941854721606, 5405.4324295948945, 5472.972635136819, 5689.402612725661, 5691.345495268046, 5751.137329400592, 5530.917036244459, 5597.552195824334, 5599.888002239953, 5629.198656429944, 5629.662220266777, 4290.914181716364, 4293.742375457467, 4347.108842687241, 4363.170997510479, 4373.4095897053885, 4097.815598298083, 4323.935140972888, 4329.264025115722, 4398.802053907566, 4403.933940990888, 4271.9572804271875, 4272.1028583997395, 4279.068837846085, 4283.479364825489, 4310.224159651277, 4304.5910638489295, 4309.0, 4315.525292217853, 4326.718763280408, 4337.132573485284, 3589.7128229741556, 3803.82882770276, 3806.543214814212, 3809.4095415210686, 3822.6368494993208, 5367.845913128696, 5400.621956463049, 5408.756605952703, 5432.2123292122815, 5442.510174084351, 4905.23968784839, 4914.680545764514, 4932.284818701304, 4934.259861020875, 4946.2580612908, 5522.779088836442, 5829.562782791308, 5831.57126504005, 5844.766209351621, 5850.3564607893095, 4062.6546743526837, 4106.445629839964, 4117.258893399187, 4118.91762164758, 4164.354525048622, 6056.849818314479, 6073.423024812636, 6082.847928801771, 6089.756409743605, 6115.541334399938, 4128.938065929014, 4223.092035212383, 4234.8142520094425, 4236.559569746301, 4241.681873859411, 4287.228298906227, 4293.828246870153, 4308.202982448257, 4318.201132790444, 4320.805563749639, 4759.547842954914, 4853.956399374081, 4903.0, 4924.507549245047, 4986.202207646759, 5815.73829177688, 5844.649321040752, 5846.367085641344, 5926.4666180044005, 5927.555433342431, 1471.6615178509003, 1482.9406823726931, 1483.4437086092714, 1495.4765831958728, 1497.6779992301708, 928.8095940332215, 951.1582249709057, 954.8997355277735, 961.8316794561064, 962.8459446488528, 4993.876377814962, 5052.267421223902, 5068.189089745623, 5135.281060651511, 5199.714015729096, 5364.892702146013, 5372.543333816591, 5373.9731301343245, 5466.398696143421, 5482.588805839578, 4870.975645121752, 4904.966278356831, 5061.746912654353, 5083.966872795905, 5099.209622508517, 2884.298264024236, 2889.8699558519916, 2905.5932169496286, 2908.88364465419, 2935.530315149566, 5506.64206826555, 5544.91682624761, 5551.611387202938, 5575.553955683536, 5578.163275508625, 5429.864253393618, 5693.658380497183, 6181.96909015452, 6192.318844927055, 6199.535034872402, 6282.151909492251, 6288.308286088527, 6293.433590976742, 6321.873562528724, 6325.177726895567, 6027.005544085352, 6107.267127944675, 6159.907601386072, 6174.567780255339, 6177.81466556004, 5871.706414679335, 6044.727987240497, 6048.697565121638, 6067.575269731076, 6103.176071230327, 5688.687122208318, 6212.378762123752, 6221.471174949999, 6304.014235515798, 6317.652529110759, 4229.577042295746, 4243.239055791812, 4268.91462170761, 4273.551277115858, 4273.700840941105, 6095.2685677718955, 6115.969420152871, 6119.265688117454, 6166.845828854135, 6169.722362493609, 5789.45000224978, 5906.881862362815, 5929.466348028698, 5977.491913187428, 5998.910016349845, 5872.442117998783, 5873.2658417697785, 5884.499452639549, 5908.527317814479, 5934.881302373842, 5769.711514424178, 5816.982028145142, 5832.066869300891, 5834.679092649775, 5835.7373918174635, 5596.328440586993, 5939.821805345847, 5957.8084383124415, 5969.432903874125, 5998.550108741774, 5768.278965129359, 5816.680082595498, 5851.239338885917, 5853.268341457318, 5889.911651325147], "value": 4390.514492224131, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.7808974442285, 777.3625626985873, 797.3222760653446, 811.2536466450864, 848.6817443458701, 15200.92399538002, 15269.312880920357, 15419.768703469457, 15731.84268157318, 15749.84250157498, 13923.37344819483, 13937.372818223179, 13971.930140349285, 14039.789403158935, 14063.718725625482, 808.9514629122257, 818.4271010292789, 820.1347578304886, 820.9753707388788, 822.2640736540792, 678.3182901184302, 792.3859009267806, 808.7533302342783, 811.4887620798918, 817.5626040068564, 856.8714692796068, 857.652650676477, 864.4813112132701, 866.4801119328384, 866.5970323799432, 854.1159899504046, 856.9271611912994, 857.3912522109279, 859.1794835931702, 860.1054902900976, 618.832915112917, 619.894617914951, 622.4273668225244, 625.8998560230386, 626.0140279060453, 14289.142651440947, 14325.426982920671, 14377.209253491053, 14378.928105359511, 14391.78412323816, 15559.611009724847, 15608.687826243411, 15660.530184094496, 15757.369705211893, 15858.60353491172, 12382.677588557903, 12416.503339866395, 12459.252444853339, 12777.425015874307, 12834.101612887102, 3827.6937844972335, 3834.0798208430056, 3878.941815872764, 4002.7998600070173, 4027.0939038716347, 74548.99999999946, 75223.0, 77687.22312776913, 78092.60953695195, 78743.99999999943, 11334.886651133384, 11338.773224535464, 12123.515059397701, 12248.632541023784, 12398.690032749253, 23053.654195187086, 23276.41808954756, 23458.413539661644, 23560.175393861133, 23694.644580331307, 8925.419847709878, 8976.551172441352, 9095.135962083592, 9154.130357616015, 9364.0, 4951.900961980812, 5025.422076461181, 5105.897882042413, 5115.1559992600805, 5139.434662187156, 3699.741018128705, 3812.599677033927, 3815.904602384907, 3816.1795214029116, 3825.3305671507374, 628.8082134948885, 630.9936900631027, 632.4150161100963, 645.7223393940557, 652.7128063651978, 662.3078882567728, 680.357062575861, 687.0141347166832, 739.7216572955285, 759.4107369758573, 9879.456629885282, 9901.306908516479, 10116.342437741523, 10119.797604047877, 10352.585896564053, 559.6502186133666, 590.8818236352747, 668.8963210702349, 698.5180225644289, 734.1997223026926, 4702.412198475191, 4810.542998415145, 4872.829450969199, 4886.682365646222, 4907.828226012072, 61716.38283617106, 63082.684586576775, 67521.0, 68157.65921170362, 68220.6588967052, 98089.0, 100459.49770251248, 101904.49047754862, 102197.48901255446, 102257.48871255596, 79411.60294198492, 80617.0, 81071.59464202759, 90150.0, 90660.92025858852, 9966.252531060345, 10370.792584148125, 10579.15366770672, 10663.200259980378, 10697.14422846186, 37840.43239351357, 38138.80930595329, 52142.0, 56998.7150064247, 57094.0, 75657.62171189109, 80639.59680201796, 83637.0, 86350.0, 86782.0, 13469.12450690702, 13573.11774734639, 13664.795028074786, 13795.448182073007, 13826.516071937434, 14764.63088422798, 14918.328675209425, 14946.551603451913, 15008.699826003638, 15021.549353519413, 13714.17714937107, 13886.444542218198, 14150.78773818373, 14254.643633909236, 14609.853901460849, 14515.129092254498, 14661.120332780067, 14965.850341496882, 15108.106764749564, 15181.16503592313, 14027.438902443788, 14169.858301416854, 14360.210188439736, 14508.709825803637, 14608.0, 10792.0, 10799.838002430128, 10909.236353455182, 11101.722456938642, 11650.941745291218, 9569.90430095718, 9941.552630131517, 10060.84908726355, 10277.84583231267, 10409.178393781209], "value": 7590.110413759001, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 112.0, 111.0, 113.0, 111.0, 111.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 161.0, 185.0, 125.0, 162.0, 159.0, 130.0, 189.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 165.0, 171.0, 164.0, 162.0, 162.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 152.0, 76.0, 75.0, 74.0, 76.0, 155.0, 75.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 85.0, 86.0, 86.0, 138.0, 85.0, 85.0, 138.0], "value": 101.9, "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, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 57.0, 59.0, 59.0, 59.0, 58.0, 57.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 86.0, 87.0, 81.0, 81.0, 81.0, 81.0, 102.0, 87.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 129.0, 131.0, 128.0, 120.0, 122.0, 129.0, 128.0, 133.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 167.0, 160.0, 162.0, 168.0, 164.0, 168.0, 169.0, 167.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 64.0, 69.0, 65.0, 65.0, 64.0, 63.0, 62.0], "value": 66.2, "unit": "score"}]}]} 05:17:50 INFO - Return code: 0 05:17:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:50 ERROR - # TBPL SUCCESS # 05:17:50 INFO - Running post-action listener: _resource_record_post_action 05:17:50 INFO - ##### 05:17:50 INFO - ##### Finished run-tests step (success) 05:17:50 INFO - ##### 05:17:50 INFO - Running post-run listener: _resource_record_post_run 05:17:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 507904; Write bytes: 305504256; Read time: 236; Write time: 236360 05:17:50 INFO - TinderboxPrint: CPU usage
13.5% 05:17:50 INFO - TinderboxPrint: I/O read bytes / time
507,904 / 236 05:17:50 INFO - TinderboxPrint: I/O write bytes / time
305,504,256 / 236,360 05:17:50 INFO - TinderboxPrint: CPU idle
8,214.8 (86.5%) 05:17:50 INFO - TinderboxPrint: CPU user
1,226.1 (12.9%) 05:17:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:17:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 17592320; Read time: 0; Write time: 10820 05:17:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 507904; Write bytes: 287911936; Read time: 236; Write time: 225540 05:17:50 INFO - Running post-run listener: _upload_blobber_files 05:17:50 INFO - Blob upload gear active. 05:17:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:55 INFO - (blobuploader) - INFO - Done attempting. 05:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:55 INFO - (blobuploader) - INFO - Done attempting. 05:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:56 INFO - (blobuploader) - INFO - Done attempting. 05:17:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:56 INFO - Return code: 0 05:17:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6650ed00f270f04aceb17faf8ffa09f6b9f3e68fdb11297bb605bcceff3df4a7d84bb8bfe302ea37b05beb8ededcfa1dee1a5d7a0c67ed4a5972f5041005cf5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac749401efc2007d20e590c613e9e7013da158d01a4b755721775b2a0b968f9e1d7deb00a3ed8743efed81c4a6e59a5a3013be8310e74b0045ba82e1d78d482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c7ab0c004b0f03b10da647f2bad6c045ccc7da6c69927f448d090ab58472a1379fcda2618bb0f3332f1419525a131d430f12e25221df9ae6e492c24503bf289"} 05:17:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:56 INFO - Contents: 05:17:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6650ed00f270f04aceb17faf8ffa09f6b9f3e68fdb11297bb605bcceff3df4a7d84bb8bfe302ea37b05beb8ededcfa1dee1a5d7a0c67ed4a5972f5041005cf5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac749401efc2007d20e590c613e9e7013da158d01a4b755721775b2a0b968f9e1d7deb00a3ed8743efed81c4a6e59a5a3013be8310e74b0045ba82e1d78d482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c7ab0c004b0f03b10da647f2bad6c045ccc7da6c69927f448d090ab58472a1379fcda2618bb0f3332f1419525a131d430f12e25221df9ae6e492c24503bf289"} 05:17:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:56 INFO - Copying logs to upload dir... 05:17:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.697261 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 05:17:56.547799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:17:56.550883) ========= 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=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6650ed00f270f04aceb17faf8ffa09f6b9f3e68fdb11297bb605bcceff3df4a7d84bb8bfe302ea37b05beb8ededcfa1dee1a5d7a0c67ed4a5972f5041005cf5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac749401efc2007d20e590c613e9e7013da158d01a4b755721775b2a0b968f9e1d7deb00a3ed8743efed81c4a6e59a5a3013be8310e74b0045ba82e1d78d482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c7ab0c004b0f03b10da647f2bad6c045ccc7da6c69927f448d090ab58472a1379fcda2618bb0f3332f1419525a131d430f12e25221df9ae6e492c24503bf289"} build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6650ed00f270f04aceb17faf8ffa09f6b9f3e68fdb11297bb605bcceff3df4a7d84bb8bfe302ea37b05beb8ededcfa1dee1a5d7a0c67ed4a5972f5041005cf5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac749401efc2007d20e590c613e9e7013da158d01a4b755721775b2a0b968f9e1d7deb00a3ed8743efed81c4a6e59a5a3013be8310e74b0045ba82e1d78d482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c7ab0c004b0f03b10da647f2bad6c045ccc7da6c69927f448d090ab58472a1379fcda2618bb0f3332f1419525a131d430f12e25221df9ae6e492c24503bf289"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:17:56.575300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:17:56.575603) ========= 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=232498196343f89f466a4a9a000001c8-1465039796.301079-151718172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:17:56.660211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:17:56.660618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:17:56.660892) ========= ========= Total master_lag: 0.16 =========