builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1465438085.59 results: success (0) buildid: 20160608163004 builduid: 7713e4fd0e3444c68c45b3e76da34958 revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.588621) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.589116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.589418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.605756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.606054) ========= 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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 19:08:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.1M=0s 2016-06-08 19:08:05 (73.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.691742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.692045) ========= 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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016902 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.744667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:05.744997) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 19:08:06,075 truncating revision to first 12 chars 2016-06-08 19:08:06,075 Setting DEBUG logging. 2016-06-08 19:08:06,075 attempt 1/10 2016-06-08 19:08:06,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/051765f8237d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 19:08:06,389 unpacking tar archive at: mozilla-central-051765f8237d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:06.413330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:06.413686) ========= script_repo_revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:06.414136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:06.414476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 19:08:06.425221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-08 19:08:06.425652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:06 INFO - MultiFileLogger online at 20160608 19:08:06 in /builds/slave/test 19:08:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:08:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:06 INFO - {'append_to_log': False, 19:08:06 INFO - 'base_work_dir': '/builds/slave/test', 19:08:06 INFO - 'blob_upload_branch': 'Firefox', 19:08:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:06 INFO - 'branch': 'Firefox', 19:08:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:06 INFO - 'config_files': ('talos/linux_config.py',), 19:08:06 INFO - 'default_actions': ('clobber', 19:08:06 INFO - 'read-buildbot-config', 19:08:06 INFO - 'download-and-extract', 19:08:06 INFO - 'populate-webroot', 19:08:06 INFO - 'create-virtualenv', 19:08:06 INFO - 'install', 19:08:06 INFO - 'run-tests'), 19:08:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:06 INFO - 'download_minidump_stackwalk': True, 19:08:06 INFO - 'download_symbols': 'ondemand', 19:08:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:06 INFO - 'installer_path': 'installer.exe', 19:08:06 INFO - 'log_level': 'info', 19:08:06 INFO - 'log_name': 'talos', 19:08:06 INFO - 'log_to_console': True, 19:08:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:06 INFO - 'opt_config_files': (), 19:08:06 INFO - 'pip_index': False, 19:08:06 INFO - 'sps_profile': False, 19:08:06 INFO - 'sps_profile_interval': 0, 19:08:06 INFO - 'suite': 'dromaeojs', 19:08:06 INFO - 'system_bits': '32', 19:08:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:06 INFO - 'title': 'talos-linux64-ix-008', 19:08:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:06 INFO - 'use_talos_json': True, 19:08:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:06 INFO - 'work_dir': 'build'} 19:08:06 INFO - ##### 19:08:06 INFO - ##### Running clobber step. 19:08:06 INFO - ##### 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: clobber 19:08:06 INFO - rmtree: /builds/slave/test/build 19:08:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:07 INFO - Running post-action listener: _resource_record_post_action 19:08:07 INFO - ##### 19:08:07 INFO - ##### Finished clobber step (success) 19:08:07 INFO - ##### 19:08:07 INFO - ##### 19:08:07 INFO - ##### Running read-buildbot-config step. 19:08:07 INFO - ##### 19:08:07 INFO - Running pre-action listener: _resource_record_pre_action 19:08:07 INFO - Running main action method: read_buildbot_config 19:08:07 INFO - Using buildbot properties: 19:08:07 INFO - { 19:08:07 INFO - "project": "", 19:08:07 INFO - "product": "firefox", 19:08:07 INFO - "script_repo_revision": "production", 19:08:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:08:07 INFO - "repository": "", 19:08:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:08:07 INFO - "buildid": "20160608163004", 19:08:07 INFO - "pgo_build": "True", 19:08:07 INFO - "basedir": "/builds/slave/test", 19:08:07 INFO - "buildnumber": 475, 19:08:07 INFO - "slavename": "talos-linux64-ix-008", 19:08:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:08:07 INFO - "platform": "ubuntu64_hw", 19:08:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:08:07 INFO - "branch": "mozilla-central", 19:08:07 INFO - "repo_path": "mozilla-central", 19:08:07 INFO - "revision": "051765f8237daf5da7ba0d3e97da16668ce9988c", 19:08:07 INFO - "stage_platform": "linux64-pgo", 19:08:07 INFO - "builduid": "7713e4fd0e3444c68c45b3e76da34958", 19:08:07 INFO - "slavebuilddir": "test" 19:08:07 INFO - } 19:08:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:08:07 INFO - Running post-action listener: _resource_record_post_action 19:08:07 INFO - ##### 19:08:07 INFO - ##### Finished read-buildbot-config step (success) 19:08:07 INFO - ##### 19:08:07 INFO - ##### 19:08:07 INFO - ##### Running download-and-extract step. 19:08:07 INFO - ##### 19:08:07 INFO - Running pre-action listener: _resource_record_pre_action 19:08:07 INFO - Running main action method: download_and_extract 19:08:07 INFO - mkdir: /builds/slave/test/build/tests 19:08:07 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')]} 19:08:07 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:07 INFO - Downloaded 1361 bytes. 19:08:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - Using the following test package requirements: 19:08:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'jsshell-linux-x86_64.zip'], 19:08:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:07 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')]} 19:08:07 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:09 INFO - Downloaded 24451218 bytes. 19:08:09 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'] 19:08:09 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 19:08:11 INFO - Return code: 0 19:08:11 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 19:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:11 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:12 INFO - Downloaded 24451218 bytes. 19:08:12 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'] 19:08:12 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 19:08:13 INFO - Return code: 0 19:08:13 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')]} 19:08:13 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:14 INFO - Downloaded 10833369 bytes. 19:08:14 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'] 19:08:14 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 19:08:14 INFO - Return code: 0 19:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:14 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:08:16 INFO - Downloaded 59273696 bytes. 19:08:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:16 INFO - mkdir: /builds/slave/test/properties 19:08:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:16 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:16 INFO - Contents: 19:08:16 INFO - build_url:https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:17 INFO - Running post-action listener: _resource_record_post_action 19:08:17 INFO - Running post-action listener: set_extra_try_arguments 19:08:17 INFO - ##### 19:08:17 INFO - ##### Finished download-and-extract step (success) 19:08:17 INFO - ##### 19:08:17 INFO - ##### 19:08:17 INFO - ##### Running populate-webroot step. 19:08:17 INFO - ##### 19:08:17 INFO - Running pre-action listener: _resource_record_pre_action 19:08:17 INFO - Running main action method: populate_webroot 19:08:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:17 INFO - '--tppagecycles', 19:08:17 INFO - '7'], 19:08:17 INFO - 'tests': ['tsvgm']}}, 19:08:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['damp', 'tps']}, 19:08:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'tests': ['damp', 'tps']}, 19:08:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['dromaeo_dom']}, 19:08:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['a11yr', 19:08:17 INFO - 'ts_paint', 19:08:17 INFO - 'tpaint', 19:08:17 INFO - 'sessionrestore', 19:08:17 INFO - 'sessionrestore_no_auto_restore', 19:08:17 INFO - 'tabpaint']}, 19:08:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['tsvgx', 19:08:17 INFO - 'tsvgr_opacity', 19:08:17 INFO - 'tart', 19:08:17 INFO - 'tscrollx', 19:08:17 INFO - 'cart']}, 19:08:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:17 INFO - 'tsvgr_opacity', 19:08:17 INFO - 'tart', 19:08:17 INFO - 'tscrollx', 19:08:17 INFO - 'cart']}, 19:08:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'talos_options': ['--disable-e10s'], 19:08:17 INFO - 'tests': ['tp5o']}, 19:08:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'tests': ['tp5o']}, 19:08:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'talos_options': ['--disable-e10s', 19:08:17 INFO - '--xperf_path', 19:08:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:17 INFO - 'tests': ['tp5n']}, 19:08:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:17 INFO - 'talos_options': ['--xperf_path', 19:08:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:17 INFO - 'tests': ['tp5n']}}, 19:08:17 INFO - 'talos.zip': {'path': '', 19:08:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:17 INFO - Running post-action listener: _resource_record_post_action 19:08:17 INFO - ##### 19:08:17 INFO - ##### Finished populate-webroot step (success) 19:08:17 INFO - ##### 19:08:17 INFO - ##### 19:08:17 INFO - ##### Running create-virtualenv step. 19:08:17 INFO - ##### 19:08:17 INFO - Running pre-action listener: _resource_record_pre_action 19:08:17 INFO - Running main action method: create_virtualenv 19:08:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:17 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 19:08:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:17 INFO - Using real prefix '/usr' 19:08:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:18 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:20 INFO - Installing pip.................done. 19:08:20 INFO - Return code: 0 19:08:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:20 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 19:08:20 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 19:08:20 INFO - Using env: {'DISPLAY': ':0', 19:08:20 INFO - 'HOME': '/home/cltbld', 19:08:20 INFO - 'LANG': 'en_US.UTF-8', 19:08:20 INFO - 'LANGUAGE': 'en_US:en', 19:08:20 INFO - 'LOGNAME': 'cltbld', 19:08:20 INFO - 'MAIL': '/var/mail/cltbld', 19:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:20 INFO - 'MOZ_NO_REMOTE': '1', 19:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:20 INFO - 'NO_EM_RESTART': '1', 19:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:20 INFO - 'PWD': '/builds/slave/test', 19:08:20 INFO - 'SHELL': '/bin/bash', 19:08:20 INFO - 'SHLVL': '1', 19:08:20 INFO - 'TERM': 'linux', 19:08:20 INFO - 'TMOUT': '86400', 19:08:20 INFO - 'USER': 'cltbld', 19:08:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:20 INFO - '_': '/tools/buildbot/bin/python'} 19:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:20 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 19:08:20 INFO - Cleaning up... 19:08:20 INFO - Return code: 0 19:08:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:20 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 19:08:20 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 19:08:20 INFO - Using env: {'DISPLAY': ':0', 19:08:20 INFO - 'HOME': '/home/cltbld', 19:08:20 INFO - 'LANG': 'en_US.UTF-8', 19:08:20 INFO - 'LANGUAGE': 'en_US:en', 19:08:20 INFO - 'LOGNAME': 'cltbld', 19:08:20 INFO - 'MAIL': '/var/mail/cltbld', 19:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:20 INFO - 'MOZ_NO_REMOTE': '1', 19:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:20 INFO - 'NO_EM_RESTART': '1', 19:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:20 INFO - 'PWD': '/builds/slave/test', 19:08:20 INFO - 'SHELL': '/bin/bash', 19:08:20 INFO - 'SHLVL': '1', 19:08:20 INFO - 'TERM': 'linux', 19:08:20 INFO - 'TMOUT': '86400', 19:08:20 INFO - 'USER': 'cltbld', 19:08:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:20 INFO - '_': '/tools/buildbot/bin/python'} 19:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:20 INFO - Downloading/unpacking psutil>=3.1.1 19:08:20 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 19:08:20 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 19:08:20 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 19:08:20 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 19:08:20 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 19:08:20 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 19:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:22 INFO - Installing collected packages: psutil 19:08:22 INFO - Running setup.py install for psutil 19:08:22 INFO - building 'psutil._psutil_linux' extension 19:08:22 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 19:08:22 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 19:08:22 INFO - building 'psutil._psutil_posix' extension 19:08:22 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 19:08:22 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 19:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:23 INFO - Successfully installed psutil 19:08:23 INFO - Cleaning up... 19:08:23 INFO - Return code: 0 19:08:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:23 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')]} 19:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 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')]} 19:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:23 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 19:08:23 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 19:08:23 INFO - Using env: {'DISPLAY': ':0', 19:08:23 INFO - 'HOME': '/home/cltbld', 19:08:23 INFO - 'LANG': 'en_US.UTF-8', 19:08:23 INFO - 'LANGUAGE': 'en_US:en', 19:08:23 INFO - 'LOGNAME': 'cltbld', 19:08:23 INFO - 'MAIL': '/var/mail/cltbld', 19:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:23 INFO - 'MOZ_NO_REMOTE': '1', 19:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:23 INFO - 'NO_EM_RESTART': '1', 19:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:23 INFO - 'PWD': '/builds/slave/test', 19:08:23 INFO - 'SHELL': '/bin/bash', 19:08:23 INFO - 'SHLVL': '1', 19:08:23 INFO - 'TERM': 'linux', 19:08:23 INFO - 'TMOUT': '86400', 19:08:23 INFO - 'USER': 'cltbld', 19:08:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:23 INFO - '_': '/tools/buildbot/bin/python'} 19:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:23 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 19:08:23 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 19:08:23 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 19:08:23 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 19:08:23 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 19:08:23 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 19:08:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:25 INFO - Installing collected packages: mozsystemmonitor 19:08:25 INFO - Running setup.py install for mozsystemmonitor 19:08:25 INFO - Successfully installed mozsystemmonitor 19:08:25 INFO - Cleaning up... 19:08:25 INFO - Return code: 0 19:08:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:08:25 INFO - Using env: {'DISPLAY': ':0', 19:08:25 INFO - 'HOME': '/home/cltbld', 19:08:25 INFO - 'LANG': 'en_US.UTF-8', 19:08:25 INFO - 'LANGUAGE': 'en_US:en', 19:08:25 INFO - 'LOGNAME': 'cltbld', 19:08:25 INFO - 'MAIL': '/var/mail/cltbld', 19:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:25 INFO - 'MOZ_NO_REMOTE': '1', 19:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:25 INFO - 'NO_EM_RESTART': '1', 19:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:25 INFO - 'PWD': '/builds/slave/test', 19:08:25 INFO - 'SHELL': '/bin/bash', 19:08:25 INFO - 'SHLVL': '1', 19:08:25 INFO - 'TERM': 'linux', 19:08:25 INFO - 'TMOUT': '86400', 19:08:25 INFO - 'USER': 'cltbld', 19:08:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:25 INFO - '_': '/tools/buildbot/bin/python'} 19:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:27 INFO - warning: no files found matching '*.txt' 19:08:27 INFO - no previously-included directories found matching 'build' 19:08:27 INFO - no previously-included directories found matching 'dist' 19:08:27 INFO - no previously-included directories found matching '.git*' 19:08:27 INFO - Installing collected packages: jsonschema, functools32 19:08:27 INFO - Running setup.py install for functools32 19:08:28 INFO - warning: no files found matching '*.txt' 19:08:28 INFO - no previously-included directories found matching 'build' 19:08:28 INFO - no previously-included directories found matching 'dist' 19:08:28 INFO - no previously-included directories found matching '.git*' 19:08:28 INFO - Successfully installed jsonschema functools32 19:08:28 INFO - Cleaning up... 19:08:28 INFO - Return code: 0 19:08:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:28 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:28 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 19:08:28 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 19:08:28 INFO - Using env: {'DISPLAY': ':0', 19:08:28 INFO - 'HOME': '/home/cltbld', 19:08:28 INFO - 'LANG': 'en_US.UTF-8', 19:08:28 INFO - 'LANGUAGE': 'en_US:en', 19:08:28 INFO - 'LOGNAME': 'cltbld', 19:08:28 INFO - 'MAIL': '/var/mail/cltbld', 19:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:28 INFO - 'MOZ_NO_REMOTE': '1', 19:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:28 INFO - 'NO_EM_RESTART': '1', 19:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:28 INFO - 'PWD': '/builds/slave/test', 19:08:28 INFO - 'SHELL': '/bin/bash', 19:08:28 INFO - 'SHLVL': '1', 19:08:28 INFO - 'TERM': 'linux', 19:08:28 INFO - 'TMOUT': '86400', 19:08:28 INFO - 'USER': 'cltbld', 19:08:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:28 INFO - '_': '/tools/buildbot/bin/python'} 19:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:28 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:30 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - Downloading docopt-0.6.1.tar.gz 19:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:30 INFO - Running setup.py install for blobuploader 19:08:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:31 INFO - Running setup.py install for requests 19:08:31 INFO - Running setup.py install for docopt 19:08:31 INFO - Successfully installed blobuploader requests docopt 19:08:31 INFO - Cleaning up... 19:08:31 INFO - Return code: 0 19:08:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:31 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 19:08:31 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 19:08:31 INFO - Using env: {'DISPLAY': ':0', 19:08:31 INFO - 'HOME': '/home/cltbld', 19:08:31 INFO - 'LANG': 'en_US.UTF-8', 19:08:31 INFO - 'LANGUAGE': 'en_US:en', 19:08:31 INFO - 'LOGNAME': 'cltbld', 19:08:31 INFO - 'MAIL': '/var/mail/cltbld', 19:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:31 INFO - 'MOZ_NO_REMOTE': '1', 19:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:31 INFO - 'NO_EM_RESTART': '1', 19:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:31 INFO - 'PWD': '/builds/slave/test', 19:08:31 INFO - 'SHELL': '/bin/bash', 19:08:31 INFO - 'SHLVL': '1', 19:08:31 INFO - 'TERM': 'linux', 19:08:31 INFO - 'TMOUT': '86400', 19:08:31 INFO - 'USER': 'cltbld', 19:08:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:31 INFO - '_': '/tools/buildbot/bin/python'} 19:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:31 INFO - Running setup.py (path:/tmp/pip-h9aG5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:31 INFO - Running setup.py (path:/tmp/pip-cFkLng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:31 INFO - Running setup.py (path:/tmp/pip-4O5aUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:31 INFO - Running setup.py (path:/tmp/pip-VaiPxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:32 INFO - Running setup.py (path:/tmp/pip-IvXPXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:32 INFO - Running setup.py (path:/tmp/pip-ft4sN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:32 INFO - Running setup.py (path:/tmp/pip-5xRrQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:32 INFO - Running setup.py (path:/tmp/pip-3UOHnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:32 INFO - Running setup.py (path:/tmp/pip-2olkPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:32 INFO - Running setup.py (path:/tmp/pip-EPDHGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:32 INFO - Running setup.py (path:/tmp/pip-G161bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:32 INFO - Running setup.py (path:/tmp/pip-rDQOaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:32 INFO - Running setup.py (path:/tmp/pip-AE5o_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:32 INFO - Running setup.py (path:/tmp/pip-o9A4WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:32 INFO - Running setup.py (path:/tmp/pip-Ki844L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:32 INFO - Running setup.py (path:/tmp/pip-lTWPfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:32 INFO - Running setup.py (path:/tmp/pip-mHtLQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:33 INFO - Running setup.py install for manifestparser 19:08:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Running setup.py install for mozcrash 19:08:33 INFO - Running setup.py install for mozdebug 19:08:33 INFO - Running setup.py install for mozdevice 19:08:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Running setup.py install for mozfile 19:08:33 INFO - Running setup.py install for mozhttpd 19:08:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Running setup.py install for mozinfo 19:08:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Running setup.py install for mozInstall 19:08:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:33 INFO - Running setup.py install for mozleak 19:08:33 INFO - Running setup.py install for mozlog 19:08:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Running setup.py install for moznetwork 19:08:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Running setup.py install for mozprocess 19:08:34 INFO - Running setup.py install for mozprofile 19:08:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Running setup.py install for mozrunner 19:08:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Running setup.py install for mozscreenshot 19:08:34 INFO - Running setup.py install for moztest 19:08:34 INFO - Running setup.py install for mozversion 19:08:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:34 INFO - Cleaning up... 19:08:34 INFO - Return code: 0 19:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:34 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 19:08:34 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 19:08:34 INFO - Using env: {'DISPLAY': ':0', 19:08:34 INFO - 'HOME': '/home/cltbld', 19:08:34 INFO - 'LANG': 'en_US.UTF-8', 19:08:34 INFO - 'LANGUAGE': 'en_US:en', 19:08:34 INFO - 'LOGNAME': 'cltbld', 19:08:34 INFO - 'MAIL': '/var/mail/cltbld', 19:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:34 INFO - 'MOZ_NO_REMOTE': '1', 19:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:34 INFO - 'NO_EM_RESTART': '1', 19:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:34 INFO - 'PWD': '/builds/slave/test', 19:08:34 INFO - 'SHELL': '/bin/bash', 19:08:34 INFO - 'SHLVL': '1', 19:08:34 INFO - 'TERM': 'linux', 19:08:34 INFO - 'TMOUT': '86400', 19:08:34 INFO - 'USER': 'cltbld', 19:08:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:34 INFO - '_': '/tools/buildbot/bin/python'} 19:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:34 INFO - Running setup.py (path:/tmp/pip-OKzCj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 INFO - Running setup.py (path:/tmp/pip-eh7WJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 INFO - Running setup.py (path:/tmp/pip-ZLwj8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 INFO - Running setup.py (path:/tmp/pip-0keyxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:35 INFO - Running setup.py (path:/tmp/pip-NjL2TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 INFO - Running setup.py (path:/tmp/pip-lLStto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 INFO - Running setup.py (path:/tmp/pip-lk6l28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:35 INFO - Running setup.py (path:/tmp/pip-qnZYIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:35 INFO - Running setup.py (path:/tmp/pip-CEX8c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:35 INFO - Running setup.py (path:/tmp/pip-Lltn9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:35 INFO - Running setup.py (path:/tmp/pip-AobQAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:35 INFO - Running setup.py (path:/tmp/pip-tuYisk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:35 INFO - Running setup.py (path:/tmp/pip-6W2Q_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:35 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)) 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:35 INFO - Running setup.py (path:/tmp/pip-NIGj3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:36 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)) 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:36 INFO - Running setup.py (path:/tmp/pip-z76FgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:36 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)) 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:36 INFO - Running setup.py (path:/tmp/pip-3P8_TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:36 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)) 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:36 INFO - Running setup.py (path:/tmp/pip-0Y5PGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:36 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)) 19:08:36 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)) 19:08:36 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)) 19:08:36 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)) 19:08:36 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)) 19:08:36 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)) 19:08:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:36 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 19:08:36 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 19:08:36 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 19:08:36 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 19:08:36 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 19:08:36 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 19:08:38 INFO - Downloading blessings-1.6.tar.gz 19:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:38 INFO - Installing collected packages: blessings 19:08:38 INFO - Running setup.py install for blessings 19:08:38 INFO - Successfully installed blessings 19:08:38 INFO - Cleaning up... 19:08:38 INFO - Return code: 0 19:08:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:38 INFO - Reading from file tmpfile_stdout 19:08:38 INFO - Current package versions: 19:08:38 INFO - argparse == 1.2.1 19:08:38 INFO - blessings == 1.6 19:08:38 INFO - blobuploader == 1.2.4 19:08:38 INFO - docopt == 0.6.1 19:08:38 INFO - functools32 == 3.2.3-2 19:08:38 INFO - jsonschema == 2.5.1 19:08:38 INFO - manifestparser == 1.1 19:08:38 INFO - mozInstall == 1.12 19:08:38 INFO - mozcrash == 0.17 19:08:38 INFO - mozdebug == 0.1 19:08:38 INFO - mozdevice == 0.48 19:08:38 INFO - mozfile == 1.2 19:08:38 INFO - mozhttpd == 0.7 19:08:38 INFO - mozinfo == 0.9 19:08:38 INFO - mozleak == 0.1 19:08:38 INFO - mozlog == 3.2 19:08:38 INFO - moznetwork == 0.27 19:08:38 INFO - mozprocess == 0.22 19:08:38 INFO - mozprofile == 0.28 19:08:38 INFO - mozrunner == 6.11 19:08:38 INFO - mozscreenshot == 0.1 19:08:38 INFO - mozsystemmonitor == 0.3 19:08:38 INFO - moztest == 0.7 19:08:38 INFO - mozversion == 1.4 19:08:38 INFO - psutil == 3.1.1 19:08:38 INFO - requests == 1.2.3 19:08:38 INFO - wsgiref == 0.1.2 19:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:38 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')]} 19:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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')]} 19:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:38 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 19:08:38 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 19:08:38 INFO - Using env: {'DISPLAY': ':0', 19:08:38 INFO - 'HOME': '/home/cltbld', 19:08:38 INFO - 'LANG': 'en_US.UTF-8', 19:08:38 INFO - 'LANGUAGE': 'en_US:en', 19:08:38 INFO - 'LOGNAME': 'cltbld', 19:08:38 INFO - 'MAIL': '/var/mail/cltbld', 19:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:38 INFO - 'MOZ_NO_REMOTE': '1', 19:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:38 INFO - 'NO_EM_RESTART': '1', 19:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:38 INFO - 'PWD': '/builds/slave/test', 19:08:38 INFO - 'SHELL': '/bin/bash', 19:08:38 INFO - 'SHLVL': '1', 19:08:38 INFO - 'TERM': 'linux', 19:08:38 INFO - 'TMOUT': '86400', 19:08:38 INFO - 'USER': 'cltbld', 19:08:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:38 INFO - '_': '/tools/buildbot/bin/python'} 19:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 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)) 19:08:38 INFO - Cleaning up... 19:08:38 INFO - Return code: 0 19:08:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:38 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')]} 19:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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')]} 19:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:38 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 19:08:38 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 19:08:38 INFO - Using env: {'DISPLAY': ':0', 19:08:38 INFO - 'HOME': '/home/cltbld', 19:08:38 INFO - 'LANG': 'en_US.UTF-8', 19:08:38 INFO - 'LANGUAGE': 'en_US:en', 19:08:38 INFO - 'LOGNAME': 'cltbld', 19:08:38 INFO - 'MAIL': '/var/mail/cltbld', 19:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:38 INFO - 'MOZ_NO_REMOTE': '1', 19:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:38 INFO - 'NO_EM_RESTART': '1', 19:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:38 INFO - 'PWD': '/builds/slave/test', 19:08:38 INFO - 'SHELL': '/bin/bash', 19:08:38 INFO - 'SHLVL': '1', 19:08:38 INFO - 'TERM': 'linux', 19:08:38 INFO - 'TMOUT': '86400', 19:08:38 INFO - 'USER': 'cltbld', 19:08:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:38 INFO - '_': '/tools/buildbot/bin/python'} 19:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:38 INFO - Cleaning up... 19:08:39 INFO - Return code: 0 19:08:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0f1fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, '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': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', '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 19:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:08:39 INFO - Using env: {'DISPLAY': ':0', 19:08:39 INFO - 'HOME': '/home/cltbld', 19:08:39 INFO - 'LANG': 'en_US.UTF-8', 19:08:39 INFO - 'LANGUAGE': 'en_US:en', 19:08:39 INFO - 'LOGNAME': 'cltbld', 19:08:39 INFO - 'MAIL': '/var/mail/cltbld', 19:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:39 INFO - 'MOZ_NO_REMOTE': '1', 19:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:39 INFO - 'NO_EM_RESTART': '1', 19:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:39 INFO - 'PWD': '/builds/slave/test', 19:08:39 INFO - 'SHELL': '/bin/bash', 19:08:39 INFO - 'SHLVL': '1', 19:08:39 INFO - 'TERM': 'linux', 19:08:39 INFO - 'TMOUT': '86400', 19:08:39 INFO - 'USER': 'cltbld', 19:08:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:39 INFO - '_': '/tools/buildbot/bin/python'} 19:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:39 INFO - Downloading/unpacking flake8 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:41 INFO - no previously-included directories found matching 'docs/_build' 19:08:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:42 INFO - Running setup.py install for pep8 19:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:42 INFO - no previously-included directories found matching 'docs/_build' 19:08:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Running post-action listener: _resource_record_post_action 19:08:42 INFO - Running post-action listener: _start_resource_monitoring 19:08:42 INFO - Starting resource monitoring. 19:08:42 INFO - ##### 19:08:42 INFO - ##### Finished create-virtualenv step (success) 19:08:42 INFO - ##### 19:08:42 INFO - ##### 19:08:42 INFO - ##### Running install step. 19:08:42 INFO - ##### 19:08:42 INFO - Running pre-action listener: _resource_record_pre_action 19:08:42 INFO - Running main action method: install 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Output received: 19:08:42 INFO - Usage: mozinstall [options] installer 19:08:42 INFO - Options: 19:08:42 INFO - -h, --help show this help message and exit 19:08:42 INFO - -d DEST, --destination=DEST 19:08:42 INFO - Directory to install application into. [default: 19:08:42 INFO - "/builds/slave/test"] 19:08:42 INFO - --app=APP Application being installed. [default: firefox] 19:08:42 INFO - mkdir: /builds/slave/test/build/application 19:08:42 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'] 19:08:42 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 19:08:59 INFO - Reading from file tmpfile_stdout 19:08:59 INFO - Output received: 19:08:59 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:59 INFO - Running post-action listener: _resource_record_post_action 19:08:59 INFO - ##### 19:08:59 INFO - ##### Finished install step (success) 19:08:59 INFO - ##### 19:08:59 INFO - ##### 19:08:59 INFO - ##### Running run-tests step. 19:08:59 INFO - ##### 19:08:59 INFO - Running pre-action listener: _resource_record_pre_action 19:08:59 INFO - Running main action method: run_tests 19:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:59 INFO - Python 2.7.3 19:08:59 INFO - Return code: 0 19:08:59 INFO - grabbing minidump binary from tooltool 19:08: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')]} 19:08:59 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 0x2165110>, '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 0x20d1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d16c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:59 INFO - Return code: 0 19:08:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:09:00 INFO - Return code: 0 19:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 19:09:00 INFO - Using env: {'DISPLAY': ':0', 19:09:00 INFO - 'HOME': '/home/cltbld', 19:09:00 INFO - 'LANG': 'en_US.UTF-8', 19:09:00 INFO - 'LANGUAGE': 'en_US:en', 19:09:00 INFO - 'LOGNAME': 'cltbld', 19:09:00 INFO - 'MAIL': '/var/mail/cltbld', 19:09:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:00 INFO - 'MOZ_NO_REMOTE': '1', 19:09:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:00 INFO - 'NO_EM_RESTART': '1', 19:09:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:00 INFO - 'PWD': '/builds/slave/test', 19:09:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:00 INFO - 'SHELL': '/bin/bash', 19:09:00 INFO - 'SHLVL': '1', 19:09:00 INFO - 'TERM': 'linux', 19:09:00 INFO - 'TMOUT': '86400', 19:09:00 INFO - 'USER': 'cltbld', 19:09:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055', 19:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:00 INFO - '_': '/tools/buildbot/bin/python'} 19:09:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 19:09:00 INFO - mozversion application_buildid: 20160608163004 19:09:00 INFO - mozversion application_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 19:09:00 INFO - mozversion application_display_name: Nightly 19:09:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:00 INFO - mozversion application_name: Firefox 19:09:00 INFO - mozversion application_remotingname: firefox 19:09:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:09:00 INFO - mozversion application_vendor: Mozilla 19:09:00 INFO - mozversion application_version: 50.0a1 19:09:00 INFO - mozversion platform_buildid: 20160608163004 19:09:00 INFO - mozversion platform_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 19:09:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:09:00 INFO - mozversion platform_version: 50.0a1 19:09:00 INFO - using testdate: 1465438140 19:09:00 INFO - actual date: 1465438140 19:09:00 INFO - starting webserver on 'localhost:48820' 19:09:00 INFO - SUITE-START | Running 2 tests 19:09:00 INFO - TEST-START | dromaeo_css 19:09:00 INFO - operating with platform_type : linux_ 19:09:00 INFO - Initialising browser for dromaeo_css test... 19:09:00 INFO - TEST-INFO | started process 4242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3G7Zae/profile http://localhost:48820/getInfo.html) 19:09:04 INFO - PROCESS | 4242 | __metrics Screen width/height:1600/1200 19:09:04 INFO - PROCESS | 4242 | colorDepth:24 19:09:04 INFO - PROCESS | 4242 | Browser inner width/height: 1024/697 19:09:04 INFO - PROCESS | 4242 | __metrics 19:09:05 ERROR - PROCESS | 4242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:09:05 INFO - PROCESS | 4242 | console.error: PushService: 19:09:05 INFO - PROCESS | 4242 | stateChangeProcessEnqueue: Error transitioning state 19:09:05 INFO - PROCESS | 4242 | UnknownError 19:09:06 INFO - TEST-INFO | 4242: exit 0 19:09:06 INFO - Browser initialized. 19:09:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:06 INFO - TEST-INFO | started process 4325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3G7Zae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:18 INFO - PROCESS | 4325 | RSS: Main: 159490048 19:09:18 INFO - PROCESS | 4325 | 19:10:09 INFO - PROCESS | 4325 | 1465438209524 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] 19:12:17 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48820/tests/dromaeo/cssquery-ext.html) 19:12:18 INFO - PROCESS | 4325 | RSS: Main: 281317376 19:12:18 INFO - PROCESS | 4325 | 19:15:20 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-ext.html (next: http://localhost:48820/tests/dromaeo/cssquery-jquery.html) 19:15:21 INFO - PROCESS | 4325 | RSS: Main: 245829632 19:15:21 INFO - PROCESS | 4325 | 19:18:23 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48820/tests/dromaeo/cssquery-mootools.html) 19:18:23 INFO - PROCESS | 4325 | RSS: Main: 246554624 19:18:23 INFO - PROCESS | 4325 | 19:21:25 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48820/tests/dromaeo/cssquery-prototype.html) 19:21:26 INFO - PROCESS | 4325 | RSS: Main: 237162496 19:21:26 INFO - PROCESS | 4325 | 19:24:29 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48820/tests/dromaeo/cssquery-yui.html) 19:24:29 INFO - PROCESS | 4325 | RSS: Main: 226414592 19:24:29 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | Cycle 1(1): loaded http://localhost:48820/tests/dromaeo/cssquery-yui.html (next: http://localhost:48820/tests/dromaeo/cssquery-dojo.html) 19:27:32 INFO - PROCESS | 4325 | RSS: Main: 269688832 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | __start_tp_report 19:27:32 INFO - PROCESS | 4325 | _x_x_mozilla_page_load 19:27:32 INFO - PROCESS | 4325 | _x_x_mozilla_page_load_details 19:27:32 INFO - PROCESS | 4325 | |i|pagename|runs| 19:27:32 INFO - PROCESS | 4325 | |0;dojo.html;3108.8911888083912;3116;3130.326979699364;3160.0203936779585;3181.2683082890935;5095.210242412432;5147.7426128693505;5182.948170518293;5241.030409374263;5269.973650131748;5178.66338687986;5230;5230.633855630107;5258.106121959267;5269.947300526994;4772.117158325704;4792.089502994429;4797.90404191916;4850.296706977486;4945.554900058994;4870.391201099863;4893.339399181101;4905.705657660534;4933.1860243059855;4962.206047032458;4710.434747830265;4748.19280722278;4771.904561908777;4784.880377990543;4787.569118779309;4764.4759076501905;4767.261074533453;4801.063792560452;4816.397950256218;4818.180909245437;4723.315119307716;4742.478327383985;4747.145513807548;4820.879478013043;4824.348712923746;5228.843134705965;5263;5263.131583288753;5274.7626356814035;5275.208718692188;5484.341878974508;5489.286392768954;5525.475079867406;5530.723463826793;5693.800716974927;5680.772769089232;5688.317401911756;5693.544516438675;5695.943040569583;5703.230063941356;5262.105442074857;5300.3639563252655;5307.442718514578;5307.469253074701;5314.760835762361;5601.355844077902;5701.515371193412;5744.827655170351;5753.654780713171;5848.88302233953;5580.302462192226;5640.830775076673;5641.464060914206;5642.266505354278;5644.407337229614;5507.091329930597;5650.886982260332;5656.8868622627315;5663.773449062074;5714.085746280658;5577.832665020056;5603.635763675429;5627.634203776742;5651.406602306781;5657.830265092054;5612.943870561324;5657.547396208293;5657.773689052392;5661.547076233891;5665.3768085510565;4237.237297286456;4271.273883439822;4327.7186982846015;4332.631726303236;4370.497392799869;3846.5576458707046;3853.5183102112237;3862.671672907778;3895.2599006188734;3921.686265098785;5254.185601231815;5254.343207099113;5268.604854635841;5275.182346736262;5321.441248668834;5522.364928033247;5564.972175139098;5581.079121944915;5618.803341883096;5666.065099258659;5291.126964050965;5302.655327403706;5309.7079660618265;5315.840524784263;5344.8663783404945;4852.8544143675745;4855.732934688626;4873.853784386474;4874.390701162355;4915.827946021872;5650.717464126859;5701.543876489871;5728.598998070179;5729.999999999916;5783.537317014629;5612.074007788832;5634.774609015757;5637.774489020558;5639.971800140973;5644.774209031592;5767.048437007847;5780.682062486603;5781.046127388934;5783.392743761844;5783.971080144741;5448.56411487088;5495.642783219078;5519.3652729936575;5542.750576223999;5584.944150558443;5662.773489060556;5664.37691853904;5667.744951477111;5673.517750991212;5681.375048744718;5349.197620356822;5468.6171967963455;5509.614326997072;5520.66875987426;5524.392316845064;5391.4338994405025;5405.540529055074;5406.756695948613;5432.185172224198;5460.699661518495;5323.6273460857365;5346.144616861284;5353.411124776194;5358.732063396893;5379.54273886724;5388.865278368072;5467.58993075513;5528.281323428089;5541.778328866962;5569.66582005081;5288.867778305573;5353.089974704231;5375.408705042364;5402.351717793733;5519.337679478488 19:27:32 INFO - PROCESS | 4325 | |1;ext.html;573.5870173475097;613.6226220874163;623.8035018969024;632.9682617333748;659.7756762700681;31647.050588482354;42734.35898461522;43783.78108109459;43968.78015609925;44038;42027;42340.57659423405;42354.364684529755;42377.576224237746;42419.57580424195;8833.955830220855;8974.102589741005;8989.101089890992;8990.190882820545;8992;8778.868316975251;8891.199792018717;8907.866382004275;8908.51003194824;8910.688125915594;8925.687600933968;8957.19385255327;8984.505852178128;8987.325950553703;8988.865167022468;8878.778030549223;8928.642854285821;8929.553522323922;8933.06202848698;8942.64229430822;8760.12398760119;8845.823083538293;8850.114988501162;8850.468971861708;8853.690120845804;42255.366169507484;42421;42513.1497370054;42648.14703705908;42730.35904461436;3336.5495658086093;3377.4427219508752;3395.2530443302435;3456.0443394439435;3783.4135708965155;31905.52141717876;31944.680553194634;32309.192270193198;32346.83826580852;32415.189620259447;4059.5940405959464;4079.388091786226;4217.240896638604;4222.662187025031;4277.721948073366;367749.9999999973;368488;369041;369748;370101;54998;55569;55901.72049139728;55903.72048139733;55959.72020139873;58139;58492.70753646205;58521.12218316729;58568;58579.70710146422;17205.397811076804;17372.131393430278;17416.65166696659;17419.39032133869;17422.651546969242;13618.114822536503;13662.18026918388;13673.453061877612;13707.725845483035;13731.107478013897;14996.775048374284;15464.690706185813;15651.139187344805;15759.606009849616;15966;6156.384361563808;6334.588251763621;6344.777932772423;6424.807255782334;6438.9756402248595;979.3291595257272;1047.2669131607904;1057.645688694296;1091.8471414002047;1096.2788422177264;32437;32798.34403311968;32891.50662740061;33189.83405082959;33496.66503334935;1119.5297974850582;1127.4306475229957;1134.5235001299475;1141.4292853573213;1220.737541428597;16433.178341083138;17051.91474042622;17182;17215.91392043057;17319.039391329046;586323;587289;594254;596652;599357;57392.426075739546;57455.42544574501;57544.71227643919;57565.71217143888;57599.424005760244;1300.2913412190378;1367.9521216757366;1404.206623257856;1410.739013282546;1413.7596608576566;32358.83820580882;34009.65990340065;34027.319453611286;34066.79881662687;34294.48558271678;48696;48872;49368;49423.75288123536;49485.257721133494;332781;333183;333696;334103;334910;34690;38871.805640971616;39966;40311.19377612373;40383.59616403798;47025.29462058003;47520.52479475161;47734;48519.272210917574;49104.263436047775;40269.19461610693;40810;41006.1798764029;41619.7919010403;41831.37252941148;40510.77190754537;40728.389074163315;41226;41874.37188442237;42060;41074;41151.176976459705;41323.1735365297;42158.15683686248;42282.36576451294;34769.47845782366;36420.4536931941;36622.08444788795;36704.63295367012;36939.26121477609;28054.85972570124;28385.858070709513;28417.28956776097;28562.428751425272;28728.569071463528 19:27:32 INFO - PROCESS | 4325 | |2;jquery.html;369.4071016019289;383.24500733554896;385.86494726845626;391.53602980468145;402.9093453972856;15131.394744210245;15158.242087895589;18073.548161295974;19872.20511179553;19901;17773.733393999068;18722.531936701555;19447.124879380426;19547.5113122172;19576.706349404736;5518.724063796814;5595.300587426572;5668;5714.342850572175;5721;4001.7398869073418;5566.832995010136;5894.322152952423;6157.630542167484;6169.413905678975;6096.416808064669;6157.784477543287;6219.2847822500535;6219.90670139946;6226.875462490748;6104.389561043905;6175.2589689237575;6207.099970504251;6258.217722784652;6269.874602507947;4840.70955742653;5152.742362881841;5424.755885985141;5427.864303392407;5429.131338985743;13061.738765224738;13069.615667148126;13394.06241563091;13402.731945361136;21445.78554214469;2151.967720484194;2210.126999835072;2223.6886835842993;2286.0741399733133;2367.981767839828;9283.489408082552;9297.953510232473;9634.03659634038;9768.413895166314;9784.51077446132;1889.1687657430687;1949.512621844539;1954.6188493243824;1971.5662554238045;2013.3389953288595;81478;81488;81623;81635.367292655;83690;10018.899811001942;10437.217208709377;10723.356598604109;10907.400092994803;10989.560417583207;15226;15344.693106137815;15345.386184552715;15371.769423458658;15375.923120384326;7565.508241964255;7707.499012564165;7749.3413059890545;7899;7906.723264685708;7258.346748792634;7303.3792127668685;7413.8146546336775;7500;7516.398688104939;4593.770311484479;4660.487346391894;4743.952560474351;4782.450018247946;4799.472058073609;1798.6222893192314;1899.6118965190178;1910.1404368034441;1911.1972971351788;1933.7002764571514;916.4913473022403;979.7207795778312;989.5843745626854;989.8911119776819;994.5126887824914;18230;18595.163217655238;18602.720959185623;18883.81116188848;18954.336598219274;1001.4892404873567;1001.5442973447064;1047.8683022335858;1066.248294952057;1079.7786453776957;9575.06012362615;10769.138468922467;10769.946150269356;10771.51528181218;10805.351678899291;473019;480392;482477;497841;499191;58954;83416;86308;87422.68865967015;88038;992.9553170107363;998.8851282102506;1023.8822535408375;1034.0972610396755;1036.3522798251092;16850.57873553171;16904.915475422546;17006.57483562921;17200.913995429943;17417.651646966737;37432.81283593673;38345;38639.613603864724;39091.6090839088;39300.41049384204;49365.75317123391;54057.72971135119;54100.729496352265;54350.45649543612;54484;4962.801487940442;5093.439721630543;7849.210432975549;7969;8098.797530061795;10030.89969100329;12255.87744122583;12325.383730813603;12517.56188533397;12916.547920822726;10815.24293299493;11033.503492343025;11154.665360039211;11204.83192752093;11579.536818527165;10835.837462437912;11028.834567481656;11286.379249141048;11368.374739389414;11467.942660286646;11214.607488737855;11271.323720576791;11360.829587556358;11485.712857178638;11740.58907938218;7828.921710782819;7965.442419030613;8028.237317454832;8110.918890811253;8133.79665508367;8113.1886811320755;10393;11385.430728463378;11458.427078645867;11482.540698371971 19:27:32 INFO - PROCESS | 4325 | |3;mootools.html;1349.446726841995;1529.3270960777256;1544.3398346777215;1652.8016638003442;1799.4151900632298;8329.91670083299;8777.297816174698;8787.780305492366;9051.049639787827;9063.410878292923;8577.614007369668;8761.43050701704;8763.518006509656;8767.473951562895;8786.560671966392;1939.806019398063;2003.8597298189134;2006.1574138861713;2170.674398840171;2195.9451013724624;2172.1094351315965;2228.92198773043;2229.409206560255;2237.552489502098;2246.1576908659254;2151.268568686646;2158.2769772126358;2176.5102851858364;2181.476445653048;2184.7050648162453;1930.8262256396852;2140.9892950535304;2171.337741988693;2171.8371122165745;2211.6019116559014;2256.5035692147703;2288.8969996350206;2290.0839664134314;2292.094622624054;2292.4154340643195;8800.735977920673;8869.68956086534;8870.911290887074;8879.822403551958;8880.422772519765;5048.570871475929;5178.663386879878;5180.715060671661;5181.35233095863;5185.403678576974;3045.725884670368;3127.8592463339205;3246.3669584431045;3261.5596894419423;3268.7875288106197;1089.6626735652062;1098.6374496416163;1108.927919685226;1140.7433327501328;1174.4656181437426;12300.507979680802;12318.75362492745;12341.691457713629;12343.567975120828;12350.567730129402;4408.404865343202;4424.933625995613;4492.146492166478;4516.254817955067;4525.909481810345;10345.482725863676;10374;10389.220808439397;10397.376157430579;10401.739956501147;4984.90030199394;5031.345925029796;5034.924476132861;5039.4708555601865;5039.899202015939;4107.199096176217;4525.796339164745;4589.380433641482;4625.514320996314;4649;3753.2118255166174;3763.7741735495956;3814.1990182062077;3838.3666694995572;3862.8841134766003;1162.3665102518978;1218.7014181525583;1223.6573759347398;1224.675461002835;1239.39269757818;938.2915898496591;948.9572969216401;986.6546708652058;1003.2325271167563;1009.5053423822421;5751.654900705971;5842.211301474332;5872.882542349214;6037.366076561898;6120.17377654011;960.2653969713175;962.129273007929;970.8883478399933;991.3060857399705;1012.427978192319;3999.140184860269;4051.9392209116886;4083.1833633273463;4139.91720165595;4163.250614889288;10793;11005.339679619248;11187.272827266203;11201.607943722094;11205.66383008511;11019.393933333584;11081.390523521284;11105.167112466597;11115.166362522843;11116.555337786398;7846.686132554748;8002.679892804223;8114.553699546582;8140.308073813792;8147.144549822302;5981.820545383645;6263.217097862767;6277.3408792078;6294.118823364641;6317.5893566918;10145.28982971185;10181.33821301613;10195.847062293924;10445;10467.94766026165;10285.845712314172;10565.894341056492;10578.841317380091;10594.258401911793;10594.258401911793;6649.966750166218;7750.728724494616;7877.684892604231;8071;8075.475094118863;8584.356173287153;8587.441816281922;8650.697225597074;8664.783380415289;8669.653213871374;7586.658600363107;7621.69513219465;7665.386769058574;7825.491343062683;7846;7423.851522969619;7523.134839493309;7609.543427394374;7713.5371877685275;7723.961380193288;6947.826304342432;6994.195667498303;6998.510104292651;7024.473164512579;7025.718971241093;5011.473795251592;5113.51421614946;5221;5254.527092561688;5276.997370499593;5212.739363031909;5245.790168393221;5247.08176069194;5289.629725919149;5291.523762861361 19:27:32 INFO - PROCESS | 4325 | |4;prototype.html;316.39252634940925;325.57024727359885;329.2016859116643;332.39504102533397;332.75209968573415;5254.264402983586;5340.412554618989;5369.355677318722;5369.731513424328;5490.533304669108;5260.605454590911;5273.551748101407;5303.416624171338;5309.177077552986;5309.787608495655;4095.201435720036;4110.77390743509;4114.382842573623;4117.773522456264;4125.319322311815;4062.431259623655;4122.8144733486915;4126.1541384016355;4126.277901367263;4141.710080294366;4047.1298670785777;4097.422492340455;4111.958880411203;4121.4848143982;4122.793860306988;4090.6522945549664;4108;4117.402976568411;4118.979405102985;4142.523609784883;3613.2412193439145;3626.3653860574295;3642.4354225095153;3642.7267954903223;3657.579378371495;5094.668846525001;5110.437851836295;5115.8209462669;5127.7948882044675;5146.588272938156;4636.11913736389;4660.720356778605;4664.137134630104;4665.323528088442;4704.929426058612;5524.447555244484;5534;5556.749946252388;5574.944250557483;5603.299587551556;3876.554196267437;3945.368741001426;3967.940480892789;3969.4442778011103;3975.6421922027157;5398.16462402785;5609.681724794629;5755.769769209227;5786.334571524287;5827.155062515912;3834.175652234783;3842.769433833979;3848.9230215395537;3855.4987851579117;4012;3755.6807671347697;4028.569857700533;4044.797760111983;4050.5089370037217;4068.7965601719798;4584.564466375689;4640.512746161672;4644.140833945731;4675.3220782986955;4688.429376159025;5522.337319521603;5530.474604912527;5535.33575970878;5551.583631227674;5594;1362.4958765256918;1372.6774208061097;1385.279654579613;1393.1501783911806;1394.1635018988525;872.4939535069772;874.1258741258741;884.6155766225836;894.9463032218088;903.4534106865252;4729.557484967049;4738.95261047392;4750.762461876892;4773.1408346497965;4792.496787837227;5074.314967479417;5080.49195080489;5082.923756143661;5091.41448733393;5118.053160165381;4486.641068714495;4723.385959825269;4768.354917553438;4811.927821082687;4817.278237795635;2636.973630263711;2704.810663253593;2714.9457010859674;2715.9049433270134;2722.454505037796;5174.353205849269;5216.295800067019;5218.921716174261;5232.3982741985155;5282.286891269706;5014.323066386064;5100.617453690988;5113.488651134857;5277.709725965109;5297.65565238266;5176.870578235649;5193.246979187997;5199.532042116228;5207.635465517453;5222.399424066205;5124.924405615731;5153.3558305211845;5168.508991645787;5181.455947125498;5197.402298735694;5112.6165537585575;5155.639105262596;5219.243209734643;5397.379301380234;5672.262605861211;5811.244538210006;5864.208331875313;5867.237259156283;5877.4122587740885;5913.29040515141;4025.5370632377653;4035.5157381114454;4049.210403971197;4060.7563546187325;4064.4309796627904;5562.638428502134;5570.832875013756;5617.4101719320515;5628.690422026828;5655.321361436654;5499.395066542757;5524.558035357242;5531.861703457445;5544.695041772741;5554.389017208185;5316;5528.19841123043;5581.883623275442;5596.964561556125;5606.943930560806;5517.972410137923;5528.9723551381985;5540.750666219949;5542.11326187808;5561.3882472927135;5610.18652295423;5657.4908258256955;5682.715864206856;5694.601377903507;5712.057510510719;5332.5467335276935;5596.832095037155;5598.384177740527;5616.691081990366;5622.269105016322 19:27:32 INFO - PROCESS | 4325 | |5;yui.html;678.9864202715946;689.9724011039559;737.4174402222245;794.638439510023;847.669408930517;13195.34023298836;13216.669583260424;13262.204267743942;14368.71262574748;14839.332230049647;13745.65635859104;14169.362378692958;14220.217888016155;14227.502037428692;14233;692.9861402771967;800.3197282310034;803.602216902634;830.2320353672859;837.8617528107854;818.7298191596789;830.3066939105854;830.6013113705425;830.667732906836;830.90444598871;871.4727589808139;874.1564390363299;878.7846977490492;879.2833840420069;880.0715245416084;716.4125417157933;843.5318398288947;866.9003064647583;871.6861929705301;872.467794645269;635.152071983902;637.1207733328024;640.263696748738;640.362838975218;640.3724350136891;13777.724445511134;13807.792883106762;13824.516141935084;13835.584932452042;13857.099288546213;13067.346632668328;13434.32828358578;13439.529616463475;13558.93220533901;13802;12620.117216553126;12653.493860245671;12916.483340666457;13150.276734779583;13379.933100334534;4436.532523134913;4445.333200019991;4470.977645111753;4515.074409746027;4659.464161621423;72486.63756681235;72799;73639.63180184118;74479.62760186165;75996.88037435488;10595.576176952989;10625.893741062646;11020.724481887857;11116.777664446667;11370.976612104785;19803.009849507467;19805.306814261432;19829.10769015398;19842.305519307043;19847.404577862686;7573.712468880303;7801.648925798353;7818.6090695465;7951.920480795234;8053.07389650186;4455.6212721918355;4510.030343476168;4563.178627846953;4570.702904311275;4650.697704649187;3064.9540256896166;3163.557102005721;3173.936521269608;3174.555562221291;3177.1421716136974;533.8485901815689;555.5194756535649;566.4816692726109;571.2202843119112;587.2571197435248;604.1903848842572;618.9876202475925;651.2933467188059;658.1312667279241;786.3041208530377;9882.160016398542;10446.529906154241;10455.21585881062;10461.84307235392;10465.790684186426;665.9567128136656;709.375749340577;711.1075600121917;722.3679280629449;774.7133560582621;4720;4778.1399348116975;4865.172920603506;4875.317455556225;4880.707157570557;65279.67360163264;67354.66322668355;67387.32612673909;67397.3260267391;87364.5631771837;94900.52549737207;94971;95880.52059739656;96639;96934;82183;87992.56003719941;88095.11904880869;88108;88120;8958.238549723346;9030.954845225731;9055.68305109318;9157.587908543997;9209.493477858514;49015.509844902524;49443;49559.50440495693;51116.233256501924;52422;68908.6554567224;76199.23800761922;76636.23363766514;77675;78680.21319786728;11330.660080197607;11358.182690769438;11569.595064172714;11603.071754259809;11844.881551184722;13221.603351899459;13466.192028478323;13655.931720341334;14313.355898984779;14495.565133046026;14068;14131.364088615832;14170.645733856323;14268.785968210694;14726.926365368105;13960.930195348958;13967.650808729863;14322.427102915766;14454.132752034911;14612.196329201995;13816.792748108988;14063.507777227747;14081.295935203403;14225.288735562974;14305.427782888568;11511.769764604493;11608.767824643628;11680.415979201176;11688.824667630162;12153.210041347284;10869.239153259512;10944.23390362667;11243.943780281374;11510.539578417105;11597.594084207012 19:27:32 INFO - PROCESS | 4325 | __end_tp_report 19:27:32 INFO - PROCESS | 4325 | __start_cc_report 19:27:32 INFO - PROCESS | 4325 | _x_x_mozilla_cycle_collect,1055 19:27:32 INFO - PROCESS | 4325 | __end_cc_report 19:27:32 INFO - PROCESS | 4325 | __startTimestamp1465439252944__endTimestamp 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | ------- Summary: start ------- 19:27:32 INFO - PROCESS | 4325 | Number of tests: 6 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#0] dojo.html Cycles:165 Average:5223.94 Median:5375.41 stddev:570.53 (10.6%) stddev-sans-first:547.62 19:27:32 INFO - PROCESS | 4325 | Values: 3108.9 3116.0 3130.3 3160.0 3181.3 5095.2 5147.7 5182.9 5241.0 5270.0 5178.7 5230.0 5230.6 5258.1 5269.9 4772.1 4792.1 4797.9 4850.3 4945.6 4870.4 4893.3 4905.7 4933.2 4962.2 4710.4 4748.2 4771.9 4784.9 4787.6 4764.5 4767.3 4801.1 4816.4 4818.2 4723.3 4742.5 4747.1 4820.9 4824.3 5228.8 5263.0 5263.1 5274.8 5275.2 5484.3 5489.3 5525.5 5530.7 5693.8 5680.8 5688.3 5693.5 5695.9 5703.2 5262.1 5300.4 5307.4 5307.5 5314.8 5601.4 5701.5 5744.8 5753.7 5848.9 5580.3 5640.8 5641.5 5642.3 5644.4 5507.1 5650.9 5656.9 5663.8 5714.1 5577.8 5603.6 5627.6 5651.4 5657.8 5612.9 5657.5 5657.8 5661.5 5665.4 4237.2 4271.3 4327.7 4332.6 4370.5 3846.6 3853.5 3862.7 3895.3 3921.7 5254.2 5254.3 5268.6 5275.2 5321.4 5522.4 5565.0 5581.1 5618.8 5666.1 5291.1 5302.7 5309.7 5315.8 5344.9 4852.9 4855.7 4873.9 4874.4 4915.8 5650.7 5701.5 5728.6 5730.0 5783.5 5612.1 5634.8 5637.8 5640.0 5644.8 5767.0 5780.7 5781.0 5783.4 5784.0 5448.6 5495.6 5519.4 5542.8 5584.9 5662.8 5664.4 5667.7 5673.5 5681.4 5349.2 5468.6 5509.6 5520.7 5524.4 5391.4 5405.5 5406.8 5432.2 5460.7 5323.6 5346.1 5353.4 5358.7 5379.5 5388.9 5467.6 5528.3 5541.8 5569.7 5288.9 5353.1 5375.4 5402.4 5519.3 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#1] ext.html Cycles:180 Average:59533.90 Median:41471.48 stddev:118740.99 (286.3%) stddev-sans-first:118991.57 19:27:32 INFO - PROCESS | 4325 | Values: 573.6 613.6 623.8 633.0 659.8 31647.1 42734.4 43783.8 43968.8 44038.0 42027.0 42340.6 42354.4 42377.6 42419.6 8834.0 8974.1 8989.1 8990.2 8992.0 8778.9 8891.2 8907.9 8908.5 8910.7 8925.7 8957.2 8984.5 8987.3 8988.9 8878.8 8928.6 8929.6 8933.1 8942.6 8760.1 8845.8 8850.1 8850.5 8853.7 42255.4 42421.0 42513.1 42648.1 42730.4 3336.5 3377.4 3395.3 3456.0 3783.4 31905.5 31944.7 32309.2 32346.8 32415.2 4059.6 4079.4 4217.2 4222.7 4277.7 367750.0 368488.0 369041.0 369748.0 370101.0 54998.0 55569.0 55901.7 55903.7 55959.7 58139.0 58492.7 58521.1 58568.0 58579.7 17205.4 17372.1 17416.7 17419.4 17422.7 13618.1 13662.2 13673.5 13707.7 13731.1 14996.8 15464.7 15651.1 15759.6 15966.0 6156.4 6334.6 6344.8 6424.8 6439.0 979.3 1047.3 1057.6 1091.8 1096.3 32437.0 32798.3 32891.5 33189.8 33496.7 1119.5 1127.4 1134.5 1141.4 1220.7 16433.2 17051.9 17182.0 17215.9 17319.0 586323.0 587289.0 594254.0 596652.0 599357.0 57392.4 57455.4 57544.7 57565.7 57599.4 1300.3 1368.0 1404.2 1410.7 1413.8 32358.8 34009.7 34027.3 34066.8 34294.5 48696.0 48872.0 49368.0 49423.8 49485.3 332781.0 333183.0 333696.0 334103.0 334910.0 34690.0 38871.8 39966.0 40311.2 40383.6 47025.3 47520.5 47734.0 48519.3 49104.3 40269.2 40810.0 41006.2 41619.8 41831.4 40510.8 40728.4 41226.0 41874.4 42060.0 41074.0 41151.2 41323.2 42158.2 42282.4 34769.5 36420.5 36622.1 36704.6 36939.3 28054.9 28385.9 28417.3 28562.4 28728.6 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#2] jquery.html Cycles:180 Average:27886.16 Median:19512.74 stddev:80110.26 (410.6%) stddev-sans-first:80308.35 19:27:32 INFO - PROCESS | 4325 | Values: 369.4 383.2 385.9 391.5 402.9 15131.4 15158.2 18073.5 19872.2 19901.0 17773.7 18722.5 19447.1 19547.5 19576.7 5518.7 5595.3 5668.0 5714.3 5721.0 4001.7 5566.8 5894.3 6157.6 6169.4 6096.4 6157.8 6219.3 6219.9 6226.9 6104.4 6175.3 6207.1 6258.2 6269.9 4840.7 5152.7 5424.8 5427.9 5429.1 13061.7 13069.6 13394.1 13402.7 21445.8 2152.0 2210.1 2223.7 2286.1 2368.0 9283.5 9298.0 9634.0 9768.4 9784.5 1889.2 1949.5 1954.6 1971.6 2013.3 81478.0 81488.0 81623.0 81635.4 83690.0 10018.9 10437.2 10723.4 10907.4 10989.6 15226.0 15344.7 15345.4 15371.8 15375.9 7565.5 7707.5 7749.3 7899.0 7906.7 7258.3 7303.4 7413.8 7500.0 7516.4 4593.8 4660.5 4744.0 4782.5 4799.5 1798.6 1899.6 1910.1 1911.2 1933.7 916.5 979.7 989.6 989.9 994.5 18230.0 18595.2 18602.7 18883.8 18954.3 1001.5 1001.5 1047.9 1066.2 1079.8 9575.1 10769.1 10769.9 10771.5 10805.4 473019.0 480392.0 482477.0 497841.0 499191.0 58954.0 83416.0 86308.0 87422.7 88038.0 993.0 998.9 1023.9 1034.1 1036.4 16850.6 16904.9 17006.6 17200.9 17417.7 37432.8 38345.0 38639.6 39091.6 39300.4 49365.8 54057.7 54100.7 54350.5 54484.0 4962.8 5093.4 7849.2 7969.0 8098.8 10030.9 12255.9 12325.4 12517.6 12916.5 10815.2 11033.5 11154.7 11204.8 11579.5 10835.8 11028.8 11286.4 11368.4 11467.9 11214.6 11271.3 11360.8 11485.7 11740.6 7828.9 7965.4 8028.2 8110.9 8133.8 8113.2 10393.0 11385.4 11458.4 11482.5 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#3] mootools.html Cycles:180 Average:5786.45 Median:4458.54 stddev:3369.94 (75.6%) stddev-sans-first:3362.90 19:27:32 INFO - PROCESS | 4325 | Values: 1349.4 1529.3 1544.3 1652.8 1799.4 8329.9 8777.3 8787.8 9051.0 9063.4 8577.6 8761.4 8763.5 8767.5 8786.6 1939.8 2003.9 2006.2 2170.7 2195.9 2172.1 2228.9 2229.4 2237.6 2246.2 2151.3 2158.3 2176.5 2181.5 2184.7 1930.8 2141.0 2171.3 2171.8 2211.6 2256.5 2288.9 2290.1 2292.1 2292.4 8800.7 8869.7 8870.9 8879.8 8880.4 5048.6 5178.7 5180.7 5181.4 5185.4 3045.7 3127.9 3246.4 3261.6 3268.8 1089.7 1098.6 1108.9 1140.7 1174.5 12300.5 12318.8 12341.7 12343.6 12350.6 4408.4 4424.9 4492.1 4516.3 4525.9 10345.5 10374.0 10389.2 10397.4 10401.7 4984.9 5031.3 5034.9 5039.5 5039.9 4107.2 4525.8 4589.4 4625.5 4649.0 3753.2 3763.8 3814.2 3838.4 3862.9 1162.4 1218.7 1223.7 1224.7 1239.4 938.3 949.0 986.7 1003.2 1009.5 5751.7 5842.2 5872.9 6037.4 6120.2 960.3 962.1 970.9 991.3 1012.4 3999.1 4051.9 4083.2 4139.9 4163.3 10793.0 11005.3 11187.3 11201.6 11205.7 11019.4 11081.4 11105.2 11115.2 11116.6 7846.7 8002.7 8114.6 8140.3 8147.1 5981.8 6263.2 6277.3 6294.1 6317.6 10145.3 10181.3 10195.8 10445.0 10467.9 10285.8 10565.9 10578.8 10594.3 10594.3 6650.0 7750.7 7877.7 8071.0 8075.5 8584.4 8587.4 8650.7 8664.8 8669.7 7586.7 7621.7 7665.4 7825.5 7846.0 7423.9 7523.1 7609.5 7713.5 7724.0 6947.8 6994.2 6998.5 7024.5 7025.7 5011.5 5113.5 5221.0 5254.5 5277.0 5212.7 5245.8 5247.1 5289.6 5291.5 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#4] prototype.html Cycles:180 Average:4528.60 Median:5116.94 stddev:1329.37 (26.0%) stddev-sans-first:1294.96 19:27:32 INFO - PROCESS | 4325 | Values: 316.4 325.6 329.2 332.4 332.8 5254.3 5340.4 5369.4 5369.7 5490.5 5260.6 5273.6 5303.4 5309.2 5309.8 4095.2 4110.8 4114.4 4117.8 4125.3 4062.4 4122.8 4126.2 4126.3 4141.7 4047.1 4097.4 4112.0 4121.5 4122.8 4090.7 4108.0 4117.4 4119.0 4142.5 3613.2 3626.4 3642.4 3642.7 3657.6 5094.7 5110.4 5115.8 5127.8 5146.6 4636.1 4660.7 4664.1 4665.3 4704.9 5524.4 5534.0 5556.7 5574.9 5603.3 3876.6 3945.4 3967.9 3969.4 3975.6 5398.2 5609.7 5755.8 5786.3 5827.2 3834.2 3842.8 3848.9 3855.5 4012.0 3755.7 4028.6 4044.8 4050.5 4068.8 4584.6 4640.5 4644.1 4675.3 4688.4 5522.3 5530.5 5535.3 5551.6 5594.0 1362.5 1372.7 1385.3 1393.2 1394.2 872.5 874.1 884.6 894.9 903.5 4729.6 4739.0 4750.8 4773.1 4792.5 5074.3 5080.5 5082.9 5091.4 5118.1 4486.6 4723.4 4768.4 4811.9 4817.3 2637.0 2704.8 2714.9 2715.9 2722.5 5174.4 5216.3 5218.9 5232.4 5282.3 5014.3 5100.6 5113.5 5277.7 5297.7 5176.9 5193.2 5199.5 5207.6 5222.4 5124.9 5153.4 5168.5 5181.5 5197.4 5112.6 5155.6 5219.2 5397.4 5672.3 5811.2 5864.2 5867.2 5877.4 5913.3 4025.5 4035.5 4049.2 4060.8 4064.4 5562.6 5570.8 5617.4 5628.7 5655.3 5499.4 5524.6 5531.9 5544.7 5554.4 5316.0 5528.2 5581.9 5597.0 5606.9 5518.0 5529.0 5540.8 5542.1 5561.4 5610.2 5657.5 5682.7 5694.6 5712.1 5332.5 5596.8 5598.4 5616.7 5622.3 19:27:32 INFO - PROCESS | 4325 | 19:27:32 INFO - PROCESS | 4325 | [#5] yui.html Cycles:180 Average:19287.56 Median:4821.66 stddev:26504.44 (549.7%) stddev-sans-first:26541.95 19:27:32 INFO - PROCESS | 4325 | Values: 679.0 690.0 737.4 794.6 847.7 13195.3 13216.7 13262.2 14368.7 14839.3 13745.7 14169.4 14220.2 14227.5 14233.0 693.0 800.3 803.6 830.2 837.9 818.7 830.3 830.6 830.7 830.9 871.5 874.2 878.8 879.3 880.1 716.4 843.5 866.9 871.7 872.5 635.2 637.1 640.3 640.4 640.4 13777.7 13807.8 13824.5 13835.6 13857.1 13067.3 13434.3 13439.5 13558.9 13802.0 12620.1 12653.5 12916.5 13150.3 13379.9 4436.5 4445.3 4471.0 4515.1 4659.5 72486.6 72799.0 73639.6 74479.6 75996.9 10595.6 10625.9 11020.7 11116.8 11371.0 19803.0 19805.3 19829.1 19842.3 19847.4 7573.7 7801.6 7818.6 7951.9 8053.1 4455.6 4510.0 4563.2 4570.7 4650.7 3065.0 3163.6 3173.9 3174.6 3177.1 533.8 555.5 566.5 571.2 587.3 604.2 619.0 651.3 658.1 786.3 9882.2 10446.5 10455.2 10461.8 10465.8 666.0 709.4 711.1 722.4 774.7 4720.0 4778.1 4865.2 4875.3 4880.7 65279.7 67354.7 67387.3 67397.3 87364.6 94900.5 94971.0 95880.5 96639.0 96934.0 82183.0 87992.6 88095.1 88108.0 88120.0 8958.2 9031.0 9055.7 9157.6 9209.5 49015.5 49443.0 49559.5 51116.2 52422.0 68908.7 76199.2 76636.2 77675.0 78680.2 11330.7 11358.2 11569.6 11603.1 11844.9 13221.6 13466.2 13655.9 14313.4 14495.6 14068.0 14131.4 14170.6 14268.8 14726.9 13960.9 13967.7 14322.4 14454.1 14612.2 13816.8 14063.5 14081.3 14225.3 14305.4 11511.8 11608.8 11680.4 11688.8 12153.2 10869.2 10944.2 11243.9 11510.5 11597.6 19:27:32 INFO - PROCESS | 4325 | -------- Summary: end -------- 19:27:32 INFO - PROCESS | 4325 | 19:27:33 INFO - TEST-INFO | 4325: exit 0 19:27:33 INFO - TEST-OK | dromaeo_css | took 1113024ms 19:27:33 INFO - TEST-START | kraken 19:27:33 INFO - operating with platform_type : linux_ 19:27:33 INFO - Initialising browser for kraken test... 19:27:33 INFO - TEST-INFO | started process 4509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqPZBP/profile http://localhost:48820/getInfo.html) 19:27:37 INFO - PROCESS | 4509 | __metrics Screen width/height:1600/1200 19:27:37 INFO - PROCESS | 4509 | colorDepth:24 19:27:37 INFO - PROCESS | 4509 | Browser inner width/height: 1024/697 19:27:37 INFO - PROCESS | 4509 | __metrics 19:27:38 ERROR - PROCESS | 4509 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:27:38 INFO - PROCESS | 4509 | console.error: PushService: 19:27:38 INFO - PROCESS | 4509 | stateChangeProcessEnqueue: Error transitioning state 19:27:38 INFO - PROCESS | 4509 | UnknownError 19:27:39 INFO - TEST-INFO | 4509: exit 0 19:27:39 INFO - Browser initialized. 19:27:39 INFO - Running cycle 1/1 for kraken test... 19:27:39 INFO - TEST-INFO | started process 4591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqPZBP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:51 INFO - PROCESS | 4591 | RSS: Main: 156385280 19:27:51 INFO - PROCESS | 4591 | 19:27:53 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48820/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:54 INFO - PROCESS | 4591 | RSS: Main: 214220800 19:27:54 INFO - PROCESS | 4591 | 19:27:57 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48820/tests/kraken/driver.html?testName=audio-dft) 19:27:58 INFO - PROCESS | 4591 | RSS: Main: 200830976 19:27:58 INFO - PROCESS | 4591 | 19:28:01 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48820/tests/kraken/driver.html?testName=audio-fft) 19:28:01 INFO - PROCESS | 4591 | RSS: Main: 268165120 19:28:01 INFO - PROCESS | 4591 | 19:28:03 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48820/tests/kraken/driver.html?testName=audio-oscillator) 19:28:04 INFO - PROCESS | 4591 | RSS: Main: 178900992 19:28:04 INFO - PROCESS | 4591 | 19:28:06 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:07 INFO - PROCESS | 4591 | RSS: Main: 182915072 19:28:07 INFO - PROCESS | 4591 | 19:28:10 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48820/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:10 INFO - PROCESS | 4591 | RSS: Main: 217649152 19:28:10 INFO - PROCESS | 4591 | 19:28:14 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48820/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:14 INFO - PROCESS | 4591 | RSS: Main: 219955200 19:28:14 INFO - PROCESS | 4591 | 19:28:17 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48820/tests/kraken/driver.html?testName=json-parse-financial) 19:28:18 INFO - PROCESS | 4591 | RSS: Main: 219856896 19:28:18 INFO - PROCESS | 4591 | 19:28:19 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:20 INFO - PROCESS | 4591 | RSS: Main: 206962688 19:28:20 INFO - PROCESS | 4591 | 19:28:22 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:22 INFO - PROCESS | 4591 | RSS: Main: 211533824 19:28:22 INFO - PROCESS | 4591 | 19:28:24 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:25 INFO - PROCESS | 4591 | RSS: Main: 217673728 19:28:25 INFO - PROCESS | 4591 | 19:28:27 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:28 INFO - PROCESS | 4591 | RSS: Main: 222920704 19:28:28 INFO - PROCESS | 4591 | 19:28:31 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:31 INFO - PROCESS | 4591 | RSS: Main: 221372416 19:28:31 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | Cycle 1(1): loaded http://localhost:48820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48820/tests/kraken/driver.html?testName=ai-astar) 19:28:33 INFO - PROCESS | 4591 | RSS: Main: 263671808 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | __start_tp_report 19:28:33 INFO - PROCESS | 4591 | _x_x_mozilla_page_load 19:28:33 INFO - PROCESS | 4591 | _x_x_mozilla_page_load_details 19:28:33 INFO - PROCESS | 4591 | |i|pagename|runs| 19:28:33 INFO - PROCESS | 4591 | |0;ai-astar;111;105;111;112;110;111;110;110;111;110 19:28:33 INFO - PROCESS | 4591 | |1;audio-beat-detection;151;123;128;189;129;126;159;125;158;130 19:28:33 INFO - PROCESS | 4591 | |2;audio-dft;161;159;160;160;161;160;161;160;161;160 19:28:33 INFO - PROCESS | 4591 | |3;audio-fft;76;76;74;121;75;76;74;74;99;74 19:28:33 INFO - PROCESS | 4591 | |4;audio-oscillator;84;85;113;84;84;85;113;85;85;116 19:28:33 INFO - PROCESS | 4591 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;118;117;116 19:28:33 INFO - PROCESS | 4591 | |6;imaging-darkroom;146;146;146;145;147;146;146;146;147;145 19:28:33 INFO - PROCESS | 4591 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;95;95 19:28:33 INFO - PROCESS | 4591 | |8;json-parse-financial;54;53;54;54;53;54;53;54;52;54 19:28:33 INFO - PROCESS | 4591 | |9;json-stringify-tinderbox;62;62;62;62;70;63;62;63;63;62 19:28:33 INFO - PROCESS | 4591 | |10;stanford-crypto-aes;80;85;79;80;81;80;80;81;112;80 19:28:33 INFO - PROCESS | 4591 | |11;stanford-crypto-ccm;132;123;124;121;118;121;121;123;130;123 19:28:33 INFO - PROCESS | 4591 | |12;stanford-crypto-pbkdf2;163;162;166;159;161;163;161;160;162;158 19:28:33 INFO - PROCESS | 4591 | |13;stanford-crypto-sha256-iterative;63;64;63;62;62;62;62;63;62;71 19:28:33 INFO - PROCESS | 4591 | __end_tp_report 19:28:33 INFO - PROCESS | 4591 | __start_cc_report 19:28:33 INFO - PROCESS | 4591 | _x_x_mozilla_cycle_collect,1632 19:28:33 INFO - PROCESS | 4591 | __end_cc_report 19:28:33 INFO - PROCESS | 4591 | __startTimestamp1465439313761__endTimestamp 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | ------- Summary: start ------- 19:28:33 INFO - PROCESS | 4591 | Number of tests: 14 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 19:28:33 INFO - PROCESS | 4591 | Values: 111.0 105.0 111.0 112.0 110.0 111.0 110.0 110.0 111.0 110.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:140.50 stddev:21.73 (15.5%) stddev-sans-first:22.79 19:28:33 INFO - PROCESS | 4591 | Values: 151.0 123.0 128.0 189.0 129.0 126.0 159.0 125.0 158.0 130.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:28:33 INFO - PROCESS | 4591 | Values: 161.0 159.0 160.0 160.0 161.0 160.0 161.0 160.0 161.0 160.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:15.72 (20.8%) stddev-sans-first:16.52 19:28:33 INFO - PROCESS | 4591 | Values: 76.0 76.0 74.0 121.0 75.0 76.0 74.0 74.0 99.0 74.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.50 stddev:14.25 (16.9%) stddev-sans-first:14.70 19:28:33 INFO - PROCESS | 4591 | Values: 84.0 85.0 113.0 84.0 84.0 85.0 113.0 85.0 85.0 116.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 19:28:33 INFO - PROCESS | 4591 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 116.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:28:33 INFO - PROCESS | 4591 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 147.0 145.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:28:33 INFO - PROCESS | 4591 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.71 (1.3%) stddev-sans-first:0.73 19:28:33 INFO - PROCESS | 4591 | Values: 54.0 53.0 54.0 54.0 53.0 54.0 53.0 54.0 52.0 54.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:62.50 stddev:2.47 (4.0%) stddev-sans-first:2.59 19:28:33 INFO - PROCESS | 4591 | Values: 62.0 62.0 62.0 62.0 70.0 63.0 62.0 63.0 63.0 62.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:80.00 stddev:10.04 (12.6%) stddev-sans-first:10.56 19:28:33 INFO - PROCESS | 4591 | Values: 80.0 85.0 79.0 80.0 81.0 80.0 80.0 81.0 112.0 80.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.00 stddev:4.27 (3.5%) stddev-sans-first:3.28 19:28:33 INFO - PROCESS | 4591 | Values: 132.0 123.0 124.0 121.0 118.0 121.0 121.0 123.0 130.0 123.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 19:28:33 INFO - PROCESS | 4591 | Values: 163.0 162.0 166.0 159.0 161.0 163.0 161.0 160.0 162.0 158.0 19:28:33 INFO - PROCESS | 4591 | 19:28:33 INFO - PROCESS | 4591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.76 (4.4%) stddev-sans-first:2.92 19:28:33 INFO - PROCESS | 4591 | Values: 63.0 64.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 71.0 19:28:33 INFO - PROCESS | 4591 | -------- Summary: end -------- 19:28:33 INFO - PROCESS | 4591 | 19:28:34 INFO - TEST-INFO | 4591: exit 0 19:28:34 INFO - TEST-OK | kraken | took 61063ms 19:28:34 INFO - SUITE-END | took 1174s 19:28:34 INFO - Completed test suite (00:19:34) 19:28:34 INFO - javascript benchmark 19:28:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.8911888083912, 3116.0, 3130.326979699364, 3160.0203936779585, 3181.2683082890935, 5095.210242412432, 5147.7426128693505, 5182.948170518293, 5241.030409374263, 5269.973650131748, 5178.66338687986, 5230.0, 5230.633855630107, 5258.106121959267, 5269.947300526994, 4772.117158325704, 4792.089502994429, 4797.90404191916, 4850.296706977486, 4945.554900058994, 4870.391201099863, 4893.339399181101, 4905.705657660534, 4933.1860243059855, 4962.206047032458, 4710.434747830265, 4748.19280722278, 4771.904561908777, 4784.880377990543, 4787.569118779309, 4764.4759076501905, 4767.261074533453, 4801.063792560452, 4816.397950256218, 4818.180909245437, 4723.315119307716, 4742.478327383985, 4747.145513807548, 4820.879478013043, 4824.348712923746, 5228.843134705965, 5263.0, 5263.131583288753, 5274.7626356814035, 5275.208718692188, 5484.341878974508, 5489.286392768954, 5525.475079867406, 5530.723463826793, 5693.800716974927, 5680.772769089232, 5688.317401911756, 5693.544516438675, 5695.943040569583, 5703.230063941356, 5262.105442074857, 5300.3639563252655, 5307.442718514578, 5307.469253074701, 5314.760835762361, 5601.355844077902, 5701.515371193412, 5744.827655170351, 5753.654780713171, 5848.88302233953, 5580.302462192226, 5640.830775076673, 5641.464060914206, 5642.266505354278, 5644.407337229614, 5507.091329930597, 5650.886982260332, 5656.8868622627315, 5663.773449062074, 5714.085746280658, 5577.832665020056, 5603.635763675429, 5627.634203776742, 5651.406602306781, 5657.830265092054, 5612.943870561324, 5657.547396208293, 5657.773689052392, 5661.547076233891, 5665.3768085510565, 4237.237297286456, 4271.273883439822, 4327.7186982846015, 4332.631726303236, 4370.497392799869, 3846.5576458707046, 3853.5183102112237, 3862.671672907778, 3895.2599006188734, 3921.686265098785, 5254.185601231815, 5254.343207099113, 5268.604854635841, 5275.182346736262, 5321.441248668834, 5522.364928033247, 5564.972175139098, 5581.079121944915, 5618.803341883096, 5666.065099258659, 5291.126964050965, 5302.655327403706, 5309.7079660618265, 5315.840524784263, 5344.8663783404945, 4852.8544143675745, 4855.732934688626, 4873.853784386474, 4874.390701162355, 4915.827946021872, 5650.717464126859, 5701.543876489871, 5728.598998070179, 5729.999999999916, 5783.537317014629, 5612.074007788832, 5634.774609015757, 5637.774489020558, 5639.971800140973, 5644.774209031592, 5767.048437007847, 5780.682062486603, 5781.046127388934, 5783.392743761844, 5783.971080144741, 5448.56411487088, 5495.642783219078, 5519.3652729936575, 5542.750576223999, 5584.944150558443, 5662.773489060556, 5664.37691853904, 5667.744951477111, 5673.517750991212, 5681.375048744718, 5349.197620356822, 5468.6171967963455, 5509.614326997072, 5520.66875987426, 5524.392316845064, 5391.4338994405025, 5405.540529055074, 5406.756695948613, 5432.185172224198, 5460.699661518495, 5323.6273460857365, 5346.144616861284, 5353.411124776194, 5358.732063396893, 5379.54273886724, 5388.865278368072, 5467.58993075513, 5528.281323428089, 5541.778328866962, 5569.66582005081, 5288.867778305573, 5353.089974704231, 5375.408705042364, 5402.351717793733, 5519.337679478488], "value": 5187.219397681189, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5870173475097, 613.6226220874163, 623.8035018969024, 632.9682617333748, 659.7756762700681, 31647.050588482354, 42734.35898461522, 43783.78108109459, 43968.78015609925, 44038.0, 42027.0, 42340.57659423405, 42354.364684529755, 42377.576224237746, 42419.57580424195, 8833.955830220855, 8974.102589741005, 8989.101089890992, 8990.190882820545, 8992.0, 8778.868316975251, 8891.199792018717, 8907.866382004275, 8908.51003194824, 8910.688125915594, 8925.687600933968, 8957.19385255327, 8984.505852178128, 8987.325950553703, 8988.865167022468, 8878.778030549223, 8928.642854285821, 8929.553522323922, 8933.06202848698, 8942.64229430822, 8760.12398760119, 8845.823083538293, 8850.114988501162, 8850.468971861708, 8853.690120845804, 42255.366169507484, 42421.0, 42513.1497370054, 42648.14703705908, 42730.35904461436, 3336.5495658086093, 3377.4427219508752, 3395.2530443302435, 3456.0443394439435, 3783.4135708965155, 31905.52141717876, 31944.680553194634, 32309.192270193198, 32346.83826580852, 32415.189620259447, 4059.5940405959464, 4079.388091786226, 4217.240896638604, 4222.662187025031, 4277.721948073366, 367749.9999999973, 368488.0, 369041.0, 369748.0, 370101.0, 54998.0, 55569.0, 55901.72049139728, 55903.72048139733, 55959.72020139873, 58139.0, 58492.70753646205, 58521.12218316729, 58568.0, 58579.70710146422, 17205.397811076804, 17372.131393430278, 17416.65166696659, 17419.39032133869, 17422.651546969242, 13618.114822536503, 13662.18026918388, 13673.453061877612, 13707.725845483035, 13731.107478013897, 14996.775048374284, 15464.690706185813, 15651.139187344805, 15759.606009849616, 15966.0, 6156.384361563808, 6334.588251763621, 6344.777932772423, 6424.807255782334, 6438.9756402248595, 979.3291595257272, 1047.2669131607904, 1057.645688694296, 1091.8471414002047, 1096.2788422177264, 32437.0, 32798.34403311968, 32891.50662740061, 33189.83405082959, 33496.66503334935, 1119.5297974850582, 1127.4306475229957, 1134.5235001299475, 1141.4292853573213, 1220.737541428597, 16433.178341083138, 17051.91474042622, 17182.0, 17215.91392043057, 17319.039391329046, 586323.0, 587289.0, 594254.0, 596652.0, 599357.0, 57392.426075739546, 57455.42544574501, 57544.71227643919, 57565.71217143888, 57599.424005760244, 1300.2913412190378, 1367.9521216757366, 1404.206623257856, 1410.739013282546, 1413.7596608576566, 32358.83820580882, 34009.65990340065, 34027.319453611286, 34066.79881662687, 34294.48558271678, 48696.0, 48872.0, 49368.0, 49423.75288123536, 49485.257721133494, 332781.0, 333183.0, 333696.0, 334103.0, 334910.0, 34690.0, 38871.805640971616, 39966.0, 40311.19377612373, 40383.59616403798, 47025.29462058003, 47520.52479475161, 47734.0, 48519.272210917574, 49104.263436047775, 40269.19461610693, 40810.0, 41006.1798764029, 41619.7919010403, 41831.37252941148, 40510.77190754537, 40728.389074163315, 41226.0, 41874.37188442237, 42060.0, 41074.0, 41151.176976459705, 41323.1735365297, 42158.15683686248, 42282.36576451294, 34769.47845782366, 36420.4536931941, 36622.08444788795, 36704.63295367012, 36939.26121477609, 28054.85972570124, 28385.858070709513, 28417.28956776097, 28562.428751425272, 28728.569071463528], "value": 20098.24109888495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4071016019289, 383.24500733554896, 385.86494726845626, 391.53602980468145, 402.9093453972856, 15131.394744210245, 15158.242087895589, 18073.548161295974, 19872.20511179553, 19901.0, 17773.733393999068, 18722.531936701555, 19447.124879380426, 19547.5113122172, 19576.706349404736, 5518.724063796814, 5595.300587426572, 5668.0, 5714.342850572175, 5721.0, 4001.7398869073418, 5566.832995010136, 5894.322152952423, 6157.630542167484, 6169.413905678975, 6096.416808064669, 6157.784477543287, 6219.2847822500535, 6219.90670139946, 6226.875462490748, 6104.389561043905, 6175.2589689237575, 6207.099970504251, 6258.217722784652, 6269.874602507947, 4840.70955742653, 5152.742362881841, 5424.755885985141, 5427.864303392407, 5429.131338985743, 13061.738765224738, 13069.615667148126, 13394.06241563091, 13402.731945361136, 21445.78554214469, 2151.967720484194, 2210.126999835072, 2223.6886835842993, 2286.0741399733133, 2367.981767839828, 9283.489408082552, 9297.953510232473, 9634.03659634038, 9768.413895166314, 9784.51077446132, 1889.1687657430687, 1949.512621844539, 1954.6188493243824, 1971.5662554238045, 2013.3389953288595, 81478.0, 81488.0, 81623.0, 81635.367292655, 83690.0, 10018.899811001942, 10437.217208709377, 10723.356598604109, 10907.400092994803, 10989.560417583207, 15226.0, 15344.693106137815, 15345.386184552715, 15371.769423458658, 15375.923120384326, 7565.508241964255, 7707.499012564165, 7749.3413059890545, 7899.0, 7906.723264685708, 7258.346748792634, 7303.3792127668685, 7413.8146546336775, 7500.0, 7516.398688104939, 4593.770311484479, 4660.487346391894, 4743.952560474351, 4782.450018247946, 4799.472058073609, 1798.6222893192314, 1899.6118965190178, 1910.1404368034441, 1911.1972971351788, 1933.7002764571514, 916.4913473022403, 979.7207795778312, 989.5843745626854, 989.8911119776819, 994.5126887824914, 18230.0, 18595.163217655238, 18602.720959185623, 18883.81116188848, 18954.336598219274, 1001.4892404873567, 1001.5442973447064, 1047.8683022335858, 1066.248294952057, 1079.7786453776957, 9575.06012362615, 10769.138468922467, 10769.946150269356, 10771.51528181218, 10805.351678899291, 473019.0, 480392.0, 482477.0, 497841.0, 499191.0, 58954.0, 83416.0, 86308.0, 87422.68865967015, 88038.0, 992.9553170107363, 998.8851282102506, 1023.8822535408375, 1034.0972610396755, 1036.3522798251092, 16850.57873553171, 16904.915475422546, 17006.57483562921, 17200.913995429943, 17417.651646966737, 37432.81283593673, 38345.0, 38639.613603864724, 39091.6090839088, 39300.41049384204, 49365.75317123391, 54057.72971135119, 54100.729496352265, 54350.45649543612, 54484.0, 4962.801487940442, 5093.439721630543, 7849.210432975549, 7969.0, 8098.797530061795, 10030.89969100329, 12255.87744122583, 12325.383730813603, 12517.56188533397, 12916.547920822726, 10815.24293299493, 11033.503492343025, 11154.665360039211, 11204.83192752093, 11579.536818527165, 10835.837462437912, 11028.834567481656, 11286.379249141048, 11368.374739389414, 11467.942660286646, 11214.607488737855, 11271.323720576791, 11360.829587556358, 11485.712857178638, 11740.58907938218, 7828.921710782819, 7965.442419030613, 8028.237317454832, 8110.918890811253, 8133.79665508367, 8113.1886811320755, 10393.0, 11385.430728463378, 11458.427078645867, 11482.540698371971], "value": 8791.36136004696, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.446726841995, 1529.3270960777256, 1544.3398346777215, 1652.8016638003442, 1799.4151900632298, 8329.91670083299, 8777.297816174698, 8787.780305492366, 9051.049639787827, 9063.410878292923, 8577.614007369668, 8761.43050701704, 8763.518006509656, 8767.473951562895, 8786.560671966392, 1939.806019398063, 2003.8597298189134, 2006.1574138861713, 2170.674398840171, 2195.9451013724624, 2172.1094351315965, 2228.92198773043, 2229.409206560255, 2237.552489502098, 2246.1576908659254, 2151.268568686646, 2158.2769772126358, 2176.5102851858364, 2181.476445653048, 2184.7050648162453, 1930.8262256396852, 2140.9892950535304, 2171.337741988693, 2171.8371122165745, 2211.6019116559014, 2256.5035692147703, 2288.8969996350206, 2290.0839664134314, 2292.094622624054, 2292.4154340643195, 8800.735977920673, 8869.68956086534, 8870.911290887074, 8879.822403551958, 8880.422772519765, 5048.570871475929, 5178.663386879878, 5180.715060671661, 5181.35233095863, 5185.403678576974, 3045.725884670368, 3127.8592463339205, 3246.3669584431045, 3261.5596894419423, 3268.7875288106197, 1089.6626735652062, 1098.6374496416163, 1108.927919685226, 1140.7433327501328, 1174.4656181437426, 12300.507979680802, 12318.75362492745, 12341.691457713629, 12343.567975120828, 12350.567730129402, 4408.404865343202, 4424.933625995613, 4492.146492166478, 4516.254817955067, 4525.909481810345, 10345.482725863676, 10374.0, 10389.220808439397, 10397.376157430579, 10401.739956501147, 4984.90030199394, 5031.345925029796, 5034.924476132861, 5039.4708555601865, 5039.899202015939, 4107.199096176217, 4525.796339164745, 4589.380433641482, 4625.514320996314, 4649.0, 3753.2118255166174, 3763.7741735495956, 3814.1990182062077, 3838.3666694995572, 3862.8841134766003, 1162.3665102518978, 1218.7014181525583, 1223.6573759347398, 1224.675461002835, 1239.39269757818, 938.2915898496591, 948.9572969216401, 986.6546708652058, 1003.2325271167563, 1009.5053423822421, 5751.654900705971, 5842.211301474332, 5872.882542349214, 6037.366076561898, 6120.17377654011, 960.2653969713175, 962.129273007929, 970.8883478399933, 991.3060857399705, 1012.427978192319, 3999.140184860269, 4051.9392209116886, 4083.1833633273463, 4139.91720165595, 4163.250614889288, 10793.0, 11005.339679619248, 11187.272827266203, 11201.607943722094, 11205.66383008511, 11019.393933333584, 11081.390523521284, 11105.167112466597, 11115.166362522843, 11116.555337786398, 7846.686132554748, 8002.679892804223, 8114.553699546582, 8140.308073813792, 8147.144549822302, 5981.820545383645, 6263.217097862767, 6277.3408792078, 6294.118823364641, 6317.5893566918, 10145.28982971185, 10181.33821301613, 10195.847062293924, 10445.0, 10467.94766026165, 10285.845712314172, 10565.894341056492, 10578.841317380091, 10594.258401911793, 10594.258401911793, 6649.966750166218, 7750.728724494616, 7877.684892604231, 8071.0, 8075.475094118863, 8584.356173287153, 8587.441816281922, 8650.697225597074, 8664.783380415289, 8669.653213871374, 7586.658600363107, 7621.69513219465, 7665.386769058574, 7825.491343062683, 7846.0, 7423.851522969619, 7523.134839493309, 7609.543427394374, 7713.5371877685275, 7723.961380193288, 6947.826304342432, 6994.195667498303, 6998.510104292651, 7024.473164512579, 7025.718971241093, 5011.473795251592, 5113.51421614946, 5221.0, 5254.527092561688, 5276.997370499593, 5212.739363031909, 5245.790168393221, 5247.08176069194, 5289.629725919149, 5291.523762861361], "value": 4587.611569341602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.39252634940925, 325.57024727359885, 329.2016859116643, 332.39504102533397, 332.75209968573415, 5254.264402983586, 5340.412554618989, 5369.355677318722, 5369.731513424328, 5490.533304669108, 5260.605454590911, 5273.551748101407, 5303.416624171338, 5309.177077552986, 5309.787608495655, 4095.201435720036, 4110.77390743509, 4114.382842573623, 4117.773522456264, 4125.319322311815, 4062.431259623655, 4122.8144733486915, 4126.1541384016355, 4126.277901367263, 4141.710080294366, 4047.1298670785777, 4097.422492340455, 4111.958880411203, 4121.4848143982, 4122.793860306988, 4090.6522945549664, 4108.0, 4117.402976568411, 4118.979405102985, 4142.523609784883, 3613.2412193439145, 3626.3653860574295, 3642.4354225095153, 3642.7267954903223, 3657.579378371495, 5094.668846525001, 5110.437851836295, 5115.8209462669, 5127.7948882044675, 5146.588272938156, 4636.11913736389, 4660.720356778605, 4664.137134630104, 4665.323528088442, 4704.929426058612, 5524.447555244484, 5534.0, 5556.749946252388, 5574.944250557483, 5603.299587551556, 3876.554196267437, 3945.368741001426, 3967.940480892789, 3969.4442778011103, 3975.6421922027157, 5398.16462402785, 5609.681724794629, 5755.769769209227, 5786.334571524287, 5827.155062515912, 3834.175652234783, 3842.769433833979, 3848.9230215395537, 3855.4987851579117, 4012.0, 3755.6807671347697, 4028.569857700533, 4044.797760111983, 4050.5089370037217, 4068.7965601719798, 4584.564466375689, 4640.512746161672, 4644.140833945731, 4675.3220782986955, 4688.429376159025, 5522.337319521603, 5530.474604912527, 5535.33575970878, 5551.583631227674, 5594.0, 1362.4958765256918, 1372.6774208061097, 1385.279654579613, 1393.1501783911806, 1394.1635018988525, 872.4939535069772, 874.1258741258741, 884.6155766225836, 894.9463032218088, 903.4534106865252, 4729.557484967049, 4738.95261047392, 4750.762461876892, 4773.1408346497965, 4792.496787837227, 5074.314967479417, 5080.49195080489, 5082.923756143661, 5091.41448733393, 5118.053160165381, 4486.641068714495, 4723.385959825269, 4768.354917553438, 4811.927821082687, 4817.278237795635, 2636.973630263711, 2704.810663253593, 2714.9457010859674, 2715.9049433270134, 2722.454505037796, 5174.353205849269, 5216.295800067019, 5218.921716174261, 5232.3982741985155, 5282.286891269706, 5014.323066386064, 5100.617453690988, 5113.488651134857, 5277.709725965109, 5297.65565238266, 5176.870578235649, 5193.246979187997, 5199.532042116228, 5207.635465517453, 5222.399424066205, 5124.924405615731, 5153.3558305211845, 5168.508991645787, 5181.455947125498, 5197.402298735694, 5112.6165537585575, 5155.639105262596, 5219.243209734643, 5397.379301380234, 5672.262605861211, 5811.244538210006, 5864.208331875313, 5867.237259156283, 5877.4122587740885, 5913.29040515141, 4025.5370632377653, 4035.5157381114454, 4049.210403971197, 4060.7563546187325, 4064.4309796627904, 5562.638428502134, 5570.832875013756, 5617.4101719320515, 5628.690422026828, 5655.321361436654, 5499.395066542757, 5524.558035357242, 5531.861703457445, 5544.695041772741, 5554.389017208185, 5316.0, 5528.19841123043, 5581.883623275442, 5596.964561556125, 5606.943930560806, 5517.972410137923, 5528.9723551381985, 5540.750666219949, 5542.11326187808, 5561.3882472927135, 5610.18652295423, 5657.4908258256955, 5682.715864206856, 5694.601377903507, 5712.057510510719, 5332.5467335276935, 5596.832095037155, 5598.384177740527, 5616.691081990366, 5622.269105016322], "value": 4103.4264384383205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.9864202715946, 689.9724011039559, 737.4174402222245, 794.638439510023, 847.669408930517, 13195.34023298836, 13216.669583260424, 13262.204267743942, 14368.71262574748, 14839.332230049647, 13745.65635859104, 14169.362378692958, 14220.217888016155, 14227.502037428692, 14233.0, 692.9861402771967, 800.3197282310034, 803.602216902634, 830.2320353672859, 837.8617528107854, 818.7298191596789, 830.3066939105854, 830.6013113705425, 830.667732906836, 830.90444598871, 871.4727589808139, 874.1564390363299, 878.7846977490492, 879.2833840420069, 880.0715245416084, 716.4125417157933, 843.5318398288947, 866.9003064647583, 871.6861929705301, 872.467794645269, 635.152071983902, 637.1207733328024, 640.263696748738, 640.362838975218, 640.3724350136891, 13777.724445511134, 13807.792883106762, 13824.516141935084, 13835.584932452042, 13857.099288546213, 13067.346632668328, 13434.32828358578, 13439.529616463475, 13558.93220533901, 13802.0, 12620.117216553126, 12653.493860245671, 12916.483340666457, 13150.276734779583, 13379.933100334534, 4436.532523134913, 4445.333200019991, 4470.977645111753, 4515.074409746027, 4659.464161621423, 72486.63756681235, 72799.0, 73639.63180184118, 74479.62760186165, 75996.88037435488, 10595.576176952989, 10625.893741062646, 11020.724481887857, 11116.777664446667, 11370.976612104785, 19803.009849507467, 19805.306814261432, 19829.10769015398, 19842.305519307043, 19847.404577862686, 7573.712468880303, 7801.648925798353, 7818.6090695465, 7951.920480795234, 8053.07389650186, 4455.6212721918355, 4510.030343476168, 4563.178627846953, 4570.702904311275, 4650.697704649187, 3064.9540256896166, 3163.557102005721, 3173.936521269608, 3174.555562221291, 3177.1421716136974, 533.8485901815689, 555.5194756535649, 566.4816692726109, 571.2202843119112, 587.2571197435248, 604.1903848842572, 618.9876202475925, 651.2933467188059, 658.1312667279241, 786.3041208530377, 9882.160016398542, 10446.529906154241, 10455.21585881062, 10461.84307235392, 10465.790684186426, 665.9567128136656, 709.375749340577, 711.1075600121917, 722.3679280629449, 774.7133560582621, 4720.0, 4778.1399348116975, 4865.172920603506, 4875.317455556225, 4880.707157570557, 65279.67360163264, 67354.66322668355, 67387.32612673909, 67397.3260267391, 87364.5631771837, 94900.52549737207, 94971.0, 95880.52059739656, 96639.0, 96934.0, 82183.0, 87992.56003719941, 88095.11904880869, 88108.0, 88120.0, 8958.238549723346, 9030.954845225731, 9055.68305109318, 9157.587908543997, 9209.493477858514, 49015.509844902524, 49443.0, 49559.50440495693, 51116.233256501924, 52422.0, 68908.6554567224, 76199.23800761922, 76636.23363766514, 77675.0, 78680.21319786728, 11330.660080197607, 11358.182690769438, 11569.595064172714, 11603.071754259809, 11844.881551184722, 13221.603351899459, 13466.192028478323, 13655.931720341334, 14313.355898984779, 14495.565133046026, 14068.0, 14131.364088615832, 14170.645733856323, 14268.785968210694, 14726.926365368105, 13960.930195348958, 13967.650808729863, 14322.427102915766, 14454.132752034911, 14612.196329201995, 13816.792748108988, 14063.507777227747, 14081.295935203403, 14225.288735562974, 14305.427782888568, 11511.769764604493, 11608.767824643628, 11680.415979201176, 11688.824667630162, 12153.210041347284, 10869.239153259512, 10944.23390362667, 11243.943780281374, 11510.539578417105, 11597.594084207012], "value": 7338.968268059197, "unit": "score"}], "name": "dromaeo_css", "value": 7086.426684846133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 128.0, 189.0, 129.0, 126.0, 159.0, 125.0, 158.0, 130.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 121.0, 75.0, 76.0, 74.0, 74.0, 99.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 84.0, 84.0, 85.0, 113.0, 85.0, 85.0, 116.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 52.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 70.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 80.0, 81.0, 80.0, 80.0, 81.0, 112.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 124.0, 121.0, 118.0, 121.0, 121.0, 123.0, 130.0, 123.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 166.0, 159.0, 161.0, 163.0, 161.0, 160.0, 162.0, 158.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 71.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1494.6, "alertThreshold": 2.0}]} 19:28:35 INFO - Return code: 0 19:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:35 ERROR - # TBPL SUCCESS # 19:28:35 INFO - Running post-action listener: _resource_record_post_action 19:28:35 INFO - ##### 19:28:35 INFO - ##### Finished run-tests step (success) 19:28:35 INFO - ##### 19:28:35 INFO - Running post-run listener: _resource_record_post_run 19:28:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549584896; Read time: 12; Write time: 530856 19:28:35 INFO - TinderboxPrint: CPU usage
13.2% 19:28:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:28:35 INFO - TinderboxPrint: I/O write bytes / time
549,584,896 / 530,856 19:28:35 INFO - TinderboxPrint: CPU idle
8,256.2 (86.8%) 19:28:35 INFO - TinderboxPrint: CPU user
1,213.0 (12.7%) 19:28:35 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255840256; Read time: 0; Write time: 286064 19:28:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293744640; Read time: 12; Write time: 244792 19:28:35 INFO - Running post-run listener: _upload_blobber_files 19:28:35 INFO - Blob upload gear active. 19:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:35 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 19:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:39 INFO - (blobuploader) - INFO - Done attempting. 19:28:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:40 INFO - (blobuploader) - INFO - Done attempting. 19:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:41 INFO - (blobuploader) - INFO - Done attempting. 19:28:41 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:41 INFO - Return code: 0 19:28:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e206d9fc5e36c7e47b7edc93513046920513766f0d878121fede2ce83d7214692b72d7b9db121ae688c3752bf87999e274b44f0d2c170ce82a10adbaac394c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2693ca0e018f9af2137666b17c97ecb2afd501802bac7c4dda8844f896800b6594acdd0803aae5f0942b0632f4395fcad14a045fb1f847c185b4fe9d64eb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54f696b14edcdcaaac7aa9246d8c8abb2673784b09dd7ed44e479e28ce3ff5e0e2d69aebed71bedf93592e04e12c4fce5e12b65b42a726463be3ea62aed164dd"} 19:28:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:41 INFO - Contents: 19:28:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e206d9fc5e36c7e47b7edc93513046920513766f0d878121fede2ce83d7214692b72d7b9db121ae688c3752bf87999e274b44f0d2c170ce82a10adbaac394c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2693ca0e018f9af2137666b17c97ecb2afd501802bac7c4dda8844f896800b6594acdd0803aae5f0942b0632f4395fcad14a045fb1f847c185b4fe9d64eb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54f696b14edcdcaaac7aa9246d8c8abb2673784b09dd7ed44e479e28ce3ff5e0e2d69aebed71bedf93592e04e12c4fce5e12b65b42a726463be3ea62aed164dd"} 19:28:41 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:41 INFO - Copying logs to upload dir... 19:28:41 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.353746 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-08 19:28:40.790926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:28:40.794696) ========= 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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e206d9fc5e36c7e47b7edc93513046920513766f0d878121fede2ce83d7214692b72d7b9db121ae688c3752bf87999e274b44f0d2c170ce82a10adbaac394c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2693ca0e018f9af2137666b17c97ecb2afd501802bac7c4dda8844f896800b6594acdd0803aae5f0942b0632f4395fcad14a045fb1f847c185b4fe9d64eb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54f696b14edcdcaaac7aa9246d8c8abb2673784b09dd7ed44e479e28ce3ff5e0e2d69aebed71bedf93592e04e12c4fce5e12b65b42a726463be3ea62aed164dd"} build_url:https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/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/Firefox/sha512/9e206d9fc5e36c7e47b7edc93513046920513766f0d878121fede2ce83d7214692b72d7b9db121ae688c3752bf87999e274b44f0d2c170ce82a10adbaac394c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2693ca0e018f9af2137666b17c97ecb2afd501802bac7c4dda8844f896800b6594acdd0803aae5f0942b0632f4395fcad14a045fb1f847c185b4fe9d64eb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54f696b14edcdcaaac7aa9246d8c8abb2673784b09dd7ed44e479e28ce3ff5e0e2d69aebed71bedf93592e04e12c4fce5e12b65b42a726463be3ea62aed164dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:28:40.820212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:28:40.820555) ========= 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=32c5991c409366f7fec8a718000001d2-1465437535.538025-455282055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:28:40.904264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:28:40.904580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:28:40.904970) ========= ========= Total master_lag: 0.17 =========