builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1466681782.95 results: success (0) buildid: 20160623013034 builduid: f3f0508f62824bc683344d19d3eba38b revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:22.953706) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:22.954195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:22.954488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:22.968951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:22.969267) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:36:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-23 04:36:26 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.070534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.070886) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016328 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.120892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.121306) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:36:26,887 truncating revision to first 12 chars 2016-06-23 04:36:26,887 Setting DEBUG logging. 2016-06-23 04:36:26,887 attempt 1/10 2016-06-23 04:36:26,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0a73cc327229?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:36:27,271 unpacking tar archive at: mozilla-inbound-0a73cc327229/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.913502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.913843) ========= script_repo_revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.914305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.914613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:36:23.924008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-23 04:36:23.924392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:27 INFO - MultiFileLogger online at 20160623 04:36:27 in /builds/slave/test 04:36:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:36:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:27 INFO - {'append_to_log': False, 04:36:27 INFO - 'base_work_dir': '/builds/slave/test', 04:36:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:36:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:27 INFO - 'branch': 'Mozilla-Inbound', 04:36:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:27 INFO - 'config_files': ('talos/linux_config.py',), 04:36:27 INFO - 'default_actions': ('clobber', 04:36:27 INFO - 'read-buildbot-config', 04:36:27 INFO - 'download-and-extract', 04:36:27 INFO - 'populate-webroot', 04:36:27 INFO - 'create-virtualenv', 04:36:27 INFO - 'install', 04:36:27 INFO - 'run-tests'), 04:36:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:27 INFO - 'download_minidump_stackwalk': True, 04:36:27 INFO - 'download_symbols': 'ondemand', 04:36:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:27 INFO - 'installer_path': 'installer.exe', 04:36:27 INFO - 'log_level': 'info', 04:36:27 INFO - 'log_name': 'talos', 04:36:27 INFO - 'log_to_console': True, 04:36:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:27 INFO - 'opt_config_files': (), 04:36:27 INFO - 'pip_index': False, 04:36:27 INFO - 'sps_profile': False, 04:36:27 INFO - 'sps_profile_interval': 0, 04:36:27 INFO - 'suite': 'dromaeojs', 04:36:27 INFO - 'system_bits': '32', 04:36:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:27 INFO - 'title': 'talos-linux64-ix-059', 04:36:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:27 INFO - 'use_talos_json': True, 04:36:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:27 INFO - 'work_dir': 'build'} 04:36:27 INFO - ##### 04:36:27 INFO - ##### Running clobber step. 04:36:27 INFO - ##### 04:36:27 INFO - Running pre-action listener: _resource_record_pre_action 04:36:27 INFO - Running main action method: clobber 04:36:27 INFO - rmtree: /builds/slave/test/build 04:36:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:28 INFO - Running post-action listener: _resource_record_post_action 04:36:28 INFO - ##### 04:36:28 INFO - ##### Finished clobber step (success) 04:36:28 INFO - ##### 04:36:28 INFO - ##### 04:36:28 INFO - ##### Running read-buildbot-config step. 04:36:28 INFO - ##### 04:36:28 INFO - Running pre-action listener: _resource_record_pre_action 04:36:28 INFO - Running main action method: read_buildbot_config 04:36:28 INFO - Using buildbot properties: 04:36:28 INFO - { 04:36:28 INFO - "project": "", 04:36:28 INFO - "product": "firefox", 04:36:28 INFO - "script_repo_revision": "production", 04:36:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:36:28 INFO - "repository": "", 04:36:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:36:28 INFO - "buildid": "20160623013034", 04:36:28 INFO - "pgo_build": "True", 04:36:28 INFO - "basedir": "/builds/slave/test", 04:36:28 INFO - "buildnumber": 1221, 04:36:28 INFO - "slavename": "talos-linux64-ix-059", 04:36:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:36:28 INFO - "platform": "ubuntu64_hw", 04:36:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:36:28 INFO - "branch": "mozilla-inbound", 04:36:28 INFO - "repo_path": "integration/mozilla-inbound", 04:36:28 INFO - "revision": "0a73cc32722952781b61bad3b69ba5a2fc591621", 04:36:28 INFO - "stage_platform": "linux64-pgo", 04:36:28 INFO - "builduid": "f3f0508f62824bc683344d19d3eba38b", 04:36:28 INFO - "slavebuilddir": "test" 04:36:28 INFO - } 04:36:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:36:28 INFO - Running post-action listener: _resource_record_post_action 04:36:28 INFO - ##### 04:36:28 INFO - ##### Finished read-buildbot-config step (success) 04:36:28 INFO - ##### 04:36:28 INFO - ##### 04:36:28 INFO - ##### Running download-and-extract step. 04:36:28 INFO - ##### 04:36:28 INFO - Running pre-action listener: _resource_record_pre_action 04:36:28 INFO - Running main action method: download_and_extract 04:36:28 INFO - mkdir: /builds/slave/test/build/tests 04:36: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:36:28 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:36:29 INFO - Downloaded 1361 bytes. 04:36:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:36:29 INFO - Using the following test package requirements: 04:36:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:36:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:36:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'jsshell-linux-x86_64.zip'], 04:36:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:36:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:36:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:36:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:36:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:36:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:36:29 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:36:29 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:30 INFO - Downloaded 24270138 bytes. 04:36:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:36:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:36:31 INFO - Return code: 0 04:36:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:36:31 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:36:31 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:32 INFO - Downloaded 24270138 bytes. 04:36:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:36:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:36:34 INFO - Return code: 0 04:36:34 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:36:34 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:36:35 INFO - Downloaded 14405384 bytes. 04:36:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:36:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:36:35 INFO - Return code: 0 04:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:35 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:36:37 INFO - Downloaded 60145882 bytes. 04:36:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:37 INFO - mkdir: /builds/slave/test/properties 04:36:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:37 INFO - Contents: 04:36:37 INFO - build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:37 INFO - Running post-action listener: _resource_record_post_action 04:36:37 INFO - Running post-action listener: set_extra_try_arguments 04:36:37 INFO - ##### 04:36:37 INFO - ##### Finished download-and-extract step (success) 04:36:37 INFO - ##### 04:36:37 INFO - ##### 04:36:37 INFO - ##### Running populate-webroot step. 04:36:37 INFO - ##### 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: populate_webroot 04:36:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:37 INFO - '--tppagecycles', 04:36:37 INFO - '7'], 04:36:37 INFO - 'tests': ['tsvgm']}}, 04:36:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['damp', 'tps']}, 04:36:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'tests': ['damp', 'tps']}, 04:36:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['dromaeo_dom']}, 04:36:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['basic_compositor_video']}, 04:36:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['a11yr', 04:36:37 INFO - 'ts_paint', 04:36:37 INFO - 'tpaint', 04:36:37 INFO - 'sessionrestore', 04:36:37 INFO - 'sessionrestore_no_auto_restore', 04:36:37 INFO - 'tabpaint']}, 04:36:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['tsvgx', 04:36:37 INFO - 'tsvgr_opacity', 04:36:37 INFO - 'tart', 04:36:37 INFO - 'tscrollx', 04:36:37 INFO - 'cart']}, 04:36:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:37 INFO - 'tsvgr_opacity', 04:36:37 INFO - 'tart', 04:36:37 INFO - 'tscrollx', 04:36:37 INFO - 'cart']}, 04:36:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'talos_options': ['--disable-e10s'], 04:36:37 INFO - 'tests': ['tp5o']}, 04:36:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'tests': ['tp5o']}, 04:36:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'talos_options': ['--disable-e10s', 04:36:37 INFO - '--xperf_path', 04:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:37 INFO - 'tests': ['tp5n']}, 04:36:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:37 INFO - 'talos_options': ['--xperf_path', 04:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:37 INFO - 'tests': ['tp5n']}}, 04:36:37 INFO - 'talos.zip': {'path': '', 04:36:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:37 INFO - Running post-action listener: _resource_record_post_action 04:36:37 INFO - ##### 04:36:37 INFO - ##### Finished populate-webroot step (success) 04:36:37 INFO - ##### 04:36:37 INFO - ##### 04:36:37 INFO - ##### Running create-virtualenv step. 04:36:37 INFO - ##### 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: create_virtualenv 04:36:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:37 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:36:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:38 INFO - Using real prefix '/usr' 04:36:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:40 INFO - Installing pip.................done. 04:36:40 INFO - Return code: 0 04:36:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36: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:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36: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', 'pip>=1.5'] in /builds/slave/test/build 04:36: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 pip>=1.5 04:36:40 INFO - Using env: {'DISPLAY': ':0', 04:36:40 INFO - 'HOME': '/home/cltbld', 04:36:40 INFO - 'LANG': 'en_US.UTF-8', 04:36:40 INFO - 'LANGUAGE': 'en_US:en', 04:36:40 INFO - 'LOGNAME': 'cltbld', 04:36:40 INFO - 'MAIL': '/var/mail/cltbld', 04:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:40 INFO - 'MOZ_NO_REMOTE': '1', 04:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:40 INFO - 'NO_EM_RESTART': '1', 04:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:40 INFO - 'PWD': '/builds/slave/test', 04:36:40 INFO - 'SHELL': '/bin/bash', 04:36:40 INFO - 'SHLVL': '1', 04:36:40 INFO - 'TERM': 'linux', 04:36:40 INFO - 'TMOUT': '86400', 04:36:40 INFO - 'USER': 'cltbld', 04:36:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:40 INFO - '_': '/tools/buildbot/bin/python'} 04:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:40 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:36:40 INFO - Cleaning up... 04:36:40 INFO - Return code: 0 04:36:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36: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:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36: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 psutil>=3.1.1 04:36:40 INFO - Using env: {'DISPLAY': ':0', 04:36:40 INFO - 'HOME': '/home/cltbld', 04:36:40 INFO - 'LANG': 'en_US.UTF-8', 04:36:40 INFO - 'LANGUAGE': 'en_US:en', 04:36:40 INFO - 'LOGNAME': 'cltbld', 04:36:40 INFO - 'MAIL': '/var/mail/cltbld', 04:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:40 INFO - 'MOZ_NO_REMOTE': '1', 04:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:40 INFO - 'NO_EM_RESTART': '1', 04:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:40 INFO - 'PWD': '/builds/slave/test', 04:36:40 INFO - 'SHELL': '/bin/bash', 04:36:40 INFO - 'SHLVL': '1', 04:36:40 INFO - 'TERM': 'linux', 04:36:40 INFO - 'TMOUT': '86400', 04:36:40 INFO - 'USER': 'cltbld', 04:36:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:40 INFO - '_': '/tools/buildbot/bin/python'} 04:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:41 INFO - Downloading/unpacking psutil>=3.1.1 04:36: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:36: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:36: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:36: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:36: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:36: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:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:43 INFO - Installing collected packages: psutil 04:36:43 INFO - Running setup.py install for psutil 04:36:43 INFO - building 'psutil._psutil_linux' extension 04:36:43 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:36:43 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:36:43 INFO - building 'psutil._psutil_posix' extension 04:36:43 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:36:43 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:36:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:43 INFO - Successfully installed psutil 04:36:43 INFO - Cleaning up... 04:36:43 INFO - Return code: 0 04:36:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36: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:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36: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 mozsystemmonitor==0.3 04:36:43 INFO - Using env: {'DISPLAY': ':0', 04:36:43 INFO - 'HOME': '/home/cltbld', 04:36:43 INFO - 'LANG': 'en_US.UTF-8', 04:36:43 INFO - 'LANGUAGE': 'en_US:en', 04:36:43 INFO - 'LOGNAME': 'cltbld', 04:36:43 INFO - 'MAIL': '/var/mail/cltbld', 04:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:43 INFO - 'MOZ_NO_REMOTE': '1', 04:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:43 INFO - 'NO_EM_RESTART': '1', 04:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:43 INFO - 'PWD': '/builds/slave/test', 04:36:43 INFO - 'SHELL': '/bin/bash', 04:36:43 INFO - 'SHLVL': '1', 04:36:43 INFO - 'TERM': 'linux', 04:36:43 INFO - 'TMOUT': '86400', 04:36:43 INFO - 'USER': 'cltbld', 04:36:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:43 INFO - '_': '/tools/buildbot/bin/python'} 04:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36: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:36: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:36: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:36: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:36: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:36: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:36:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:45 INFO - Installing collected packages: mozsystemmonitor 04:36:45 INFO - Running setup.py install for mozsystemmonitor 04:36:45 INFO - Successfully installed mozsystemmonitor 04:36:45 INFO - Cleaning up... 04:36:45 INFO - Return code: 0 04:36:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36: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:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:36: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 jsonschema==2.5.1 04:36:45 INFO - Using env: {'DISPLAY': ':0', 04:36:45 INFO - 'HOME': '/home/cltbld', 04:36:45 INFO - 'LANG': 'en_US.UTF-8', 04:36:45 INFO - 'LANGUAGE': 'en_US:en', 04:36:45 INFO - 'LOGNAME': 'cltbld', 04:36:45 INFO - 'MAIL': '/var/mail/cltbld', 04:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:45 INFO - 'MOZ_NO_REMOTE': '1', 04:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:45 INFO - 'NO_EM_RESTART': '1', 04:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:45 INFO - 'PWD': '/builds/slave/test', 04:36:45 INFO - 'SHELL': '/bin/bash', 04:36:45 INFO - 'SHLVL': '1', 04:36:45 INFO - 'TERM': 'linux', 04:36:45 INFO - 'TMOUT': '86400', 04:36:45 INFO - 'USER': 'cltbld', 04:36:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:45 INFO - '_': '/tools/buildbot/bin/python'} 04:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:46 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36: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:36: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:36: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:36: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:36: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:36: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:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:48 INFO - warning: no files found matching '*.txt' 04:36:48 INFO - no previously-included directories found matching 'build' 04:36:48 INFO - no previously-included directories found matching 'dist' 04:36:48 INFO - no previously-included directories found matching '.git*' 04:36:48 INFO - Installing collected packages: jsonschema, functools32 04:36:48 INFO - Running setup.py install for functools32 04:36:48 INFO - warning: no files found matching '*.txt' 04:36:48 INFO - no previously-included directories found matching 'build' 04:36:48 INFO - no previously-included directories found matching 'dist' 04:36:48 INFO - no previously-included directories found matching '.git*' 04:36:48 INFO - Successfully installed jsonschema functools32 04:36:48 INFO - Cleaning up... 04:36:48 INFO - Return code: 0 04:36:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:48 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:48 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:36:48 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:36:48 INFO - Using env: {'DISPLAY': ':0', 04:36:48 INFO - 'HOME': '/home/cltbld', 04:36:48 INFO - 'LANG': 'en_US.UTF-8', 04:36:48 INFO - 'LANGUAGE': 'en_US:en', 04:36:48 INFO - 'LOGNAME': 'cltbld', 04:36:48 INFO - 'MAIL': '/var/mail/cltbld', 04:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:48 INFO - 'MOZ_NO_REMOTE': '1', 04:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:48 INFO - 'NO_EM_RESTART': '1', 04:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:48 INFO - 'PWD': '/builds/slave/test', 04:36:48 INFO - 'SHELL': '/bin/bash', 04:36:48 INFO - 'SHLVL': '1', 04:36:48 INFO - 'TERM': 'linux', 04:36:48 INFO - 'TMOUT': '86400', 04:36:48 INFO - 'USER': 'cltbld', 04:36:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:48 INFO - '_': '/tools/buildbot/bin/python'} 04:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:36: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:36: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:36: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:36: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:36: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:36: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:36:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:51 INFO - Downloading docopt-0.6.1.tar.gz 04:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:51 INFO - Running setup.py install for blobuploader 04:36:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:51 INFO - Running setup.py install for requests 04:36:51 INFO - Running setup.py install for docopt 04:36:51 INFO - Successfully installed blobuploader requests docopt 04:36:51 INFO - Cleaning up... 04:36:51 INFO - Return code: 0 04:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 04:36:51 INFO - 'HOME': '/home/cltbld', 04:36:51 INFO - 'LANG': 'en_US.UTF-8', 04:36:51 INFO - 'LANGUAGE': 'en_US:en', 04:36:51 INFO - 'LOGNAME': 'cltbld', 04:36:51 INFO - 'MAIL': '/var/mail/cltbld', 04:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:51 INFO - 'MOZ_NO_REMOTE': '1', 04:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:51 INFO - 'NO_EM_RESTART': '1', 04:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:51 INFO - 'PWD': '/builds/slave/test', 04:36:51 INFO - 'SHELL': '/bin/bash', 04:36:51 INFO - 'SHLVL': '1', 04:36:51 INFO - 'TERM': 'linux', 04:36:51 INFO - 'TMOUT': '86400', 04:36:51 INFO - 'USER': 'cltbld', 04:36:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:51 INFO - '_': '/tools/buildbot/bin/python'} 04:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:52 INFO - Running setup.py (path:/tmp/pip-iYqhj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:52 INFO - Running setup.py (path:/tmp/pip-YFfQxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 INFO - Running setup.py (path:/tmp/pip-c6RzK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 INFO - Running setup.py (path:/tmp/pip-Y9CU8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:52 INFO - Running setup.py (path:/tmp/pip-vPkR9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 INFO - Running setup.py (path:/tmp/pip-z9oTkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 INFO - Running setup.py (path:/tmp/pip-NtLSGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 INFO - Running setup.py (path:/tmp/pip-zUESTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:52 INFO - Running setup.py (path:/tmp/pip-0JG6qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:52 INFO - Running setup.py (path:/tmp/pip-1E2ge7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:52 INFO - Running setup.py (path:/tmp/pip-zY2k2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:52 INFO - Running setup.py (path:/tmp/pip-caRJv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:52 INFO - Running setup.py (path:/tmp/pip-DC5KLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 INFO - Running setup.py (path:/tmp/pip-9OOXcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 INFO - Running setup.py (path:/tmp/pip-Cpdbgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:53 INFO - Running setup.py (path:/tmp/pip-IMSeT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:53 INFO - Running setup.py (path:/tmp/pip-GS63us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:53 INFO - Running setup.py install for manifestparser 04:36:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:53 INFO - Running setup.py install for mozcrash 04:36:53 INFO - Running setup.py install for mozdebug 04:36:53 INFO - Running setup.py install for mozdevice 04:36:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:53 INFO - Running setup.py install for mozfile 04:36:53 INFO - Running setup.py install for mozhttpd 04:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:53 INFO - Running setup.py install for mozinfo 04:36:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for mozInstall 04:36:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for mozleak 04:36:54 INFO - Running setup.py install for mozlog 04:36:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for moznetwork 04:36:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for mozprocess 04:36:54 INFO - Running setup.py install for mozprofile 04:36:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for mozrunner 04:36:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:54 INFO - Running setup.py install for mozscreenshot 04:36:54 INFO - Running setup.py install for moztest 04:36:55 INFO - Running setup.py install for mozversion 04:36:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:55 INFO - Cleaning up... 04:36:55 INFO - Return code: 0 04:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:55 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:55 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:36:55 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:36:55 INFO - Using env: {'DISPLAY': ':0', 04:36:55 INFO - 'HOME': '/home/cltbld', 04:36:55 INFO - 'LANG': 'en_US.UTF-8', 04:36:55 INFO - 'LANGUAGE': 'en_US:en', 04:36:55 INFO - 'LOGNAME': 'cltbld', 04:36:55 INFO - 'MAIL': '/var/mail/cltbld', 04:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:55 INFO - 'MOZ_NO_REMOTE': '1', 04:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:55 INFO - 'NO_EM_RESTART': '1', 04:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:55 INFO - 'PWD': '/builds/slave/test', 04:36:55 INFO - 'SHELL': '/bin/bash', 04:36:55 INFO - 'SHLVL': '1', 04:36:55 INFO - 'TERM': 'linux', 04:36:55 INFO - 'TMOUT': '86400', 04:36:55 INFO - 'USER': 'cltbld', 04:36:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:55 INFO - '_': '/tools/buildbot/bin/python'} 04:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:55 INFO - Running setup.py (path:/tmp/pip-mzMmLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:55 INFO - Running setup.py (path:/tmp/pip-7la7Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:55 INFO - Running setup.py (path:/tmp/pip-y0OwTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:55 INFO - Running setup.py (path:/tmp/pip-nuU5Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:55 INFO - Running setup.py (path:/tmp/pip-z4Zowp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:55 INFO - Running setup.py (path:/tmp/pip-RmLdD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:55 INFO - Running setup.py (path:/tmp/pip-G1w9Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:55 INFO - Running setup.py (path:/tmp/pip-k1dpYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:55 INFO - Running setup.py (path:/tmp/pip-k1CFMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:56 INFO - Running setup.py (path:/tmp/pip-9WjwFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:56 INFO - Running setup.py (path:/tmp/pip-DjbRJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:56 INFO - Running setup.py (path:/tmp/pip-XGgRFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:56 INFO - Running setup.py (path:/tmp/pip-JD0iUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:56 INFO - Running setup.py (path:/tmp/pip-BD6iTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:56 INFO - Running setup.py (path:/tmp/pip-CzG2u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:56 INFO - Running setup.py (path:/tmp/pip-IJET0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:56 INFO - Running setup.py (path:/tmp/pip-EJzDHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:56 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:36:56 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:36:56 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:36:56 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:36:56 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:36:56 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:36:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36: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:36: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:36: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:36: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:36: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:36: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:36:58 INFO - Downloading blessings-1.6.tar.gz 04:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:58 INFO - Installing collected packages: blessings 04:36:58 INFO - Running setup.py install for blessings 04:36:58 INFO - Successfully installed blessings 04:36:58 INFO - Cleaning up... 04:36:58 INFO - Return code: 0 04:36:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:58 INFO - Reading from file tmpfile_stdout 04:36:58 INFO - Current package versions: 04:36:58 INFO - argparse == 1.2.1 04:36:58 INFO - blessings == 1.6 04:36:58 INFO - blobuploader == 1.2.4 04:36:58 INFO - docopt == 0.6.1 04:36:58 INFO - functools32 == 3.2.3-2 04:36:58 INFO - jsonschema == 2.5.1 04:36:58 INFO - manifestparser == 1.1 04:36:58 INFO - mozInstall == 1.12 04:36:58 INFO - mozcrash == 0.17 04:36:58 INFO - mozdebug == 0.1 04:36:58 INFO - mozdevice == 0.48 04:36:58 INFO - mozfile == 1.2 04:36:58 INFO - mozhttpd == 0.7 04:36:58 INFO - mozinfo == 0.9 04:36:58 INFO - mozleak == 0.1 04:36:58 INFO - mozlog == 3.2 04:36:58 INFO - moznetwork == 0.27 04:36:58 INFO - mozprocess == 0.22 04:36:58 INFO - mozprofile == 0.28 04:36:58 INFO - mozrunner == 6.11 04:36:58 INFO - mozscreenshot == 0.1 04:36:58 INFO - mozsystemmonitor == 0.3 04:36:58 INFO - moztest == 0.7 04:36:58 INFO - mozversion == 1.4 04:36:58 INFO - psutil == 3.1.1 04:36:58 INFO - requests == 1.2.3 04:36:58 INFO - wsgiref == 0.1.2 04:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 04:36:58 INFO - 'HOME': '/home/cltbld', 04:36:58 INFO - 'LANG': 'en_US.UTF-8', 04:36:58 INFO - 'LANGUAGE': 'en_US:en', 04:36:58 INFO - 'LOGNAME': 'cltbld', 04:36:58 INFO - 'MAIL': '/var/mail/cltbld', 04:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:58 INFO - 'MOZ_NO_REMOTE': '1', 04:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:58 INFO - 'NO_EM_RESTART': '1', 04:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:58 INFO - 'PWD': '/builds/slave/test', 04:36:58 INFO - 'SHELL': '/bin/bash', 04:36:58 INFO - 'SHLVL': '1', 04:36:58 INFO - 'TERM': 'linux', 04:36:58 INFO - 'TMOUT': '86400', 04:36:58 INFO - 'USER': 'cltbld', 04:36:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:58 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 INFO - Cleaning up... 04:36:59 INFO - Return code: 0 04:36:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:59 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:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 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:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:59 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:36:59 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:36:59 INFO - Using env: {'DISPLAY': ':0', 04:36:59 INFO - 'HOME': '/home/cltbld', 04:36:59 INFO - 'LANG': 'en_US.UTF-8', 04:36:59 INFO - 'LANGUAGE': 'en_US:en', 04:36:59 INFO - 'LOGNAME': 'cltbld', 04:36:59 INFO - 'MAIL': '/var/mail/cltbld', 04:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:59 INFO - 'MOZ_NO_REMOTE': '1', 04:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:59 INFO - 'NO_EM_RESTART': '1', 04:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:59 INFO - 'PWD': '/builds/slave/test', 04:36:59 INFO - 'SHELL': '/bin/bash', 04:36:59 INFO - 'SHLVL': '1', 04:36:59 INFO - 'TERM': 'linux', 04:36:59 INFO - 'TMOUT': '86400', 04:36:59 INFO - 'USER': 'cltbld', 04:36:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:59 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:59 INFO - Cleaning up... 04:36:59 INFO - Return code: 0 04:36:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:36:59 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:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 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:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 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 0x7f9e43a13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', '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:36:59 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:36:59 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:36:59 INFO - Using env: {'DISPLAY': ':0', 04:36:59 INFO - 'HOME': '/home/cltbld', 04:36:59 INFO - 'LANG': 'en_US.UTF-8', 04:36:59 INFO - 'LANGUAGE': 'en_US:en', 04:36:59 INFO - 'LOGNAME': 'cltbld', 04:36:59 INFO - 'MAIL': '/var/mail/cltbld', 04:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:59 INFO - 'MOZ_NO_REMOTE': '1', 04:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:59 INFO - 'NO_EM_RESTART': '1', 04:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:59 INFO - 'PWD': '/builds/slave/test', 04:36:59 INFO - 'SHELL': '/bin/bash', 04:36:59 INFO - 'SHLVL': '1', 04:36:59 INFO - 'TERM': 'linux', 04:36:59 INFO - 'TMOUT': '86400', 04:36:59 INFO - 'USER': 'cltbld', 04:36:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:59 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 INFO - Downloading/unpacking flake8 04:36: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:36: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:36: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:36: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:36: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:36: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:37:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:37:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:37:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:37:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:02 INFO - no previously-included directories found matching 'docs/_build' 04:37:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:37:02 INFO - Running setup.py install for pep8 04:37:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:02 INFO - no previously-included directories found matching 'docs/_build' 04:37:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:37:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:37:02 INFO - Cleaning up... 04:37:02 INFO - Return code: 0 04:37:02 INFO - Running post-action listener: _resource_record_post_action 04:37:02 INFO - Running post-action listener: _start_resource_monitoring 04:37:02 INFO - Starting resource monitoring. 04:37:02 INFO - ##### 04:37:02 INFO - ##### Finished create-virtualenv step (success) 04:37:02 INFO - ##### 04:37:02 INFO - ##### 04:37:02 INFO - ##### Running install step. 04:37:02 INFO - ##### 04:37:02 INFO - Running pre-action listener: _resource_record_pre_action 04:37:02 INFO - Running main action method: install 04:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:02 INFO - Reading from file tmpfile_stdout 04:37:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:02 INFO - Reading from file tmpfile_stdout 04:37:02 INFO - Output received: 04:37:02 INFO - Usage: mozinstall [options] installer 04:37:02 INFO - Options: 04:37:02 INFO - -h, --help show this help message and exit 04:37:02 INFO - -d DEST, --destination=DEST 04:37:02 INFO - Directory to install application into. [default: 04:37:02 INFO - "/builds/slave/test"] 04:37:02 INFO - --app=APP Application being installed. [default: firefox] 04:37:02 INFO - mkdir: /builds/slave/test/build/application 04:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:37:19 INFO - Reading from file tmpfile_stdout 04:37:19 INFO - Output received: 04:37:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:19 INFO - Running post-action listener: _resource_record_post_action 04:37:19 INFO - ##### 04:37:19 INFO - ##### Finished install step (success) 04:37:19 INFO - ##### 04:37:19 INFO - ##### 04:37:19 INFO - ##### Running run-tests step. 04:37:19 INFO - ##### 04:37:19 INFO - Running pre-action listener: _resource_record_pre_action 04:37:19 INFO - Running main action method: run_tests 04:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:19 INFO - Python 2.7.3 04:37:19 INFO - Return code: 0 04:37:19 INFO - grabbing minidump binary from tooltool 04:37: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:37:19 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 0x1f8c1c0>, '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 0x1f8d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:19 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:37:19 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:37:19 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:37:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:19 INFO - Return code: 0 04:37:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:37:20 INFO - Return code: 0 04:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:20 INFO - Using env: {'DISPLAY': ':0', 04:37:20 INFO - 'HOME': '/home/cltbld', 04:37:20 INFO - 'LANG': 'en_US.UTF-8', 04:37:20 INFO - 'LANGUAGE': 'en_US:en', 04:37:20 INFO - 'LOGNAME': 'cltbld', 04:37:20 INFO - 'MAIL': '/var/mail/cltbld', 04:37:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:20 INFO - 'MOZ_NO_REMOTE': '1', 04:37:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:20 INFO - 'NO_EM_RESTART': '1', 04:37:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:20 INFO - 'PWD': '/builds/slave/test', 04:37:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:20 INFO - 'SHELL': '/bin/bash', 04:37:20 INFO - 'SHLVL': '1', 04:37:20 INFO - 'TERM': 'linux', 04:37:20 INFO - 'TMOUT': '86400', 04:37:20 INFO - 'USER': 'cltbld', 04:37:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582', 04:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:20 INFO - '_': '/tools/buildbot/bin/python'} 04:37:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:21 INFO - mozversion application_buildid: 20160623013034 04:37:21 INFO - mozversion application_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:37:21 INFO - mozversion application_display_name: Nightly 04:37:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:21 INFO - mozversion application_name: Firefox 04:37:21 INFO - mozversion application_remotingname: firefox 04:37:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:37:21 INFO - mozversion application_vendor: Mozilla 04:37:21 INFO - mozversion application_version: 50.0a1 04:37:21 INFO - mozversion platform_buildid: 20160623013034 04:37:21 INFO - mozversion platform_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:37:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:37:21 INFO - mozversion platform_version: 50.0a1 04:37:21 INFO - using testdate: 1466681841 04:37:21 INFO - actual date: 1466681841 04:37:21 INFO - starting webserver on 'localhost:53452' 04:37:21 INFO - SUITE-START | Running 2 tests 04:37:21 INFO - TEST-START | dromaeo_css 04:37:21 INFO - operating with platform_type : linux_ 04:37:21 INFO - Initialising browser for dromaeo_css test... 04:37:21 INFO - TEST-INFO | started process 30213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_Rup_/profile http://localhost:53452/getInfo.html) 04:37:24 INFO - PROCESS | 30213 | __metrics Screen width/height:1600/1200 04:37:24 INFO - PROCESS | 30213 | colorDepth:24 04:37:24 INFO - PROCESS | 30213 | Browser inner width/height: 1024/697 04:37:24 INFO - PROCESS | 30213 | __metrics 04:37:25 INFO - PROCESS | 30213 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:26 INFO - TEST-INFO | 30213: exit 0 04:37:26 INFO - Browser initialized. 04:37:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:26 INFO - TEST-INFO | started process 30295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_Rup_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:38 INFO - PROCESS | 30295 | RSS: Main: 174108672 04:37:38 INFO - PROCESS | 30295 | 04:38:30 INFO - PROCESS | 30295 | 1466681910173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:40:37 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53452/tests/dromaeo/cssquery-ext.html) 04:40:38 INFO - PROCESS | 30295 | RSS: Main: 281075712 04:40:38 INFO - PROCESS | 30295 | 04:43:41 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-ext.html (next: http://localhost:53452/tests/dromaeo/cssquery-jquery.html) 04:43:41 INFO - PROCESS | 30295 | RSS: Main: 256987136 04:43:41 INFO - PROCESS | 30295 | 04:46:43 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53452/tests/dromaeo/cssquery-mootools.html) 04:46:44 INFO - PROCESS | 30295 | RSS: Main: 259923968 04:46:44 INFO - PROCESS | 30295 | 04:49:46 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53452/tests/dromaeo/cssquery-prototype.html) 04:49:47 INFO - PROCESS | 30295 | RSS: Main: 258031616 04:49:47 INFO - PROCESS | 30295 | 04:52:49 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53452/tests/dromaeo/cssquery-yui.html) 04:52:50 INFO - PROCESS | 30295 | RSS: Main: 243654656 04:52:50 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-yui.html (next: http://localhost:53452/tests/dromaeo/cssquery-dojo.html) 04:55:53 INFO - PROCESS | 30295 | RSS: Main: 304914432 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | __start_tp_report 04:55:53 INFO - PROCESS | 30295 | _x_x_mozilla_page_load 04:55:53 INFO - PROCESS | 30295 | _x_x_mozilla_page_load_details 04:55:53 INFO - PROCESS | 30295 | |i|pagename|runs| 04:55:53 INFO - PROCESS | 30295 | |0;dojo.html;3072.078376487054;3085.72228499435;3107.0678796361094;3113.4240165569386;3153.621565412151;5206.661566998143;5247.92128118078;5298.046351656701;5307.177387504933;5387.542058924992;5327.840164795062;5328.786848526054;5341.385740639827;5353.705546194958;5374.355077390718;4781.617470602361;4855.5387238212315;4873.8781530461665;4892.9510704892855;5010.498950104979;4918.778654960517;4928.926066109011;4945.876353091184;4969.055879382906;4976.876680618832;4738.384010078685;4818.469968303484;4844.224924012176;4852.975735121302;4867.634927380461;4864.586510146642;4927.334809800667;4929.359183306183;4935.0376676548085;4968.180250258703;4696.365990591295;4815.253635686474;4886.9511304886855;4889.75551222441;4934.605231581465;5346.091164502044;5363.490468405495;5393;5403.891922161535;5415.323084614423;5784.1034639630925;5789.594728369016;5814;5816.88366232673;5838.328592211908;5567.192757050246;5658.236138121342;5692.402297758717;5769.076947688392;5807.070868660994;5388.1648344506275;5438.265834112423;5442.863928401782;5443.292371991655;5443.918341224845;5902.645841249453;5915.37888521699;5918.171455996164;5918.704064796743;5919.052951527735;5506.394296627368;5567.582431317667;5621.156826476062;5637.774489020393;5647.124695672177;5704.543636509153;5733.197352370671;5747.08046712524;5758.712064396847;5760.481556659837;5716.714164291852;5730.713464326767;5736.569757268138;5740.885182296331;5743.885122297531;5516.558675305966;5679.176519404663;5718;5734.369219385864;5786.07422812348;4432.711873728197;4439.955600443955;4448.955510444919;4450.443694538183;4484.551544845489;3907;3916.099297161669;3964.444977703124;3980.20395920817;4010.47863777707;5388.407275199725;5421.756020979065;5422.48486393792;5444.8366549003595;5473.781048758085;5780.104083867007;5805.622634528827;5810.738516766755;5811.854703632358;5858.794942177004;5220.738963051908;5377.704226267593;5453.400125986138;5458.972705136528;5464.153056276284;4968.90062198754;5026.899462010812;5029.84910452687;5040.042391945519;5078.796848126033;5988.9401105989255;5990.6705131218205;5990.820275391745;6002.759889604367;6004;5522.06124958766;5595.07681232592;5639.041362968223;5779.826605201851;5797.9420205797405;5857.092150716646;5861.0915308127305;5870.706464676835;5877.4122587740885;5904.498117660047;5553.666779993213;5575.470330318613;5584.972075139761;5585.609007369445;5599.272094627672;5509.5041446270025;5556.083246264321;5565.916511252415;5605.5515558756015;5690.3456102548735;5507.972460137834;5509.47659972302;5515.944840551703;5520.199571062093;5542.168674698827;5437.211604317273;5493.148561972901;5507.807226747044;5511.972440137773;5568.777248909998;5322.042032434199;5384.111621582395;5442.510174084351;5485.725713714219;5527.834164975057;5640.605157638925;5688.857778555569;5697.259356283656;5697.4587414195585;5699.9145012825675;5375.892482150413;5532.585056120726;5535.944640553704;5539.944600554104;5547.44525547442 04:55:53 INFO - PROCESS | 30295 | |1;ext.html;583.9328477225117;624.6002558362649;628.7139351595023;629.0815409502127;640.1773720768813;29471;41435.79282103593;42552.148957020916;42659.78670106653;42712.942270484295;44464.55535444645;44931.32603010957;44997;45049.32426013613;45061.324080138824;8838.248748856355;8968.865467018;8987.820243595124;8992.8651070234;8997.370184087084;8817.16236957488;8908.109189081104;8914.821703565956;8920.197182253629;8924.776880578005;8954.14935581122;8988.415752976036;8990.28077753778;8991.100889911022;8997.775055623597;8876.423032502898;8878.778030549289;8882.06738292483;8884.200421962023;8884.600192991331;8777.517236551987;8783.253423459013;8825.161609647073;8909.777255568597;8912.55437228136;42786.57213427888;43063.78468107671;43170.784146079066;43200;43214.567854321365;3777.490038844748;3792.886213413602;3825.9043523911846;4191.895202619929;4342.544032876534;32137.357252855047;32750.672493275;33431.33137337264;33450.665493345245;34098.249192588795;3945.704072194597;4006.5192176938663;4022.9195416091807;4045.9190816183805;4071.5521292657786;361810;362072.1896390527;363485.9999999974;364872;364912;55692;56104;56153.71923140358;56313.71843140758;56442.7177864108;58350;58990.41009589849;59051.40948590545;59059.70470147708;59098.11352829711;12695.746085078246;14743.336549855283;14976.850231497545;15055.171965542;15105.622359441102;11767.470463829148;11791.29252244868;11865.288082715064;11893.762124757457;11916.821247681119;16029.278682459317;16046.919765401099;16090.712742980768;16100.355985760438;16193.757093643604;5194.740262986836;6268.811935641938;6436.613803171825;6449.613023218528;6612.801615951529;982.3761911186448;988.9208863290919;1068;1068.278911734576;1075.725689949058;31858;31990.520142197885;32119.678803212137;32451;32789.83605081959;1073.9409332486632;1088.8747794003632;1093.8632670916136;1123.6966019174777;1141.2923987127867;16668.166591670368;17117.22972466242;17130.571735706708;17255.99152491552;17299.56751081233;535933;536802;540785;540793;540805;57987.71006144942;58275.41724582785;58283;58311.416885831444;58318.7084064577;1229.170310040719;1324.715186234945;1328.4221363706818;1354.878060974517;1370.8286464191976;32231.677683222868;33023.50464743079;33325.66674333226;33478.66521334756;33489;50140.247896282315;51138.488615113376;51210.48789512206;51327.230091547906;51354.22968655398;328244;329647;330180;330930;330952;33766;34198.46106925145;39537.60462395454;40767.1846563073;44359.33460998023;44311.55688443074;44609.33086003777;44719;45435.31847022363;45744.54255457403;40527;40722.59277407306;40735.59264407318;41022.79488602538;41618.375724363555;39879.601203987586;40099.1980160401;41185.79407102945;41258.38112428376;41642.58357416508;40201.1959760809;41065.79467102765;41142;41450;41513.37729934114;33466.49800253047;35463.29073418466;35845;35932.820335898155;36236.81881590575;26808.451514940876;27259.318517037234;27325.86337068302;27432.314192144557;27566.5865012029 04:55:53 INFO - PROCESS | 30295 | |2;jquery.html;377.1857366069207;384.64036126221987;388.25842640556533;393.3391901605302;405.27455854021304;17903.731444028333;19308.13113409898;19671.606567868635;19800.900995495038;20232.39302820914;19129.139188736506;19151.616967660637;19349.709754353695;19403.514912127204;19628.9018554907;5528.723563821803;5548.944510554883;5913.14259432382;5922.6150300230565;5964.254468191454;5820.82537523875;5856.795012174574;5870.26621672291;5884.646921184722;5892.204552385416;5573.972130139344;5828.3297420796725;5842.32813226478;5868.09044598088;5875.471207591316;5932.644041357532;5937.1984782054515;5938.376470470582;5951;5988.401159884021;5598.86002849932;5793.884122317572;5838.64968101911;5847.736851841677;5854.824355269348;12878.162919410302;13262.403191856389;15783.842161578466;23418.297451076494;23495.295141145794;2362.6219804831144;2480.0947654106303;2760.3789147441867;2991.760659147263;3012.322227498817;9729.859191473652;9898.752531186707;10913;11786.292822430596;13963;1955.5502234486005;2011.9497012574657;2027.1992562937558;2029.9695504567444;2057.1360028787944;77364.22635773626;78280;79274.60362698208;81192.18807811964;83092.58453707754;10621.150307975344;10826.242163048668;10903.29128606638;11059.281146725438;11189.832152517718;15033.098014119189;15109.47116850927;15146.469873554594;15309.46416875404;15324.157171355682;7180.31786980236;7467.365273951775;7558.886616700754;7691.961540192375;7727.729529466442;7155.529568159439;7232.92767072333;7379.741709040158;7388.519746216479;7414.184439711627;4647.16351056813;4753.6910100844025;4756.673297900791;4762.4285085789925;4821.831235906727;1913.3781521005728;1933.3136736458355;1982.8810271383763;1983.365323096624;1994.890281034528;962.0908241711516;985.8964808695127;987.2940847294219;1009.485162567096;1048.4076496779448;19060.332888348843;19439.708404373945;19778.90110549438;19965.101570429364;20026.599468010558;984.8965858584745;1006.9748256293651;1011.2971484817981;1039.4594810698395;1055.3193190392153;10242.641507547349;11022.944885275683;11063.280886742497;11082.501287442085;11108.500117494732;508266;512253;512610.69431454636;513826;516320;53428.46571534235;59291;61589.692051540354;90156;95983.68073436712;977.506359288569;997.0926456924019;1028.4395004722444;1073.6188653028062;1077.1329080090445;12425.31660758667;16742.916285418494;17205.39781107705;18218;18502.352417665854;31276.241385844616;34236.14409639779;41540;42086.78956605197;43134;55027.449725502236;55510;56017.719911400185;57976;58059.4194058054;5484.670919744828;7478.738244161428;7516.774496765106;7586.81032974158;8304.294134998592;11213.943930280297;12564.120511564468;12942.41759120823;13003.804942926054;13254.867451325363;10584.947075264574;10728.356298622108;11120.332780033224;11224.94387528057;11236.606718764804;10561.89438105609;10628.468576570986;10649.680509584725;10670.413127278074;10690.41202733857;10380.584776609154;10628.734281643021;10871.456427178768;10913.781724365626;10937.639308534539;8394.160583941557;8589.742307730778;8590.312774977861;8720.65117395297;8732.825343493221;10390.636327728493;10735.248532602644;10826;10989.505472253608;11018.39398833072 04:55:53 INFO - PROCESS | 30295 | |3;mootools.html;1286.7297867447835;1451.3033743802978;1487.4347747855816;1557.8364271751466;1758.577941294089;8026.357891368683;8397.202265784748;8418.663253469862;8595.828083438328;8613.698520551781;8341.791455213608;8552.615132319044;8555.61499732512;8559.315254779618;8567.571621418936;2037.3073155127254;2265;2347.542229265294;2366.0299277296313;2393.0547433763654;2322.500662357593;2369.857808531485;2371.3597328721235;2376.013954209001;2381.226101517005;2329.4875127472014;2356;2380.0122948976154;2381.1070848431837;2381.678473406094;1987.224982256921;2204.7795220477983;2279.931602051941;2284.7486776454575;2287.4167087392775;2315.7684231576877;2317.0268487235403;2338.5556744218543;2338.8128949683983;2339.5320935812906;8326.45878017927;8382.245597896219;8393.580320983927;8470.745877623682;8531.360147988926;4696.436427628672;4851.223804191312;4852.102361063215;4855.805767769285;4857.198562237262;3123.0786917859286;3214.437473442138;3261;3276.541284220211;3330.58367704037;1092.6667366453307;1121.0695123047933;1135.73310272086;1138.8576427946507;1146.266389510714;11665.241759285704;11934.343611101385;11970.82043769344;11971.880281197251;11996.340201288838;4499.730016199039;4655.3947986761505;4701.083288758728;4738.976305118521;4760.238361862085;10013.49932503372;10027.949860250652;10057.748556286151;10058.698239052694;10061.4466204358;4863.148948933923;4876.634252431082;4880.072786170616;4884;4885;3863.517060367454;4257.148570285955;4396.604305612446;4399.978000110043;4466.932996005063;3914.8042597869994;3947.3684210526176;4000.4199391088127;4023.8390464381096;4077.55146933837;1248.89384402325;1260.2627462934104;1270.707737220426;1273.6242808371553;1283.3390803736083;829.8340331933638;953.7615596100975;975.7607838045642;979.7256768104942;988.7330420786491;5841.299044114733;5943.494802941712;5992.280926288873;6005.3694362091355;6110.908336374958;447.085709723616;447.5502120369008;456.33375272103103;457.9175748365326;473.4082397003745;4036.3509956795715;4115.54728979812;4125.133721918371;4160.105577300835;4231.280682284019;10445.9477702611;10581.206409519316;10641.574337026432;10722.571097156026;10735;10451.84322235167;10458.633947811943;10467.685969420929;10525.368477891197;10557.736056598647;7462.067241594801;7748.728794492165;7754.263344982105;8007.359411247203;8115.959420202861;5979.820605381846;6095.969520152371;6187.81436556904;6215.036669316263;6251.249850018027;9786.902130978884;9857.35927164732;9961.900380996098;10102.09081182697;10108.898911010796;9836.754081148028;9870.259730520096;10128.949355253177;10134.746631334276;10245.74385640365;6810.829729256809;7502.249775022454;7716.729914452967;7753.961230193813;7790.14308426084;8395.580220988804;8423.578821059045;8461.153884611736;8511.36164787631;8515.701950431952;7506.024216851774;7647;7733.419993500397;7772.45592808498;7801.414893882868;7423.517471364344;7459.738909138154;7510.136334321623;7661.118971318369;7668.348190403878;6900.758473453405;6924.030635711105;6958.304169583002;6965;6966.233714291323;5046.873828154326;5101.821436249714;5171.431142574389;5221.321228240305;5262.394824595068;5055.772490237875;5183.300254465599;5208.244804503402;5292.629515933848;5366.838994830161 04:55:53 INFO - PROCESS | 30295 | |4;prototype.html;320.78507400041957;328.4744408945687;331.8125259228537;336.2182924700072;336.2887492952406;5230.686158830473;5248.816291429801;5303.9734801325985;5326.840194794162;5327.893442131155;5222.9477705222935;5240.528352448288;5260;5284.8150314739;5285.867853303669;4120.340745480717;4155.148194620111;4156.750594964296;4159.9376009359885;4209.431726716884;4153.356229784373;4181.3309870420735;4216.093539888923;4219.409282700424;4231.555686652903;4119.196756632457;4162.4796900387455;4164.646005089571;4166.166766646667;4183.288840897055;4073.490813648294;4152.211079894811;4153.460050193456;4165.604267594574;4173.499180098393;3656.7018708358682;3692.8707495237804;3710.9775172530767;3714.7771133731794;3722.236941427001;5125.974370128163;5139.306193663845;5142.897142057138;5152.845414637567;5188.221766734982;4695.741734204617;4711.905761884777;4726;4727.881802954954;4761.381020467352;5179.300794392784;5489.313835770528;5501.202325662796;5506.311711036121;5516.531094856942;4014.959850401488;4044.312466880637;4044.6157615026527;4061.817218225187;4071.6131967463043;5381.300430943991;5430.484104010113;5649.096144616841;5716.114002329646;5755.165501002373;4060.7360521566;4068.532118806316;4102.897427564335;4105.91788164235;4112.362583799516;4138.441310423114;4152.896177595584;4155.439015732898;4165.66674666026;4174.269502836992;4365.978170109129;4546.386237857913;4674.836380726658;4697.976510117427;4720.386349774576;5468.535174510212;5474.589405794582;5474.671519708831;5481.890362192734;5504.366997795225;1421.6090575091725;1442.4662874736414;1443.3577058209205;1444.111871199226;1445.978310325346;898.1826537850525;939.4081728510994;946.7301818981695;951.9524023798921;967.9951600241953;4697.530246975343;4710.3405523226775;4729.7398643074275;4759.857204283877;4802.615790736802;4995.500449954975;5001.474550262133;5030.547250747451;5032.899342013213;5079.466656001066;4509.840837666003;4548.727076375428;4741.691790033706;4761.833335833298;4803;2669.546177149889;2676.4914666213745;2688.7445692659167;2715.307596562903;2724.768394686434;5203.762382175625;5240.606954478353;5243.23973023917;5269.262303277545;5290.682559046392;4942.728149951788;4989.55094041538;5158.252053452228;5187.221916712523;5204.73976301191;5017.9247311290355;5042.369703787027;5056.418511871182;5172.086328058643;5189.377274727057;4866.270059491105;4938.358013458227;4942.777575009061;4943.8516844494725;4994.5754610858485;4586.977065114653;4909.9018019640125;4917.803287868445;4933.840547471413;4972.428170760264;5530.5022547970875;5707.571932105026;5798.1302804579655;5915.733791979457;5919.868847215085;4168.374743788335;4170.124273902515;4190.413342132165;4199.517055538652;4205.873823785291;5553.278483670075;5568.582356323373;5697.116946873241;5724.942750572608;5727.70891643346;5457.372402173801;5519.806806761744;5545.390007099297;5557.916631250454;5563.916541251803;5407.864803379947;5450.672959622435;5462.3445186577865;5467.398586155599;5513.7794488221625;5158.535731784157;5393.244945707683;5395.163749618815;5419.593530485151;5433.130699088127;5437.972810136082;5492.5331346835965;5518.696471694096;5529.612927095065;5540.889182216414;5375.919361209507;5387.515123638891;5396.973015135056;5407.945920540901;5431.750697339713 04:55:53 INFO - PROCESS | 30295 | |5;yui.html;720.9243029481905;773.8297574533605;790.6995341770127;832.4589017138862;850.3664769746538;13502.932485337571;14111.223882686449;14153.929230353846;14159.433622655095;14203.573892783234;14734.557963261093;14886.330115144818;14912.478063267788;14933.40266389346;14960.850391496082;673.9292374300701;785.352084530262;789.6328207383551;803.1927912448011;806.592670701295;784.7959530522048;793.218679600593;795.4988357334871;795.8885755994165;796.358931060496;850.1031411860484;853.5305581929945;854.9273311768476;856.1053698884649;856.6059612578222;702.9543079699829;819.336337566573;849.1381248033251;854.7606670132373;856.2422256303216;622.0047923322693;622.4460230394952;626.1077963901467;626.3048016701458;626.3955283151735;13783.51757688476;13784.172949623055;13826.93086534571;13830.308484575731;13853.792193117111;13917.443302267897;14036.438542458289;14088.225147616877;14123.223222722747;14430.20633865137;12307.753844923142;12393.318367489785;12528.373581320897;12682.80975785364;12756.425960831784;4169.728967617095;4188.853390131361;4203.47456567929;4228.302330115527;4425.159219748238;73982.26017739807;74777.62611186964;74958;74988.62505687491;75065.62467187628;10977.780444391068;11269.94365028186;11313.773724525628;11456.656300311004;11716.589919352782;20142.69785953212;20150.899245503973;20155.697664535044;20219;20222.292219772236;8285.58572071394;8311.210435008785;8322.583870806557;8334.916650833535;8743.125687431206;4791;4851.660383773102;4871.34236878017;4996.800127994912;5012.423571289275;3023.591815104977;3117.0804612639326;3124.8281344525813;3133.5769671094113;3135.0438116374726;488.0775334617576;566.6571724106939;573.4179807495395;590.0352922970974;592.762894842058;594.7888499582673;694.9270326615733;718.3104219948804;754.3550264523753;776.8936161768495;9111.635534578543;9394.765130871783;9566.091221333962;9877.308588398742;9929.80140397188;710.1166832790308;712.4300559552337;719.1801346465035;758.624480881956;764.2777575191391;4391.824327026947;4888.120138375127;5119.820806271762;5143.794248230104;5410.296661433988;116102.41948790202;116826;118182.40908795402;118278;118673;65494;65622.34377656257;73172;94260;103263;94228.0577194233;94483;94822.52588737012;95106;95832;9516.857247141437;10039.69880903574;10049.296549241482;10150.644727434505;10169.949150254497;50759.23861142012;52252.73873630608;52656;52954;53757.73121134369;73933.63033184799;83930;84969.02608408676;85025;85211;13246.47014119463;13466.394012269275;13618.114822536503;13789.176046469192;14143.787843182567;16080;16247.67504649924;16260.756088658443;16321.918390407973;16762.916185418995;15130.54608361751;15294.158821264937;15410.537683869501;15668.529944101696;16008.439704610282;13944.4422223114;15223.467178648694;15295.923520382326;15417.460388886335;16046.518604441886;14483.348249328596;14737;14965.251737413304;14985.625359366102;15359.539213823604;11162.18512868191;11243.269187502787;11245.550177993116;11821.468033938321;11887.643370698894;10791.40647264408;11105.722356941142;11220.382878941737;11542.365169915734;11579.942100289782 04:55:53 INFO - PROCESS | 30295 | __end_tp_report 04:55:53 INFO - PROCESS | 30295 | __start_cc_report 04:55:53 INFO - PROCESS | 30295 | _x_x_mozilla_cycle_collect,916 04:55:53 INFO - PROCESS | 30295 | __end_cc_report 04:55:53 INFO - PROCESS | 30295 | __startTimestamp1466682953505__endTimestamp 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | ------- Summary: start ------- 04:55:53 INFO - PROCESS | 30295 | Number of tests: 6 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#0] dojo.html Cycles:165 Average:5320.72 Median:5506.39 stddev:591.87 (10.7%) stddev-sans-first:566.79 04:55:53 INFO - PROCESS | 30295 | Values: 3072.1 3085.7 3107.1 3113.4 3153.6 5206.7 5247.9 5298.0 5307.2 5387.5 5327.8 5328.8 5341.4 5353.7 5374.4 4781.6 4855.5 4873.9 4893.0 5010.5 4918.8 4928.9 4945.9 4969.1 4976.9 4738.4 4818.5 4844.2 4853.0 4867.6 4864.6 4927.3 4929.4 4935.0 4968.2 4696.4 4815.3 4887.0 4889.8 4934.6 5346.1 5363.5 5393.0 5403.9 5415.3 5784.1 5789.6 5814.0 5816.9 5838.3 5567.2 5658.2 5692.4 5769.1 5807.1 5388.2 5438.3 5442.9 5443.3 5443.9 5902.6 5915.4 5918.2 5918.7 5919.1 5506.4 5567.6 5621.2 5637.8 5647.1 5704.5 5733.2 5747.1 5758.7 5760.5 5716.7 5730.7 5736.6 5740.9 5743.9 5516.6 5679.2 5718.0 5734.4 5786.1 4432.7 4440.0 4449.0 4450.4 4484.6 3907.0 3916.1 3964.4 3980.2 4010.5 5388.4 5421.8 5422.5 5444.8 5473.8 5780.1 5805.6 5810.7 5811.9 5858.8 5220.7 5377.7 5453.4 5459.0 5464.2 4968.9 5026.9 5029.8 5040.0 5078.8 5988.9 5990.7 5990.8 6002.8 6004.0 5522.1 5595.1 5639.0 5779.8 5797.9 5857.1 5861.1 5870.7 5877.4 5904.5 5553.7 5575.5 5585.0 5585.6 5599.3 5509.5 5556.1 5565.9 5605.6 5690.3 5508.0 5509.5 5515.9 5520.2 5542.2 5437.2 5493.1 5507.8 5512.0 5568.8 5322.0 5384.1 5442.5 5485.7 5527.8 5640.6 5688.9 5697.3 5697.5 5699.9 5375.9 5532.6 5535.9 5539.9 5547.4 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#1] ext.html Cycles:180 Average:57622.38 Median:41222.09 stddev:111522.92 (270.5%) stddev-sans-first:111753.55 04:55:53 INFO - PROCESS | 30295 | Values: 583.9 624.6 628.7 629.1 640.2 29471.0 41435.8 42552.1 42659.8 42712.9 44464.6 44931.3 44997.0 45049.3 45061.3 8838.2 8968.9 8987.8 8992.9 8997.4 8817.2 8908.1 8914.8 8920.2 8924.8 8954.1 8988.4 8990.3 8991.1 8997.8 8876.4 8878.8 8882.1 8884.2 8884.6 8777.5 8783.3 8825.2 8909.8 8912.6 42786.6 43063.8 43170.8 43200.0 43214.6 3777.5 3792.9 3825.9 4191.9 4342.5 32137.4 32750.7 33431.3 33450.7 34098.2 3945.7 4006.5 4022.9 4045.9 4071.6 361810.0 362072.2 363486.0 364872.0 364912.0 55692.0 56104.0 56153.7 56313.7 56442.7 58350.0 58990.4 59051.4 59059.7 59098.1 12695.7 14743.3 14976.9 15055.2 15105.6 11767.5 11791.3 11865.3 11893.8 11916.8 16029.3 16046.9 16090.7 16100.4 16193.8 5194.7 6268.8 6436.6 6449.6 6612.8 982.4 988.9 1068.0 1068.3 1075.7 31858.0 31990.5 32119.7 32451.0 32789.8 1073.9 1088.9 1093.9 1123.7 1141.3 16668.2 17117.2 17130.6 17256.0 17299.6 535933.0 536802.0 540785.0 540793.0 540805.0 57987.7 58275.4 58283.0 58311.4 58318.7 1229.2 1324.7 1328.4 1354.9 1370.8 32231.7 33023.5 33325.7 33478.7 33489.0 50140.2 51138.5 51210.5 51327.2 51354.2 328244.0 329647.0 330180.0 330930.0 330952.0 33766.0 34198.5 39537.6 40767.2 44359.3 44311.6 44609.3 44719.0 45435.3 45744.5 40527.0 40722.6 40735.6 41022.8 41618.4 39879.6 40099.2 41185.8 41258.4 41642.6 40201.2 41065.8 41142.0 41450.0 41513.4 33466.5 35463.3 35845.0 35932.8 36236.8 26808.5 27259.3 27325.9 27432.3 27566.6 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#2] jquery.html Cycles:180 Average:28642.08 Median:3002.04 stddev:84114.58 (2801.9%) stddev-sans-first:84323.76 04:55:53 INFO - PROCESS | 30295 | Values: 377.2 384.6 388.3 393.3 405.3 17903.7 19308.1 19671.6 19800.9 20232.4 19129.1 19151.6 19349.7 19403.5 19628.9 5528.7 5548.9 5913.1 5922.6 5964.3 5820.8 5856.8 5870.3 5884.6 5892.2 5574.0 5828.3 5842.3 5868.1 5875.5 5932.6 5937.2 5938.4 5951.0 5988.4 5598.9 5793.9 5838.6 5847.7 5854.8 12878.2 13262.4 15783.8 23418.3 23495.3 2362.6 2480.1 2760.4 2991.8 3012.3 9729.9 9898.8 10913.0 11786.3 13963.0 1955.6 2011.9 2027.2 2030.0 2057.1 77364.2 78280.0 79274.6 81192.2 83092.6 10621.2 10826.2 10903.3 11059.3 11189.8 15033.1 15109.5 15146.5 15309.5 15324.2 7180.3 7467.4 7558.9 7692.0 7727.7 7155.5 7232.9 7379.7 7388.5 7414.2 4647.2 4753.7 4756.7 4762.4 4821.8 1913.4 1933.3 1982.9 1983.4 1994.9 962.1 985.9 987.3 1009.5 1048.4 19060.3 19439.7 19778.9 19965.1 20026.6 984.9 1007.0 1011.3 1039.5 1055.3 10242.6 11022.9 11063.3 11082.5 11108.5 508266.0 512253.0 512610.7 513826.0 516320.0 53428.5 59291.0 61589.7 90156.0 95983.7 977.5 997.1 1028.4 1073.6 1077.1 12425.3 16742.9 17205.4 18218.0 18502.4 31276.2 34236.1 41540.0 42086.8 43134.0 55027.4 55510.0 56017.7 57976.0 58059.4 5484.7 7478.7 7516.8 7586.8 8304.3 11213.9 12564.1 12942.4 13003.8 13254.9 10584.9 10728.4 11120.3 11224.9 11236.6 10561.9 10628.5 10649.7 10670.4 10690.4 10380.6 10628.7 10871.5 10913.8 10937.6 8394.2 8589.7 8590.3 8720.7 8732.8 10390.6 10735.2 10826.0 10989.5 11018.4 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#3] mootools.html Cycles:180 Average:5660.38 Median:4675.92 stddev:3221.60 (68.9%) stddev-sans-first:3213.87 04:55:53 INFO - PROCESS | 30295 | Values: 1286.7 1451.3 1487.4 1557.8 1758.6 8026.4 8397.2 8418.7 8595.8 8613.7 8341.8 8552.6 8555.6 8559.3 8567.6 2037.3 2265.0 2347.5 2366.0 2393.1 2322.5 2369.9 2371.4 2376.0 2381.2 2329.5 2356.0 2380.0 2381.1 2381.7 1987.2 2204.8 2279.9 2284.7 2287.4 2315.8 2317.0 2338.6 2338.8 2339.5 8326.5 8382.2 8393.6 8470.7 8531.4 4696.4 4851.2 4852.1 4855.8 4857.2 3123.1 3214.4 3261.0 3276.5 3330.6 1092.7 1121.1 1135.7 1138.9 1146.3 11665.2 11934.3 11970.8 11971.9 11996.3 4499.7 4655.4 4701.1 4739.0 4760.2 10013.5 10027.9 10057.7 10058.7 10061.4 4863.1 4876.6 4880.1 4884.0 4885.0 3863.5 4257.1 4396.6 4400.0 4466.9 3914.8 3947.4 4000.4 4023.8 4077.6 1248.9 1260.3 1270.7 1273.6 1283.3 829.8 953.8 975.8 979.7 988.7 5841.3 5943.5 5992.3 6005.4 6110.9 447.1 447.6 456.3 457.9 473.4 4036.4 4115.5 4125.1 4160.1 4231.3 10445.9 10581.2 10641.6 10722.6 10735.0 10451.8 10458.6 10467.7 10525.4 10557.7 7462.1 7748.7 7754.3 8007.4 8116.0 5979.8 6096.0 6187.8 6215.0 6251.2 9786.9 9857.4 9961.9 10102.1 10108.9 9836.8 9870.3 10128.9 10134.7 10245.7 6810.8 7502.2 7716.7 7754.0 7790.1 8395.6 8423.6 8461.2 8511.4 8515.7 7506.0 7647.0 7733.4 7772.5 7801.4 7423.5 7459.7 7510.1 7661.1 7668.3 6900.8 6924.0 6958.3 6965.0 6966.2 5046.9 5101.8 5171.4 5221.3 5262.4 5055.8 5183.3 5208.2 5292.6 5366.8 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#4] prototype.html Cycles:180 Average:4504.01 Median:4992.06 stddev:1280.23 (25.6%) stddev-sans-first:1244.73 04:55:53 INFO - PROCESS | 30295 | Values: 320.8 328.5 331.8 336.2 336.3 5230.7 5248.8 5304.0 5326.8 5327.9 5222.9 5240.5 5260.0 5284.8 5285.9 4120.3 4155.1 4156.8 4159.9 4209.4 4153.4 4181.3 4216.1 4219.4 4231.6 4119.2 4162.5 4164.6 4166.2 4183.3 4073.5 4152.2 4153.5 4165.6 4173.5 3656.7 3692.9 3711.0 3714.8 3722.2 5126.0 5139.3 5142.9 5152.8 5188.2 4695.7 4711.9 4726.0 4727.9 4761.4 5179.3 5489.3 5501.2 5506.3 5516.5 4015.0 4044.3 4044.6 4061.8 4071.6 5381.3 5430.5 5649.1 5716.1 5755.2 4060.7 4068.5 4102.9 4105.9 4112.4 4138.4 4152.9 4155.4 4165.7 4174.3 4366.0 4546.4 4674.8 4698.0 4720.4 5468.5 5474.6 5474.7 5481.9 5504.4 1421.6 1442.5 1443.4 1444.1 1446.0 898.2 939.4 946.7 952.0 968.0 4697.5 4710.3 4729.7 4759.9 4802.6 4995.5 5001.5 5030.5 5032.9 5079.5 4509.8 4548.7 4741.7 4761.8 4803.0 2669.5 2676.5 2688.7 2715.3 2724.8 5203.8 5240.6 5243.2 5269.3 5290.7 4942.7 4989.6 5158.3 5187.2 5204.7 5017.9 5042.4 5056.4 5172.1 5189.4 4866.3 4938.4 4942.8 4943.9 4994.6 4587.0 4909.9 4917.8 4933.8 4972.4 5530.5 5707.6 5798.1 5915.7 5919.9 4168.4 4170.1 4190.4 4199.5 4205.9 5553.3 5568.6 5697.1 5724.9 5727.7 5457.4 5519.8 5545.4 5557.9 5563.9 5407.9 5450.7 5462.3 5467.4 5513.8 5158.5 5393.2 5395.2 5419.6 5433.1 5438.0 5492.5 5518.7 5529.6 5540.9 5375.9 5387.5 5397.0 5407.9 5431.8 04:55:53 INFO - PROCESS | 30295 | 04:55:53 INFO - PROCESS | 30295 | [#5] yui.html Cycles:180 Average:20938.42 Median:4608.08 stddev:29987.75 (650.8%) stddev-sans-first:30033.45 04:55:53 INFO - PROCESS | 30295 | Values: 720.9 773.8 790.7 832.5 850.4 13502.9 14111.2 14153.9 14159.4 14203.6 14734.6 14886.3 14912.5 14933.4 14960.9 673.9 785.4 789.6 803.2 806.6 784.8 793.2 795.5 795.9 796.4 850.1 853.5 854.9 856.1 856.6 703.0 819.3 849.1 854.8 856.2 622.0 622.4 626.1 626.3 626.4 13783.5 13784.2 13826.9 13830.3 13853.8 13917.4 14036.4 14088.2 14123.2 14430.2 12307.8 12393.3 12528.4 12682.8 12756.4 4169.7 4188.9 4203.5 4228.3 4425.2 73982.3 74777.6 74958.0 74988.6 75065.6 10977.8 11269.9 11313.8 11456.7 11716.6 20142.7 20150.9 20155.7 20219.0 20222.3 8285.6 8311.2 8322.6 8334.9 8743.1 4791.0 4851.7 4871.3 4996.8 5012.4 3023.6 3117.1 3124.8 3133.6 3135.0 488.1 566.7 573.4 590.0 592.8 594.8 694.9 718.3 754.4 776.9 9111.6 9394.8 9566.1 9877.3 9929.8 710.1 712.4 719.2 758.6 764.3 4391.8 4888.1 5119.8 5143.8 5410.3 116102.4 116826.0 118182.4 118278.0 118673.0 65494.0 65622.3 73172.0 94260.0 103263.0 94228.1 94483.0 94822.5 95106.0 95832.0 9516.9 10039.7 10049.3 10150.6 10169.9 50759.2 52252.7 52656.0 52954.0 53757.7 73933.6 83930.0 84969.0 85025.0 85211.0 13246.5 13466.4 13618.1 13789.2 14143.8 16080.0 16247.7 16260.8 16321.9 16762.9 15130.5 15294.2 15410.5 15668.5 16008.4 13944.4 15223.5 15295.9 15417.5 16046.5 14483.3 14737.0 14965.3 14985.6 15359.5 11162.2 11243.3 11245.6 11821.5 11887.6 10791.4 11105.7 11220.4 11542.4 11579.9 04:55:53 INFO - PROCESS | 30295 | -------- Summary: end -------- 04:55:53 INFO - PROCESS | 30295 | 04:55:54 INFO - TEST-INFO | 30295: exit 0 04:55:54 INFO - TEST-OK | dromaeo_css | took 1113220ms 04:55:54 INFO - TEST-START | kraken 04:55:54 INFO - operating with platform_type : linux_ 04:55:54 INFO - Initialising browser for kraken test... 04:55:54 INFO - TEST-INFO | started process 30477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFrda3/profile http://localhost:53452/getInfo.html) 04:55:58 INFO - PROCESS | 30477 | __metrics Screen width/height:1600/1200 04:55:58 INFO - PROCESS | 30477 | colorDepth:24 04:55:58 INFO - PROCESS | 30477 | Browser inner width/height: 1024/697 04:55:58 INFO - PROCESS | 30477 | __metrics 04:55:59 INFO - PROCESS | 30477 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:59 INFO - TEST-INFO | 30477: exit 0 04:55:59 INFO - Browser initialized. 04:55:59 INFO - Running cycle 1/1 for kraken test... 04:55:59 INFO - TEST-INFO | started process 30557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFrda3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:11 INFO - PROCESS | 30557 | RSS: Main: 174243840 04:56:11 INFO - PROCESS | 30557 | 04:56:14 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:15 INFO - PROCESS | 30557 | RSS: Main: 232534016 04:56:15 INFO - PROCESS | 30557 | 04:56:17 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-dft) 04:56:18 INFO - PROCESS | 30557 | RSS: Main: 221425664 04:56:18 INFO - PROCESS | 30557 | 04:56:21 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-fft) 04:56:22 INFO - PROCESS | 30557 | RSS: Main: 287051776 04:56:22 INFO - PROCESS | 30557 | 04:56:24 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-oscillator) 04:56:25 INFO - PROCESS | 30557 | RSS: Main: 197812224 04:56:25 INFO - PROCESS | 30557 | 04:56:27 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:27 INFO - PROCESS | 30557 | RSS: Main: 201670656 04:56:27 INFO - PROCESS | 30557 | 04:56:30 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:31 INFO - PROCESS | 30557 | RSS: Main: 237490176 04:56:31 INFO - PROCESS | 30557 | 04:56:34 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:35 INFO - PROCESS | 30557 | RSS: Main: 238100480 04:56:35 INFO - PROCESS | 30557 | 04:56:38 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53452/tests/kraken/driver.html?testName=json-parse-financial) 04:56:38 INFO - PROCESS | 30557 | RSS: Main: 238358528 04:56:38 INFO - PROCESS | 30557 | 04:56:40 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:40 INFO - PROCESS | 30557 | RSS: Main: 226131968 04:56:40 INFO - PROCESS | 30557 | 04:56:42 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:43 INFO - PROCESS | 30557 | RSS: Main: 229941248 04:56:43 INFO - PROCESS | 30557 | 04:56:45 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:46 INFO - PROCESS | 30557 | RSS: Main: 235634688 04:56:46 INFO - PROCESS | 30557 | 04:56:48 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:49 INFO - PROCESS | 30557 | RSS: Main: 238317568 04:56:49 INFO - PROCESS | 30557 | 04:56:51 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:52 INFO - PROCESS | 30557 | RSS: Main: 239095808 04:56:52 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53452/tests/kraken/driver.html?testName=ai-astar) 04:56:54 INFO - PROCESS | 30557 | RSS: Main: 282689536 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | __start_tp_report 04:56:54 INFO - PROCESS | 30557 | _x_x_mozilla_page_load 04:56:54 INFO - PROCESS | 30557 | _x_x_mozilla_page_load_details 04:56:54 INFO - PROCESS | 30557 | |i|pagename|runs| 04:56:54 INFO - PROCESS | 30557 | |0;ai-astar;102;111;110;110;112;112;110;109;110;110 04:56:54 INFO - PROCESS | 30557 | |1;audio-beat-detection;150;125;128;181;126;126;164;124;164;125 04:56:54 INFO - PROCESS | 30557 | |2;audio-dft;162;160;163;161;161;161;162;161;161;161 04:56:54 INFO - PROCESS | 30557 | |3;audio-fft;74;74;75;135;75;75;74;75;104;75 04:56:54 INFO - PROCESS | 30557 | |4;audio-oscillator;84;85;113;86;85;85;116;85;86;136 04:56:54 INFO - PROCESS | 30557 | |5;imaging-gaussian-blur;117;117;118;118;117;118;118;118;118;117 04:56:54 INFO - PROCESS | 30557 | |6;imaging-darkroom;147;147;146;145;145;145;145;145;145;145 04:56:54 INFO - PROCESS | 30557 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 04:56:54 INFO - PROCESS | 30557 | |8;json-parse-financial;54;55;56;56;54;56;58;55;56;57 04:56:54 INFO - PROCESS | 30557 | |9;json-stringify-tinderbox;63;63;62;62;63;63;62;64;62;62 04:56:54 INFO - PROCESS | 30557 | |10;stanford-crypto-aes;79;82;77;81;80;81;86;82;94;84 04:56:54 INFO - PROCESS | 30557 | |11;stanford-crypto-ccm;122;127;126;125;121;121;118;137;142;136 04:56:54 INFO - PROCESS | 30557 | |12;stanford-crypto-pbkdf2;165;168;162;165;162;161;161;159;159;159 04:56:54 INFO - PROCESS | 30557 | |13;stanford-crypto-sha256-iterative;65;64;64;64;64;72;63;64;63;63 04:56:54 INFO - PROCESS | 30557 | __end_tp_report 04:56:54 INFO - PROCESS | 30557 | __start_cc_report 04:56:54 INFO - PROCESS | 30557 | _x_x_mozilla_cycle_collect,1629 04:56:54 INFO - PROCESS | 30557 | __end_cc_report 04:56:54 INFO - PROCESS | 30557 | __startTimestamp1466683014457__endTimestamp 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | ------- Summary: start ------- 04:56:54 INFO - PROCESS | 30557 | Number of tests: 14 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.84 (2.6%) stddev-sans-first:1.01 04:56:54 INFO - PROCESS | 30557 | Values: 102.0 111.0 110.0 110.0 112.0 112.0 110.0 109.0 110.0 110.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:139.00 stddev:21.49 (15.5%) stddev-sans-first:22.57 04:56:54 INFO - PROCESS | 30557 | Values: 150.0 125.0 128.0 181.0 126.0 126.0 164.0 124.0 164.0 125.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:56:54 INFO - PROCESS | 30557 | Values: 162.0 160.0 163.0 161.0 161.0 161.0 162.0 161.0 161.0 161.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:20.29 (27.1%) stddev-sans-first:21.22 04:56:54 INFO - PROCESS | 30557 | Values: 74.0 74.0 75.0 135.0 75.0 75.0 74.0 75.0 104.0 75.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:18.61 (21.9%) stddev-sans-first:19.22 04:56:54 INFO - PROCESS | 30557 | Values: 84.0 85.0 113.0 86.0 85.0 85.0 116.0 85.0 86.0 136.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:56:54 INFO - PROCESS | 30557 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 04:56:54 INFO - PROCESS | 30557 | Values: 147.0 147.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:56:54 INFO - PROCESS | 30557 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.25 (2.2%) stddev-sans-first:1.17 04:56:54 INFO - PROCESS | 30557 | Values: 54.0 55.0 56.0 56.0 54.0 56.0 58.0 55.0 56.0 57.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 04:56:54 INFO - PROCESS | 30557 | Values: 63.0 63.0 62.0 62.0 63.0 63.0 62.0 64.0 62.0 62.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:4.72 (5.8%) stddev-sans-first:4.82 04:56:54 INFO - PROCESS | 30557 | Values: 79.0 82.0 77.0 81.0 80.0 81.0 86.0 82.0 94.0 84.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.50 stddev:8.07 (6.4%) stddev-sans-first:8.31 04:56:54 INFO - PROCESS | 30557 | Values: 122.0 127.0 126.0 125.0 121.0 121.0 118.0 137.0 142.0 136.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:3.03 (1.9%) stddev-sans-first:3.03 04:56:54 INFO - PROCESS | 30557 | Values: 165.0 168.0 162.0 165.0 162.0 161.0 161.0 159.0 159.0 159.0 04:56:54 INFO - PROCESS | 30557 | 04:56:54 INFO - PROCESS | 30557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:2.67 (4.2%) stddev-sans-first:2.83 04:56:54 INFO - PROCESS | 30557 | Values: 65.0 64.0 64.0 64.0 64.0 72.0 63.0 64.0 63.0 63.0 04:56:54 INFO - PROCESS | 30557 | -------- Summary: end -------- 04:56:54 INFO - PROCESS | 30557 | 04:56:55 INFO - TEST-INFO | 30557: exit 0 04:56:55 INFO - TEST-OK | kraken | took 61176ms 04:56:55 INFO - SUITE-END | took 1174s 04:56:55 INFO - Completed test suite (00:19:34) 04:56:55 INFO - javascript benchmark 04:56:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.078376487054, 3085.72228499435, 3107.0678796361094, 3113.4240165569386, 3153.621565412151, 5206.661566998143, 5247.92128118078, 5298.046351656701, 5307.177387504933, 5387.542058924992, 5327.840164795062, 5328.786848526054, 5341.385740639827, 5353.705546194958, 5374.355077390718, 4781.617470602361, 4855.5387238212315, 4873.8781530461665, 4892.9510704892855, 5010.498950104979, 4918.778654960517, 4928.926066109011, 4945.876353091184, 4969.055879382906, 4976.876680618832, 4738.384010078685, 4818.469968303484, 4844.224924012176, 4852.975735121302, 4867.634927380461, 4864.586510146642, 4927.334809800667, 4929.359183306183, 4935.0376676548085, 4968.180250258703, 4696.365990591295, 4815.253635686474, 4886.9511304886855, 4889.75551222441, 4934.605231581465, 5346.091164502044, 5363.490468405495, 5393.0, 5403.891922161535, 5415.323084614423, 5784.1034639630925, 5789.594728369016, 5814.0, 5816.88366232673, 5838.328592211908, 5567.192757050246, 5658.236138121342, 5692.402297758717, 5769.076947688392, 5807.070868660994, 5388.1648344506275, 5438.265834112423, 5442.863928401782, 5443.292371991655, 5443.918341224845, 5902.645841249453, 5915.37888521699, 5918.171455996164, 5918.704064796743, 5919.052951527735, 5506.394296627368, 5567.582431317667, 5621.156826476062, 5637.774489020393, 5647.124695672177, 5704.543636509153, 5733.197352370671, 5747.08046712524, 5758.712064396847, 5760.481556659837, 5716.714164291852, 5730.713464326767, 5736.569757268138, 5740.885182296331, 5743.885122297531, 5516.558675305966, 5679.176519404663, 5718.0, 5734.369219385864, 5786.07422812348, 4432.711873728197, 4439.955600443955, 4448.955510444919, 4450.443694538183, 4484.551544845489, 3907.0, 3916.099297161669, 3964.444977703124, 3980.20395920817, 4010.47863777707, 5388.407275199725, 5421.756020979065, 5422.48486393792, 5444.8366549003595, 5473.781048758085, 5780.104083867007, 5805.622634528827, 5810.738516766755, 5811.854703632358, 5858.794942177004, 5220.738963051908, 5377.704226267593, 5453.400125986138, 5458.972705136528, 5464.153056276284, 4968.90062198754, 5026.899462010812, 5029.84910452687, 5040.042391945519, 5078.796848126033, 5988.9401105989255, 5990.6705131218205, 5990.820275391745, 6002.759889604367, 6004.0, 5522.06124958766, 5595.07681232592, 5639.041362968223, 5779.826605201851, 5797.9420205797405, 5857.092150716646, 5861.0915308127305, 5870.706464676835, 5877.4122587740885, 5904.498117660047, 5553.666779993213, 5575.470330318613, 5584.972075139761, 5585.609007369445, 5599.272094627672, 5509.5041446270025, 5556.083246264321, 5565.916511252415, 5605.5515558756015, 5690.3456102548735, 5507.972460137834, 5509.47659972302, 5515.944840551703, 5520.199571062093, 5542.168674698827, 5437.211604317273, 5493.148561972901, 5507.807226747044, 5511.972440137773, 5568.777248909998, 5322.042032434199, 5384.111621582395, 5442.510174084351, 5485.725713714219, 5527.834164975057, 5640.605157638925, 5688.857778555569, 5697.259356283656, 5697.4587414195585, 5699.9145012825675, 5375.892482150413, 5532.585056120726, 5535.944640553704, 5539.944600554104, 5547.44525547442], "value": 5281.560401155733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9328477225117, 624.6002558362649, 628.7139351595023, 629.0815409502127, 640.1773720768813, 29471.0, 41435.79282103593, 42552.148957020916, 42659.78670106653, 42712.942270484295, 44464.55535444645, 44931.32603010957, 44997.0, 45049.32426013613, 45061.324080138824, 8838.248748856355, 8968.865467018, 8987.820243595124, 8992.8651070234, 8997.370184087084, 8817.16236957488, 8908.109189081104, 8914.821703565956, 8920.197182253629, 8924.776880578005, 8954.14935581122, 8988.415752976036, 8990.28077753778, 8991.100889911022, 8997.775055623597, 8876.423032502898, 8878.778030549289, 8882.06738292483, 8884.200421962023, 8884.600192991331, 8777.517236551987, 8783.253423459013, 8825.161609647073, 8909.777255568597, 8912.55437228136, 42786.57213427888, 43063.78468107671, 43170.784146079066, 43200.0, 43214.567854321365, 3777.490038844748, 3792.886213413602, 3825.9043523911846, 4191.895202619929, 4342.544032876534, 32137.357252855047, 32750.672493275, 33431.33137337264, 33450.665493345245, 34098.249192588795, 3945.704072194597, 4006.5192176938663, 4022.9195416091807, 4045.9190816183805, 4071.5521292657786, 361810.0, 362072.1896390527, 363485.9999999974, 364872.0, 364912.0, 55692.0, 56104.0, 56153.71923140358, 56313.71843140758, 56442.7177864108, 58350.0, 58990.41009589849, 59051.40948590545, 59059.70470147708, 59098.11352829711, 12695.746085078246, 14743.336549855283, 14976.850231497545, 15055.171965542, 15105.622359441102, 11767.470463829148, 11791.29252244868, 11865.288082715064, 11893.762124757457, 11916.821247681119, 16029.278682459317, 16046.919765401099, 16090.712742980768, 16100.355985760438, 16193.757093643604, 5194.740262986836, 6268.811935641938, 6436.613803171825, 6449.613023218528, 6612.801615951529, 982.3761911186448, 988.9208863290919, 1068.0, 1068.278911734576, 1075.725689949058, 31858.0, 31990.520142197885, 32119.678803212137, 32451.0, 32789.83605081959, 1073.9409332486632, 1088.8747794003632, 1093.8632670916136, 1123.6966019174777, 1141.2923987127867, 16668.166591670368, 17117.22972466242, 17130.571735706708, 17255.99152491552, 17299.56751081233, 535933.0, 536802.0, 540785.0, 540793.0, 540805.0, 57987.71006144942, 58275.41724582785, 58283.0, 58311.416885831444, 58318.7084064577, 1229.170310040719, 1324.715186234945, 1328.4221363706818, 1354.878060974517, 1370.8286464191976, 32231.677683222868, 33023.50464743079, 33325.66674333226, 33478.66521334756, 33489.0, 50140.247896282315, 51138.488615113376, 51210.48789512206, 51327.230091547906, 51354.22968655398, 328244.0, 329647.0, 330180.0, 330930.0, 330952.0, 33766.0, 34198.46106925145, 39537.60462395454, 40767.1846563073, 44359.33460998023, 44311.55688443074, 44609.33086003777, 44719.0, 45435.31847022363, 45744.54255457403, 40527.0, 40722.59277407306, 40735.59264407318, 41022.79488602538, 41618.375724363555, 39879.601203987586, 40099.1980160401, 41185.79407102945, 41258.38112428376, 41642.58357416508, 40201.1959760809, 41065.79467102765, 41142.0, 41450.0, 41513.37729934114, 33466.49800253047, 35463.29073418466, 35845.0, 35932.820335898155, 36236.81881590575, 26808.451514940876, 27259.318517037234, 27325.86337068302, 27432.314192144557, 27566.5865012029], "value": 19818.198991670233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1857366069207, 384.64036126221987, 388.25842640556533, 393.3391901605302, 405.27455854021304, 17903.731444028333, 19308.13113409898, 19671.606567868635, 19800.900995495038, 20232.39302820914, 19129.139188736506, 19151.616967660637, 19349.709754353695, 19403.514912127204, 19628.9018554907, 5528.723563821803, 5548.944510554883, 5913.14259432382, 5922.6150300230565, 5964.254468191454, 5820.82537523875, 5856.795012174574, 5870.26621672291, 5884.646921184722, 5892.204552385416, 5573.972130139344, 5828.3297420796725, 5842.32813226478, 5868.09044598088, 5875.471207591316, 5932.644041357532, 5937.1984782054515, 5938.376470470582, 5951.0, 5988.401159884021, 5598.86002849932, 5793.884122317572, 5838.64968101911, 5847.736851841677, 5854.824355269348, 12878.162919410302, 13262.403191856389, 15783.842161578466, 23418.297451076494, 23495.295141145794, 2362.6219804831144, 2480.0947654106303, 2760.3789147441867, 2991.760659147263, 3012.322227498817, 9729.859191473652, 9898.752531186707, 10913.0, 11786.292822430596, 13963.0, 1955.5502234486005, 2011.9497012574657, 2027.1992562937558, 2029.9695504567444, 2057.1360028787944, 77364.22635773626, 78280.0, 79274.60362698208, 81192.18807811964, 83092.58453707754, 10621.150307975344, 10826.242163048668, 10903.29128606638, 11059.281146725438, 11189.832152517718, 15033.098014119189, 15109.47116850927, 15146.469873554594, 15309.46416875404, 15324.157171355682, 7180.31786980236, 7467.365273951775, 7558.886616700754, 7691.961540192375, 7727.729529466442, 7155.529568159439, 7232.92767072333, 7379.741709040158, 7388.519746216479, 7414.184439711627, 4647.16351056813, 4753.6910100844025, 4756.673297900791, 4762.4285085789925, 4821.831235906727, 1913.3781521005728, 1933.3136736458355, 1982.8810271383763, 1983.365323096624, 1994.890281034528, 962.0908241711516, 985.8964808695127, 987.2940847294219, 1009.485162567096, 1048.4076496779448, 19060.332888348843, 19439.708404373945, 19778.90110549438, 19965.101570429364, 20026.599468010558, 984.8965858584745, 1006.9748256293651, 1011.2971484817981, 1039.4594810698395, 1055.3193190392153, 10242.641507547349, 11022.944885275683, 11063.280886742497, 11082.501287442085, 11108.500117494732, 508266.0, 512253.0, 512610.69431454636, 513826.0, 516320.0, 53428.46571534235, 59291.0, 61589.692051540354, 90156.0, 95983.68073436712, 977.506359288569, 997.0926456924019, 1028.4395004722444, 1073.6188653028062, 1077.1329080090445, 12425.31660758667, 16742.916285418494, 17205.39781107705, 18218.0, 18502.352417665854, 31276.241385844616, 34236.14409639779, 41540.0, 42086.78956605197, 43134.0, 55027.449725502236, 55510.0, 56017.719911400185, 57976.0, 58059.4194058054, 5484.670919744828, 7478.738244161428, 7516.774496765106, 7586.81032974158, 8304.294134998592, 11213.943930280297, 12564.120511564468, 12942.41759120823, 13003.804942926054, 13254.867451325363, 10584.947075264574, 10728.356298622108, 11120.332780033224, 11224.94387528057, 11236.606718764804, 10561.89438105609, 10628.468576570986, 10649.680509584725, 10670.413127278074, 10690.41202733857, 10380.584776609154, 10628.734281643021, 10871.456427178768, 10913.781724365626, 10937.639308534539, 8394.160583941557, 8589.742307730778, 8590.312774977861, 8720.65117395297, 8732.825343493221, 10390.636327728493, 10735.248532602644, 10826.0, 10989.505472253608, 11018.39398833072], "value": 9012.964454239685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.7297867447835, 1451.3033743802978, 1487.4347747855816, 1557.8364271751466, 1758.577941294089, 8026.357891368683, 8397.202265784748, 8418.663253469862, 8595.828083438328, 8613.698520551781, 8341.791455213608, 8552.615132319044, 8555.61499732512, 8559.315254779618, 8567.571621418936, 2037.3073155127254, 2265.0, 2347.542229265294, 2366.0299277296313, 2393.0547433763654, 2322.500662357593, 2369.857808531485, 2371.3597328721235, 2376.013954209001, 2381.226101517005, 2329.4875127472014, 2356.0, 2380.0122948976154, 2381.1070848431837, 2381.678473406094, 1987.224982256921, 2204.7795220477983, 2279.931602051941, 2284.7486776454575, 2287.4167087392775, 2315.7684231576877, 2317.0268487235403, 2338.5556744218543, 2338.8128949683983, 2339.5320935812906, 8326.45878017927, 8382.245597896219, 8393.580320983927, 8470.745877623682, 8531.360147988926, 4696.436427628672, 4851.223804191312, 4852.102361063215, 4855.805767769285, 4857.198562237262, 3123.0786917859286, 3214.437473442138, 3261.0, 3276.541284220211, 3330.58367704037, 1092.6667366453307, 1121.0695123047933, 1135.73310272086, 1138.8576427946507, 1146.266389510714, 11665.241759285704, 11934.343611101385, 11970.82043769344, 11971.880281197251, 11996.340201288838, 4499.730016199039, 4655.3947986761505, 4701.083288758728, 4738.976305118521, 4760.238361862085, 10013.49932503372, 10027.949860250652, 10057.748556286151, 10058.698239052694, 10061.4466204358, 4863.148948933923, 4876.634252431082, 4880.072786170616, 4884.0, 4885.0, 3863.517060367454, 4257.148570285955, 4396.604305612446, 4399.978000110043, 4466.932996005063, 3914.8042597869994, 3947.3684210526176, 4000.4199391088127, 4023.8390464381096, 4077.55146933837, 1248.89384402325, 1260.2627462934104, 1270.707737220426, 1273.6242808371553, 1283.3390803736083, 829.8340331933638, 953.7615596100975, 975.7607838045642, 979.7256768104942, 988.7330420786491, 5841.299044114733, 5943.494802941712, 5992.280926288873, 6005.3694362091355, 6110.908336374958, 447.085709723616, 447.5502120369008, 456.33375272103103, 457.9175748365326, 473.4082397003745, 4036.3509956795715, 4115.54728979812, 4125.133721918371, 4160.105577300835, 4231.280682284019, 10445.9477702611, 10581.206409519316, 10641.574337026432, 10722.571097156026, 10735.0, 10451.84322235167, 10458.633947811943, 10467.685969420929, 10525.368477891197, 10557.736056598647, 7462.067241594801, 7748.728794492165, 7754.263344982105, 8007.359411247203, 8115.959420202861, 5979.820605381846, 6095.969520152371, 6187.81436556904, 6215.036669316263, 6251.249850018027, 9786.902130978884, 9857.35927164732, 9961.900380996098, 10102.09081182697, 10108.898911010796, 9836.754081148028, 9870.259730520096, 10128.949355253177, 10134.746631334276, 10245.74385640365, 6810.829729256809, 7502.249775022454, 7716.729914452967, 7753.961230193813, 7790.14308426084, 8395.580220988804, 8423.578821059045, 8461.153884611736, 8511.36164787631, 8515.701950431952, 7506.024216851774, 7647.0, 7733.419993500397, 7772.45592808498, 7801.414893882868, 7423.517471364344, 7459.738909138154, 7510.136334321623, 7661.118971318369, 7668.348190403878, 6900.758473453405, 6924.030635711105, 6958.304169583002, 6965.0, 6966.233714291323, 5046.873828154326, 5101.821436249714, 5171.431142574389, 5221.321228240305, 5262.394824595068, 5055.772490237875, 5183.300254465599, 5208.244804503402, 5292.629515933848, 5366.838994830161], "value": 4464.19360721947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.78507400041957, 328.4744408945687, 331.8125259228537, 336.2182924700072, 336.2887492952406, 5230.686158830473, 5248.816291429801, 5303.9734801325985, 5326.840194794162, 5327.893442131155, 5222.9477705222935, 5240.528352448288, 5260.0, 5284.8150314739, 5285.867853303669, 4120.340745480717, 4155.148194620111, 4156.750594964296, 4159.9376009359885, 4209.431726716884, 4153.356229784373, 4181.3309870420735, 4216.093539888923, 4219.409282700424, 4231.555686652903, 4119.196756632457, 4162.4796900387455, 4164.646005089571, 4166.166766646667, 4183.288840897055, 4073.490813648294, 4152.211079894811, 4153.460050193456, 4165.604267594574, 4173.499180098393, 3656.7018708358682, 3692.8707495237804, 3710.9775172530767, 3714.7771133731794, 3722.236941427001, 5125.974370128163, 5139.306193663845, 5142.897142057138, 5152.845414637567, 5188.221766734982, 4695.741734204617, 4711.905761884777, 4726.0, 4727.881802954954, 4761.381020467352, 5179.300794392784, 5489.313835770528, 5501.202325662796, 5506.311711036121, 5516.531094856942, 4014.959850401488, 4044.312466880637, 4044.6157615026527, 4061.817218225187, 4071.6131967463043, 5381.300430943991, 5430.484104010113, 5649.096144616841, 5716.114002329646, 5755.165501002373, 4060.7360521566, 4068.532118806316, 4102.897427564335, 4105.91788164235, 4112.362583799516, 4138.441310423114, 4152.896177595584, 4155.439015732898, 4165.66674666026, 4174.269502836992, 4365.978170109129, 4546.386237857913, 4674.836380726658, 4697.976510117427, 4720.386349774576, 5468.535174510212, 5474.589405794582, 5474.671519708831, 5481.890362192734, 5504.366997795225, 1421.6090575091725, 1442.4662874736414, 1443.3577058209205, 1444.111871199226, 1445.978310325346, 898.1826537850525, 939.4081728510994, 946.7301818981695, 951.9524023798921, 967.9951600241953, 4697.530246975343, 4710.3405523226775, 4729.7398643074275, 4759.857204283877, 4802.615790736802, 4995.500449954975, 5001.474550262133, 5030.547250747451, 5032.899342013213, 5079.466656001066, 4509.840837666003, 4548.727076375428, 4741.691790033706, 4761.833335833298, 4803.0, 2669.546177149889, 2676.4914666213745, 2688.7445692659167, 2715.307596562903, 2724.768394686434, 5203.762382175625, 5240.606954478353, 5243.23973023917, 5269.262303277545, 5290.682559046392, 4942.728149951788, 4989.55094041538, 5158.252053452228, 5187.221916712523, 5204.73976301191, 5017.9247311290355, 5042.369703787027, 5056.418511871182, 5172.086328058643, 5189.377274727057, 4866.270059491105, 4938.358013458227, 4942.777575009061, 4943.8516844494725, 4994.5754610858485, 4586.977065114653, 4909.9018019640125, 4917.803287868445, 4933.840547471413, 4972.428170760264, 5530.5022547970875, 5707.571932105026, 5798.1302804579655, 5915.733791979457, 5919.868847215085, 4168.374743788335, 4170.124273902515, 4190.413342132165, 4199.517055538652, 4205.873823785291, 5553.278483670075, 5568.582356323373, 5697.116946873241, 5724.942750572608, 5727.70891643346, 5457.372402173801, 5519.806806761744, 5545.390007099297, 5557.916631250454, 5563.916541251803, 5407.864803379947, 5450.672959622435, 5462.3445186577865, 5467.398586155599, 5513.7794488221625, 5158.535731784157, 5393.244945707683, 5395.163749618815, 5419.593530485151, 5433.130699088127, 5437.972810136082, 5492.5331346835965, 5518.696471694096, 5529.612927095065, 5540.889182216414, 5375.919361209507, 5387.515123638891, 5396.973015135056, 5407.945920540901, 5431.750697339713], "value": 4100.485401580113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9243029481905, 773.8297574533605, 790.6995341770127, 832.4589017138862, 850.3664769746538, 13502.932485337571, 14111.223882686449, 14153.929230353846, 14159.433622655095, 14203.573892783234, 14734.557963261093, 14886.330115144818, 14912.478063267788, 14933.40266389346, 14960.850391496082, 673.9292374300701, 785.352084530262, 789.6328207383551, 803.1927912448011, 806.592670701295, 784.7959530522048, 793.218679600593, 795.4988357334871, 795.8885755994165, 796.358931060496, 850.1031411860484, 853.5305581929945, 854.9273311768476, 856.1053698884649, 856.6059612578222, 702.9543079699829, 819.336337566573, 849.1381248033251, 854.7606670132373, 856.2422256303216, 622.0047923322693, 622.4460230394952, 626.1077963901467, 626.3048016701458, 626.3955283151735, 13783.51757688476, 13784.172949623055, 13826.93086534571, 13830.308484575731, 13853.792193117111, 13917.443302267897, 14036.438542458289, 14088.225147616877, 14123.223222722747, 14430.20633865137, 12307.753844923142, 12393.318367489785, 12528.373581320897, 12682.80975785364, 12756.425960831784, 4169.728967617095, 4188.853390131361, 4203.47456567929, 4228.302330115527, 4425.159219748238, 73982.26017739807, 74777.62611186964, 74958.0, 74988.62505687491, 75065.62467187628, 10977.780444391068, 11269.94365028186, 11313.773724525628, 11456.656300311004, 11716.589919352782, 20142.69785953212, 20150.899245503973, 20155.697664535044, 20219.0, 20222.292219772236, 8285.58572071394, 8311.210435008785, 8322.583870806557, 8334.916650833535, 8743.125687431206, 4791.0, 4851.660383773102, 4871.34236878017, 4996.800127994912, 5012.423571289275, 3023.591815104977, 3117.0804612639326, 3124.8281344525813, 3133.5769671094113, 3135.0438116374726, 488.0775334617576, 566.6571724106939, 573.4179807495395, 590.0352922970974, 592.762894842058, 594.7888499582673, 694.9270326615733, 718.3104219948804, 754.3550264523753, 776.8936161768495, 9111.635534578543, 9394.765130871783, 9566.091221333962, 9877.308588398742, 9929.80140397188, 710.1166832790308, 712.4300559552337, 719.1801346465035, 758.624480881956, 764.2777575191391, 4391.824327026947, 4888.120138375127, 5119.820806271762, 5143.794248230104, 5410.296661433988, 116102.41948790202, 116826.0, 118182.40908795402, 118278.0, 118673.0, 65494.0, 65622.34377656257, 73172.0, 94260.0, 103263.0, 94228.0577194233, 94483.0, 94822.52588737012, 95106.0, 95832.0, 9516.857247141437, 10039.69880903574, 10049.296549241482, 10150.644727434505, 10169.949150254497, 50759.23861142012, 52252.73873630608, 52656.0, 52954.0, 53757.73121134369, 73933.63033184799, 83930.0, 84969.02608408676, 85025.0, 85211.0, 13246.47014119463, 13466.394012269275, 13618.114822536503, 13789.176046469192, 14143.787843182567, 16080.0, 16247.67504649924, 16260.756088658443, 16321.918390407973, 16762.916185418995, 15130.54608361751, 15294.158821264937, 15410.537683869501, 15668.529944101696, 16008.439704610282, 13944.4422223114, 15223.467178648694, 15295.923520382326, 15417.460388886335, 16046.518604441886, 14483.348249328596, 14737.0, 14965.251737413304, 14985.625359366102, 15359.539213823604, 11162.18512868191, 11243.269187502787, 11245.550177993116, 11821.468033938321, 11887.643370698894, 10791.40647264408, 11105.722356941142, 11220.382878941737, 11542.365169915734, 11579.942100289782], "value": 7616.793202327434, "unit": "score"}], "name": "dromaeo_css", "value": 7131.517441611867, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 112.0, 112.0, 110.0, 109.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 128.0, 181.0, 126.0, 126.0, 164.0, 124.0, 164.0, 125.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 135.0, 75.0, 75.0, 74.0, 75.0, 104.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 86.0, 85.0, 85.0, 116.0, 85.0, 86.0, 136.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 56.0, 54.0, 56.0, 58.0, 55.0, 56.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 77.0, 81.0, 80.0, 81.0, 86.0, 82.0, 94.0, 84.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 127.0, 126.0, 125.0, 121.0, 121.0, 118.0, 137.0, 142.0, 136.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 162.0, 165.0, 162.0, 161.0, 161.0, 159.0, 159.0, 159.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 72.0, 63.0, 64.0, 63.0, 63.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1505.3, "alertThreshold": 2.0}]} 04:56:55 INFO - Return code: 0 04:56:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:55 INFO - # TBPL SUCCESS # 04:56:55 INFO - Running post-action listener: _resource_record_post_action 04:56:55 INFO - ##### 04:56:55 INFO - ##### Finished run-tests step (success) 04:56:55 INFO - ##### 04:56:55 INFO - Running post-run listener: _resource_record_post_run 04:56:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 552697856; Read time: 0; Write time: 443016 04:56:55 INFO - TinderboxPrint: CPU usage
13.3% 04:56:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:56:55 INFO - TinderboxPrint: I/O write bytes / time
552,697,856 / 443,016 04:56:55 INFO - TinderboxPrint: CPU idle
8,256.0 (86.7%) 04:56:55 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 04:56:55 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256647168; Read time: 0; Write time: 224604 04:56:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 289431552; Read time: 0; Write time: 216876 04:56:56 INFO - Running post-run listener: _upload_blobber_files 04:56:56 INFO - Blob upload gear active. 04:56:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:56:56 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:56:56 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:56:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:00 INFO - (blobuploader) - INFO - Done attempting. 04:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:00 INFO - (blobuploader) - INFO - Done attempting. 04:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:01 INFO - (blobuploader) - INFO - Done attempting. 04:57:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:01 INFO - Return code: 0 04:57:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9409c1474f9b452f5bcf116a1e19b6277c8f174dbc134f509b4eaf732000e49c9618ed282e35213897ab63d691010947cda4f09c863225439e19e3ea517436e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8e86616d966389b9588f56fe55d326e77b12a8afd000c793a2179bf3ca022daa536f48b76ebb6ed785dd83e5e38e1dc28152bd6abdd373427275535763b5fc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d71da826ac307ed40704d6d61e1b81540a4b926ce493017f247fe1c3ec03094de948f3de781692fd5b20ab1f3e727aa9993a33be46730ff8e520bc55d729dcb"} 04:57:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:01 INFO - Contents: 04:57:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9409c1474f9b452f5bcf116a1e19b6277c8f174dbc134f509b4eaf732000e49c9618ed282e35213897ab63d691010947cda4f09c863225439e19e3ea517436e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8e86616d966389b9588f56fe55d326e77b12a8afd000c793a2179bf3ca022daa536f48b76ebb6ed785dd83e5e38e1dc28152bd6abdd373427275535763b5fc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d71da826ac307ed40704d6d61e1b81540a4b926ce493017f247fe1c3ec03094de948f3de781692fd5b20ab1f3e727aa9993a33be46730ff8e520bc55d729dcb"} 04:57:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:01 INFO - Copying logs to upload dir... 04:57:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.151056 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-23 04:56:58.075697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:56:58.079762) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9409c1474f9b452f5bcf116a1e19b6277c8f174dbc134f509b4eaf732000e49c9618ed282e35213897ab63d691010947cda4f09c863225439e19e3ea517436e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8e86616d966389b9588f56fe55d326e77b12a8afd000c793a2179bf3ca022daa536f48b76ebb6ed785dd83e5e38e1dc28152bd6abdd373427275535763b5fc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d71da826ac307ed40704d6d61e1b81540a4b926ce493017f247fe1c3ec03094de948f3de781692fd5b20ab1f3e727aa9993a33be46730ff8e520bc55d729dcb"} build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9409c1474f9b452f5bcf116a1e19b6277c8f174dbc134f509b4eaf732000e49c9618ed282e35213897ab63d691010947cda4f09c863225439e19e3ea517436e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8e86616d966389b9588f56fe55d326e77b12a8afd000c793a2179bf3ca022daa536f48b76ebb6ed785dd83e5e38e1dc28152bd6abdd373427275535763b5fc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d71da826ac307ed40704d6d61e1b81540a4b926ce493017f247fe1c3ec03094de948f3de781692fd5b20ab1f3e727aa9993a33be46730ff8e520bc55d729dcb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:56:58.106610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:56:58.106989) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466681786.12006-1978366582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:56:58.190816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:56:58.191173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:56:58.191519) ========= ========= Total master_lag: 0.16 =========