builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1466805354.74 results: success (0) buildid: 20160624133758 builduid: 83b9238dfbc24d1b8040ff0f9e269788 revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.741566) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.742581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.743248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.759360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.759974) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 14:55:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-06-24 14:55:55 (18.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.884847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.885539) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018708 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:54.940137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 14:55:54.940920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e073f5ca38a002d43e92016ee40d686da4a0534 --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 0e073f5ca38a002d43e92016ee40d686da4a0534 --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=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 14:55:55,162 truncating revision to first 12 chars 2016-06-24 14:55:55,162 Setting DEBUG logging. 2016-06-24 14:55:55,162 attempt 1/10 2016-06-24 14:55:55,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e073f5ca38a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 14:55:56,299 unpacking tar archive at: mozilla-central-0e073f5ca38a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 14:55:56.426889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:56.427351) ========= script_repo_revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:56.427859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:56.428287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:55:56.440240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-24 14:55:56.440884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:55:56 INFO - MultiFileLogger online at 20160624 14:55:56 in /builds/slave/test 14:55:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:55:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:55:56 INFO - {'append_to_log': False, 14:55:56 INFO - 'base_work_dir': '/builds/slave/test', 14:55:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:55:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:55:56 INFO - 'branch': 'Firefox-Non-PGO', 14:55:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:55:56 INFO - 'config_files': ('talos/linux_config.py',), 14:55:56 INFO - 'default_actions': ('clobber', 14:55:56 INFO - 'read-buildbot-config', 14:55:56 INFO - 'download-and-extract', 14:55:56 INFO - 'populate-webroot', 14:55:56 INFO - 'create-virtualenv', 14:55:56 INFO - 'install', 14:55:56 INFO - 'run-tests'), 14:55:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:55:56 INFO - 'download_minidump_stackwalk': True, 14:55:56 INFO - 'download_symbols': 'ondemand', 14:55:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:55:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:55:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:55:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:55:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:55:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:55:56 INFO - 'installer_path': 'installer.exe', 14:55:56 INFO - 'log_level': 'info', 14:55:56 INFO - 'log_name': 'talos', 14:55:56 INFO - 'log_to_console': True, 14:55:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:55:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:55:56 INFO - 'opt_config_files': (), 14:55:56 INFO - 'pip_index': False, 14:55:56 INFO - 'sps_profile': False, 14:55:56 INFO - 'sps_profile_interval': 0, 14:55:56 INFO - 'suite': 'dromaeojs', 14:55:56 INFO - 'system_bits': '32', 14:55:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:55:56 INFO - 'title': 'talos-linux64-ix-046', 14:55:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:55:56 INFO - 'use_talos_json': True, 14:55:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:55:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:55:56 INFO - 'work_dir': 'build'} 14:55:56 INFO - ##### 14:55:56 INFO - ##### Running clobber step. 14:55:56 INFO - ##### 14:55:56 INFO - Running pre-action listener: _resource_record_pre_action 14:55:56 INFO - Running main action method: clobber 14:55:56 INFO - rmtree: /builds/slave/test/build 14:55:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:55:57 INFO - Running post-action listener: _resource_record_post_action 14:55:57 INFO - ##### 14:55:57 INFO - ##### Finished clobber step (success) 14:55:57 INFO - ##### 14:55:57 INFO - ##### 14:55:57 INFO - ##### Running read-buildbot-config step. 14:55:57 INFO - ##### 14:55:57 INFO - Running pre-action listener: _resource_record_pre_action 14:55:57 INFO - Running main action method: read_buildbot_config 14:55:57 INFO - Using buildbot properties: 14:55:57 INFO - { 14:55:57 INFO - "project": "", 14:55:57 INFO - "product": "firefox", 14:55:57 INFO - "script_repo_revision": "production", 14:55:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:55:57 INFO - "repository": "", 14:55:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:55:57 INFO - "buildid": "20160624133758", 14:55:57 INFO - "pgo_build": "False", 14:55:57 INFO - "basedir": "/builds/slave/test", 14:55:57 INFO - "buildnumber": 620, 14:55:57 INFO - "slavename": "talos-linux64-ix-046", 14:55:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:55:57 INFO - "platform": "ubuntu64_hw", 14:55:57 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:55:57 INFO - "branch": "mozilla-central", 14:55:57 INFO - "repo_path": "mozilla-central", 14:55:57 INFO - "revision": "0e073f5ca38a002d43e92016ee40d686da4a0534", 14:55:57 INFO - "stage_platform": "linux64", 14:55:57 INFO - "builduid": "83b9238dfbc24d1b8040ff0f9e269788", 14:55:57 INFO - "slavebuilddir": "test" 14:55:57 INFO - } 14:55:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:55:57 INFO - Running post-action listener: _resource_record_post_action 14:55:57 INFO - ##### 14:55:57 INFO - ##### Finished read-buildbot-config step (success) 14:55:57 INFO - ##### 14:55:57 INFO - ##### 14:55:57 INFO - ##### Running download-and-extract step. 14:55:57 INFO - ##### 14:55:57 INFO - Running pre-action listener: _resource_record_pre_action 14:55:57 INFO - Running main action method: download_and_extract 14:55:57 INFO - mkdir: /builds/slave/test/build/tests 14:55:57 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')]} 14:55:57 INFO - https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:55:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:55:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:55:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:55:58 INFO - Downloaded 1361 bytes. 14:55:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:55:58 INFO - Using the following test package requirements: 14:55:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:55:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:55:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'jsshell-linux-x86_64.zip'], 14:55:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:55:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:55:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:55:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:55:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:55:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:58 INFO - https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:55:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:55:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:55:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:09 INFO - Downloaded 22713162 bytes. 14:56: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'] 14:56: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 14:56:11 INFO - Return code: 0 14:56: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 14:56: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')]} 14:56:11 INFO - https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:12 INFO - Downloaded 22713162 bytes. 14:56: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'] 14:56: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 14:56:14 INFO - Return code: 0 14:56: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')]} 14:56:14 INFO - https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:15 INFO - Downloaded 14405188 bytes. 14:56:15 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'] 14:56:15 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 14:56:15 INFO - Return code: 0 14:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:15 INFO - https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Scx9cr5qQqGkV6GgveiNHg/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 14:56:19 INFO - Downloaded 56270298 bytes. 14:56:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:56:19 INFO - mkdir: /builds/slave/test/properties 14:56:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:56:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:56:19 INFO - Contents: 14:56:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:56:19 INFO - Running post-action listener: _resource_record_post_action 14:56:19 INFO - Running post-action listener: set_extra_try_arguments 14:56:19 INFO - ##### 14:56:19 INFO - ##### Finished download-and-extract step (success) 14:56:19 INFO - ##### 14:56:19 INFO - ##### 14:56:19 INFO - ##### Running populate-webroot step. 14:56:19 INFO - ##### 14:56:19 INFO - Running pre-action listener: _resource_record_pre_action 14:56:19 INFO - Running main action method: populate_webroot 14:56:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:56:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:56:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:56:19 INFO - '--tppagecycles', 14:56:19 INFO - '7'], 14:56:19 INFO - 'tests': ['tsvgm']}}, 14:56:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:56:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:56:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:56:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:56:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['damp', 'tps']}, 14:56:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'tests': ['damp', 'tps']}, 14:56:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['dromaeo_dom']}, 14:56:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:56:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['basic_compositor_video']}, 14:56:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:56:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['a11yr', 14:56:19 INFO - 'ts_paint', 14:56:19 INFO - 'tpaint', 14:56:19 INFO - 'sessionrestore', 14:56:19 INFO - 'sessionrestore_no_auto_restore', 14:56:19 INFO - 'tabpaint']}, 14:56:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['tsvgx', 14:56:19 INFO - 'tsvgr_opacity', 14:56:19 INFO - 'tart', 14:56:19 INFO - 'tscrollx', 14:56:19 INFO - 'cart']}, 14:56:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:56:19 INFO - 'tsvgr_opacity', 14:56:19 INFO - 'tart', 14:56:19 INFO - 'tscrollx', 14:56:19 INFO - 'cart']}, 14:56:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'talos_options': ['--disable-e10s'], 14:56:19 INFO - 'tests': ['tp5o']}, 14:56:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'tests': ['tp5o']}, 14:56:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'talos_options': ['--disable-e10s', 14:56:19 INFO - '--xperf_path', 14:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:19 INFO - 'tests': ['tp5n']}, 14:56:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:19 INFO - 'talos_options': ['--xperf_path', 14:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:19 INFO - 'tests': ['tp5n']}}, 14:56:19 INFO - 'talos.zip': {'path': '', 14:56:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:56:19 INFO - Running post-action listener: _resource_record_post_action 14:56:19 INFO - ##### 14:56:19 INFO - ##### Finished populate-webroot step (success) 14:56:19 INFO - ##### 14:56:19 INFO - ##### 14:56:19 INFO - ##### Running create-virtualenv step. 14:56:19 INFO - ##### 14:56:19 INFO - Running pre-action listener: _resource_record_pre_action 14:56:19 INFO - Running main action method: create_virtualenv 14:56:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:56:19 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 14:56:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:56:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:56:19 INFO - Using real prefix '/usr' 14:56:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:56:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:56:22 INFO - Installing pip.................done. 14:56:22 INFO - Return code: 0 14:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:22 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:22 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 14:56:22 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 14:56:22 INFO - Using env: {'DISPLAY': ':0', 14:56:22 INFO - 'HOME': '/home/cltbld', 14:56:22 INFO - 'LANG': 'en_US.UTF-8', 14:56:22 INFO - 'LANGUAGE': 'en_US:en', 14:56:22 INFO - 'LOGNAME': 'cltbld', 14:56:22 INFO - 'MAIL': '/var/mail/cltbld', 14:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:22 INFO - 'MOZ_NO_REMOTE': '1', 14:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:22 INFO - 'NO_EM_RESTART': '1', 14:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:22 INFO - 'PWD': '/builds/slave/test', 14:56:22 INFO - 'SHELL': '/bin/bash', 14:56:22 INFO - 'SHLVL': '1', 14:56:22 INFO - 'TERM': 'linux', 14:56:22 INFO - 'TMOUT': '86400', 14:56:22 INFO - 'USER': 'cltbld', 14:56:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:22 INFO - '_': '/tools/buildbot/bin/python'} 14:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:22 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 14:56:22 INFO - Cleaning up... 14:56:22 INFO - Return code: 0 14:56:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:22 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:22 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 14:56:22 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 14:56:22 INFO - Using env: {'DISPLAY': ':0', 14:56:22 INFO - 'HOME': '/home/cltbld', 14:56:22 INFO - 'LANG': 'en_US.UTF-8', 14:56:22 INFO - 'LANGUAGE': 'en_US:en', 14:56:22 INFO - 'LOGNAME': 'cltbld', 14:56:22 INFO - 'MAIL': '/var/mail/cltbld', 14:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:22 INFO - 'MOZ_NO_REMOTE': '1', 14:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:22 INFO - 'NO_EM_RESTART': '1', 14:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:22 INFO - 'PWD': '/builds/slave/test', 14:56:22 INFO - 'SHELL': '/bin/bash', 14:56:22 INFO - 'SHLVL': '1', 14:56:22 INFO - 'TERM': 'linux', 14:56:22 INFO - 'TMOUT': '86400', 14:56:22 INFO - 'USER': 'cltbld', 14:56:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:22 INFO - '_': '/tools/buildbot/bin/python'} 14:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:22 INFO - Downloading/unpacking psutil>=3.1.1 14:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:24 INFO - Installing collected packages: psutil 14:56:24 INFO - Running setup.py install for psutil 14:56:24 INFO - building 'psutil._psutil_linux' extension 14:56:24 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 14:56:25 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 14:56:25 INFO - building 'psutil._psutil_posix' extension 14:56:25 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 14:56:25 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 14:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:25 INFO - Successfully installed psutil 14:56:25 INFO - Cleaning up... 14:56:25 INFO - Return code: 0 14:56:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:56: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')]} 14:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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')]} 14:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:56: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 mozsystemmonitor==0.3 14:56:25 INFO - Using env: {'DISPLAY': ':0', 14:56:25 INFO - 'HOME': '/home/cltbld', 14:56:25 INFO - 'LANG': 'en_US.UTF-8', 14:56:25 INFO - 'LANGUAGE': 'en_US:en', 14:56:25 INFO - 'LOGNAME': 'cltbld', 14:56:25 INFO - 'MAIL': '/var/mail/cltbld', 14:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:25 INFO - 'MOZ_NO_REMOTE': '1', 14:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:25 INFO - 'NO_EM_RESTART': '1', 14:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:25 INFO - 'PWD': '/builds/slave/test', 14:56:25 INFO - 'SHELL': '/bin/bash', 14:56:25 INFO - 'SHLVL': '1', 14:56:25 INFO - 'TERM': 'linux', 14:56:25 INFO - 'TMOUT': '86400', 14:56:25 INFO - 'USER': 'cltbld', 14:56:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:25 INFO - '_': '/tools/buildbot/bin/python'} 14:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:56:27 INFO - Installing collected packages: mozsystemmonitor 14:56:27 INFO - Running setup.py install for mozsystemmonitor 14:56:27 INFO - Successfully installed mozsystemmonitor 14:56:27 INFO - Cleaning up... 14:56:27 INFO - Return code: 0 14:56:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:56:27 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')]} 14:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:27 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')]} 14:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:27 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:27 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 14:56:27 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 14:56:27 INFO - Using env: {'DISPLAY': ':0', 14:56:27 INFO - 'HOME': '/home/cltbld', 14:56:27 INFO - 'LANG': 'en_US.UTF-8', 14:56:27 INFO - 'LANGUAGE': 'en_US:en', 14:56:27 INFO - 'LOGNAME': 'cltbld', 14:56:27 INFO - 'MAIL': '/var/mail/cltbld', 14:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:27 INFO - 'MOZ_NO_REMOTE': '1', 14:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:27 INFO - 'NO_EM_RESTART': '1', 14:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:27 INFO - 'PWD': '/builds/slave/test', 14:56:27 INFO - 'SHELL': '/bin/bash', 14:56:27 INFO - 'SHLVL': '1', 14:56:27 INFO - 'TERM': 'linux', 14:56:27 INFO - 'TMOUT': '86400', 14:56:27 INFO - 'USER': 'cltbld', 14:56:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:27 INFO - '_': '/tools/buildbot/bin/python'} 14:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:27 INFO - Downloading/unpacking jsonschema==2.5.1 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:56:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:56:31 INFO - warning: no files found matching '*.txt' 14:56:31 INFO - no previously-included directories found matching 'build' 14:56:31 INFO - no previously-included directories found matching 'dist' 14:56:31 INFO - no previously-included directories found matching '.git*' 14:56:31 INFO - Installing collected packages: jsonschema, functools32 14:56:31 INFO - Running setup.py install for functools32 14:56:31 INFO - warning: no files found matching '*.txt' 14:56:31 INFO - no previously-included directories found matching 'build' 14:56:31 INFO - no previously-included directories found matching 'dist' 14:56:31 INFO - no previously-included directories found matching '.git*' 14:56:31 INFO - Successfully installed jsonschema functools32 14:56:31 INFO - Cleaning up... 14:56:31 INFO - Return code: 0 14:56:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:56: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')]} 14:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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')]} 14:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:31 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:31 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 14:56:31 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 14:56:31 INFO - Using env: {'DISPLAY': ':0', 14:56:31 INFO - 'HOME': '/home/cltbld', 14:56:31 INFO - 'LANG': 'en_US.UTF-8', 14:56:31 INFO - 'LANGUAGE': 'en_US:en', 14:56:31 INFO - 'LOGNAME': 'cltbld', 14:56:31 INFO - 'MAIL': '/var/mail/cltbld', 14:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:31 INFO - 'MOZ_NO_REMOTE': '1', 14:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:31 INFO - 'NO_EM_RESTART': '1', 14:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:31 INFO - 'PWD': '/builds/slave/test', 14:56:31 INFO - 'SHELL': '/bin/bash', 14:56:31 INFO - 'SHLVL': '1', 14:56:31 INFO - 'TERM': 'linux', 14:56:31 INFO - 'TMOUT': '86400', 14:56:31 INFO - 'USER': 'cltbld', 14:56:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:31 INFO - '_': '/tools/buildbot/bin/python'} 14:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:56:31 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 14:56:31 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 14:56:31 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 14:56:31 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 14:56:31 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 14:56:31 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 14:56:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:56:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:56:33 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 14:56:33 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 14:56:33 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 14:56:33 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 14:56:33 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 14:56:33 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 14:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:56:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:56:33 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 14:56:33 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 14:56:34 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 14:56:34 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 14:56:34 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 14:56:34 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 14:56:34 INFO - Downloading docopt-0.6.1.tar.gz 14:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:56:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:56:34 INFO - Running setup.py install for blobuploader 14:56:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:56:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:56:34 INFO - Running setup.py install for requests 14:56:34 INFO - Running setup.py install for docopt 14:56:34 INFO - Successfully installed blobuploader requests docopt 14:56:34 INFO - Cleaning up... 14:56:34 INFO - Return code: 0 14:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56: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')]} 14:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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')]} 14:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:34 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:34 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 14:56:34 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 14:56:34 INFO - Using env: {'DISPLAY': ':0', 14:56:34 INFO - 'HOME': '/home/cltbld', 14:56:34 INFO - 'LANG': 'en_US.UTF-8', 14:56:34 INFO - 'LANGUAGE': 'en_US:en', 14:56:34 INFO - 'LOGNAME': 'cltbld', 14:56:34 INFO - 'MAIL': '/var/mail/cltbld', 14:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:34 INFO - 'MOZ_NO_REMOTE': '1', 14:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:34 INFO - 'NO_EM_RESTART': '1', 14:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:34 INFO - 'PWD': '/builds/slave/test', 14:56:34 INFO - 'SHELL': '/bin/bash', 14:56:34 INFO - 'SHLVL': '1', 14:56:34 INFO - 'TERM': 'linux', 14:56:34 INFO - 'TMOUT': '86400', 14:56:34 INFO - 'USER': 'cltbld', 14:56:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:34 INFO - '_': '/tools/buildbot/bin/python'} 14:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:35 INFO - Running setup.py (path:/tmp/pip-KLCgZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:35 INFO - Running setup.py (path:/tmp/pip-5c7uBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:35 INFO - Running setup.py (path:/tmp/pip-ONPpBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:35 INFO - Running setup.py (path:/tmp/pip-KfEBOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:35 INFO - Running setup.py (path:/tmp/pip-V59IQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:35 INFO - Running setup.py (path:/tmp/pip-W68kgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:35 INFO - Running setup.py (path:/tmp/pip-z7Mb03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:35 INFO - Running setup.py (path:/tmp/pip-moP1ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:35 INFO - Running setup.py (path:/tmp/pip-D1Kgyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:35 INFO - Running setup.py (path:/tmp/pip-s74ZSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:35 INFO - Running setup.py (path:/tmp/pip-JBfk73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:35 INFO - Running setup.py (path:/tmp/pip-zci_2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:35 INFO - Running setup.py (path:/tmp/pip-asMTwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:36 INFO - Running setup.py (path:/tmp/pip-00uSZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:36 INFO - Running setup.py (path:/tmp/pip-xg6Yhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:36 INFO - Running setup.py (path:/tmp/pip-ANUiFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:36 INFO - Running setup.py (path:/tmp/pip-KznmAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:56:36 INFO - Running setup.py install for manifestparser 14:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:56:36 INFO - Running setup.py install for mozcrash 14:56:36 INFO - Running setup.py install for mozdebug 14:56:36 INFO - Running setup.py install for mozdevice 14:56:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:56:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:56:36 INFO - Running setup.py install for mozfile 14:56:36 INFO - Running setup.py install for mozhttpd 14:56:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:56:36 INFO - Running setup.py install for mozinfo 14:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for mozInstall 14:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for mozleak 14:56:37 INFO - Running setup.py install for mozlog 14:56:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for moznetwork 14:56:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for mozprocess 14:56:37 INFO - Running setup.py install for mozprofile 14:56:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for mozrunner 14:56:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:56:37 INFO - Running setup.py install for mozscreenshot 14:56:37 INFO - Running setup.py install for moztest 14:56:37 INFO - Running setup.py install for mozversion 14:56:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:56:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:56:38 INFO - Cleaning up... 14:56:38 INFO - Return code: 0 14:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56: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')]} 14:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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')]} 14:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:38 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:38 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 14:56:38 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 14:56:38 INFO - Using env: {'DISPLAY': ':0', 14:56:38 INFO - 'HOME': '/home/cltbld', 14:56:38 INFO - 'LANG': 'en_US.UTF-8', 14:56:38 INFO - 'LANGUAGE': 'en_US:en', 14:56:38 INFO - 'LOGNAME': 'cltbld', 14:56:38 INFO - 'MAIL': '/var/mail/cltbld', 14:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:38 INFO - 'MOZ_NO_REMOTE': '1', 14:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:38 INFO - 'NO_EM_RESTART': '1', 14:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:38 INFO - 'PWD': '/builds/slave/test', 14:56:38 INFO - 'SHELL': '/bin/bash', 14:56:38 INFO - 'SHLVL': '1', 14:56:38 INFO - 'TERM': 'linux', 14:56:38 INFO - 'TMOUT': '86400', 14:56:38 INFO - 'USER': 'cltbld', 14:56:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:38 INFO - '_': '/tools/buildbot/bin/python'} 14:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:38 INFO - Running setup.py (path:/tmp/pip-bZ2UOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:38 INFO - Running setup.py (path:/tmp/pip-M94yDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:38 INFO - Running setup.py (path:/tmp/pip-cs7lul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:38 INFO - Running setup.py (path:/tmp/pip-K6MDmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:38 INFO - Running setup.py (path:/tmp/pip-rCVBZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:38 INFO - Running setup.py (path:/tmp/pip-mXBXZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:38 INFO - Running setup.py (path:/tmp/pip-YtrYwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:38 INFO - Running setup.py (path:/tmp/pip-mH7shb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:38 INFO - Running setup.py (path:/tmp/pip-Feo3le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:38 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)) 14:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:38 INFO - Running setup.py (path:/tmp/pip-3CRkQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:39 INFO - Running setup.py (path:/tmp/pip-o4jCI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:39 INFO - Running setup.py (path:/tmp/pip-_dHij3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:39 INFO - Running setup.py (path:/tmp/pip-8gIkSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:39 INFO - Running setup.py (path:/tmp/pip-XMWwsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:39 INFO - Running setup.py (path:/tmp/pip-IUBQEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:39 INFO - Running setup.py (path:/tmp/pip-0oXy8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:39 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)) 14:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:39 INFO - Running setup.py (path:/tmp/pip-o8cOBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:39 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)) 14:56:39 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)) 14:56:39 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)) 14:56:39 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)) 14:56:39 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)) 14:56:39 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)) 14:56:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:42 INFO - Downloading blessings-1.6.tar.gz 14:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:56:42 INFO - Installing collected packages: blessings 14:56:42 INFO - Running setup.py install for blessings 14:56:42 INFO - Successfully installed blessings 14:56:42 INFO - Cleaning up... 14:56:42 INFO - Return code: 0 14:56:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:42 INFO - Reading from file tmpfile_stdout 14:56:42 INFO - Current package versions: 14:56:42 INFO - argparse == 1.2.1 14:56:42 INFO - blessings == 1.6 14:56:42 INFO - blobuploader == 1.2.4 14:56:42 INFO - docopt == 0.6.1 14:56:42 INFO - functools32 == 3.2.3-2 14:56:42 INFO - jsonschema == 2.5.1 14:56:42 INFO - manifestparser == 1.1 14:56:42 INFO - mozInstall == 1.12 14:56:42 INFO - mozcrash == 0.17 14:56:42 INFO - mozdebug == 0.1 14:56:42 INFO - mozdevice == 0.48 14:56:42 INFO - mozfile == 1.2 14:56:42 INFO - mozhttpd == 0.7 14:56:42 INFO - mozinfo == 0.9 14:56:42 INFO - mozleak == 0.1 14:56:42 INFO - mozlog == 3.2 14:56:42 INFO - moznetwork == 0.27 14:56:42 INFO - mozprocess == 0.22 14:56:42 INFO - mozprofile == 0.28 14:56:42 INFO - mozrunner == 6.11 14:56:42 INFO - mozscreenshot == 0.1 14:56:42 INFO - mozsystemmonitor == 0.3 14:56:42 INFO - moztest == 0.7 14:56:42 INFO - mozversion == 1.4 14:56:42 INFO - psutil == 3.1.1 14:56:42 INFO - requests == 1.2.3 14:56:42 INFO - wsgiref == 0.1.2 14:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:42 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 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:42 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 14:56:42 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 14:56:42 INFO - Using env: {'DISPLAY': ':0', 14:56:42 INFO - 'HOME': '/home/cltbld', 14:56:42 INFO - 'LANG': 'en_US.UTF-8', 14:56:42 INFO - 'LANGUAGE': 'en_US:en', 14:56:42 INFO - 'LOGNAME': 'cltbld', 14:56:42 INFO - 'MAIL': '/var/mail/cltbld', 14:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:42 INFO - 'MOZ_NO_REMOTE': '1', 14:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:42 INFO - 'NO_EM_RESTART': '1', 14:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:42 INFO - 'PWD': '/builds/slave/test', 14:56:42 INFO - 'SHELL': '/bin/bash', 14:56:42 INFO - 'SHLVL': '1', 14:56:42 INFO - 'TERM': 'linux', 14:56:42 INFO - 'TMOUT': '86400', 14:56:42 INFO - 'USER': 'cltbld', 14:56:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:42 INFO - '_': '/tools/buildbot/bin/python'} 14:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 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)) 14:56:42 INFO - Cleaning up... 14:56:42 INFO - Return code: 0 14:56:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:56:42 INFO - Using env: {'DISPLAY': ':0', 14:56:42 INFO - 'HOME': '/home/cltbld', 14:56:42 INFO - 'LANG': 'en_US.UTF-8', 14:56:42 INFO - 'LANGUAGE': 'en_US:en', 14:56:42 INFO - 'LOGNAME': 'cltbld', 14:56:42 INFO - 'MAIL': '/var/mail/cltbld', 14:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:42 INFO - 'MOZ_NO_REMOTE': '1', 14:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:42 INFO - 'NO_EM_RESTART': '1', 14:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:42 INFO - 'PWD': '/builds/slave/test', 14:56:42 INFO - 'SHELL': '/bin/bash', 14:56:42 INFO - 'SHLVL': '1', 14:56:42 INFO - 'TERM': 'linux', 14:56:42 INFO - 'TMOUT': '86400', 14:56:42 INFO - 'USER': 'cltbld', 14:56:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:42 INFO - '_': '/tools/buildbot/bin/python'} 14:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:56:43 INFO - Cleaning up... 14:56:43 INFO - Return code: 0 14:56:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b0571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', '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 14:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:56:43 INFO - Using env: {'DISPLAY': ':0', 14:56:43 INFO - 'HOME': '/home/cltbld', 14:56:43 INFO - 'LANG': 'en_US.UTF-8', 14:56:43 INFO - 'LANGUAGE': 'en_US:en', 14:56:43 INFO - 'LOGNAME': 'cltbld', 14:56:43 INFO - 'MAIL': '/var/mail/cltbld', 14:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:43 INFO - 'MOZ_NO_REMOTE': '1', 14:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:43 INFO - 'NO_EM_RESTART': '1', 14:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:43 INFO - 'PWD': '/builds/slave/test', 14:56:43 INFO - 'SHELL': '/bin/bash', 14:56:43 INFO - 'SHLVL': '1', 14:56:43 INFO - 'TERM': 'linux', 14:56:43 INFO - 'TMOUT': '86400', 14:56:43 INFO - 'USER': 'cltbld', 14:56:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:43 INFO - '_': '/tools/buildbot/bin/python'} 14:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:43 INFO - Downloading/unpacking flake8 14:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:56:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:56:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:45 INFO - no previously-included directories found matching 'docs/_build' 14:56:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:56:46 INFO - Running setup.py install for pep8 14:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:46 INFO - no previously-included directories found matching 'docs/_build' 14:56:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:56:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:56:46 INFO - Cleaning up... 14:56:46 INFO - Return code: 0 14:56:46 INFO - Running post-action listener: _resource_record_post_action 14:56:46 INFO - Running post-action listener: _start_resource_monitoring 14:56:46 INFO - Starting resource monitoring. 14:56:46 INFO - ##### 14:56:46 INFO - ##### Finished create-virtualenv step (success) 14:56:46 INFO - ##### 14:56:46 INFO - ##### 14:56:46 INFO - ##### Running install step. 14:56:46 INFO - ##### 14:56:46 INFO - Running pre-action listener: _resource_record_pre_action 14:56:46 INFO - Running main action method: install 14:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:46 INFO - Reading from file tmpfile_stdout 14:56:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:56:46 INFO - Reading from file tmpfile_stdout 14:56:46 INFO - Output received: 14:56:46 INFO - Usage: mozinstall [options] installer 14:56:46 INFO - Options: 14:56:46 INFO - -h, --help show this help message and exit 14:56:46 INFO - -d DEST, --destination=DEST 14:56:46 INFO - Directory to install application into. [default: 14:56:46 INFO - "/builds/slave/test"] 14:56:46 INFO - --app=APP Application being installed. [default: firefox] 14:56:46 INFO - mkdir: /builds/slave/test/build/application 14:56:46 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'] 14:56:46 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 14:57:02 INFO - Reading from file tmpfile_stdout 14:57:02 INFO - Output received: 14:57:02 INFO - /builds/slave/test/build/application/firefox/firefox 14:57:02 INFO - Running post-action listener: _resource_record_post_action 14:57:02 INFO - ##### 14:57:02 INFO - ##### Finished install step (success) 14:57:02 INFO - ##### 14:57:02 INFO - ##### 14:57:02 INFO - ##### Running run-tests step. 14:57:02 INFO - ##### 14:57:02 INFO - Running pre-action listener: _resource_record_pre_action 14:57:02 INFO - Running main action method: run_tests 14:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:57:02 INFO - Python 2.7.3 14:57:02 INFO - Return code: 0 14:57:02 INFO - grabbing minidump binary from tooltool 14:57:02 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')]} 14:57:02 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 0x2b902e0>, '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 0x2afc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afc5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:57:02 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 14:57:02 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 14:57:02 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 14:57:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:57:02 INFO - Return code: 0 14:57:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:57:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:57:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:57:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:57:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:57:03 INFO - Return code: 0 14:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 14:57:03 INFO - Using env: {'DISPLAY': ':0', 14:57:03 INFO - 'HOME': '/home/cltbld', 14:57:03 INFO - 'LANG': 'en_US.UTF-8', 14:57:03 INFO - 'LANGUAGE': 'en_US:en', 14:57:03 INFO - 'LOGNAME': 'cltbld', 14:57:03 INFO - 'MAIL': '/var/mail/cltbld', 14:57:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:57:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:03 INFO - 'MOZ_NO_REMOTE': '1', 14:57:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:03 INFO - 'NO_EM_RESTART': '1', 14:57:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:03 INFO - 'PWD': '/builds/slave/test', 14:57:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:57:03 INFO - 'SHELL': '/bin/bash', 14:57:03 INFO - 'SHLVL': '1', 14:57:03 INFO - 'TERM': 'linux', 14:57:03 INFO - 'TMOUT': '86400', 14:57:03 INFO - 'USER': 'cltbld', 14:57:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828', 14:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:03 INFO - '_': '/tools/buildbot/bin/python'} 14:57:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:57:03 INFO - mozversion application_buildid: 20160624133758 14:57:03 INFO - mozversion application_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 14:57:03 INFO - mozversion application_display_name: Nightly 14:57:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:57:03 INFO - mozversion application_name: Firefox 14:57:03 INFO - mozversion application_remotingname: firefox 14:57:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:57:03 INFO - mozversion application_vendor: Mozilla 14:57:03 INFO - mozversion application_version: 50.0a1 14:57:03 INFO - mozversion platform_buildid: 20160624133758 14:57:03 INFO - mozversion platform_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 14:57:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:57:03 INFO - mozversion platform_version: 50.0a1 14:57:03 INFO - using testdate: 1466805423 14:57:03 INFO - actual date: 1466805423 14:57:03 INFO - starting webserver on 'localhost:38690' 14:57:03 INFO - SUITE-START | Running 2 tests 14:57:03 INFO - TEST-START | dromaeo_css 14:57:03 INFO - operating with platform_type : linux_ 14:57:03 INFO - Initialising browser for dromaeo_css test... 14:57:03 INFO - TEST-INFO | started process 8442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAhipf/profile http://localhost:38690/getInfo.html) 14:57:08 INFO - PROCESS | 8442 | __metrics Screen width/height:1600/1200 14:57:08 INFO - PROCESS | 8442 | colorDepth:24 14:57:08 INFO - PROCESS | 8442 | Browser inner width/height: 1024/697 14:57:08 INFO - PROCESS | 8442 | __metrics 14:57:09 INFO - PROCESS | 8442 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:57:10 INFO - TEST-INFO | 8442: exit 0 14:57:10 INFO - Browser initialized. 14:57:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:57:10 INFO - TEST-INFO | started process 8526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAhipf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:22 INFO - PROCESS | 8526 | RSS: Main: 175726592 14:57:22 INFO - PROCESS | 8526 | 14:58:14 INFO - PROCESS | 8526 | 1466805494217 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] 15:00:26 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38690/tests/dromaeo/cssquery-ext.html) 15:00:27 INFO - PROCESS | 8526 | RSS: Main: 281649152 15:00:27 INFO - PROCESS | 8526 | 15:03:29 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-ext.html (next: http://localhost:38690/tests/dromaeo/cssquery-jquery.html) 15:03:30 INFO - PROCESS | 8526 | RSS: Main: 248176640 15:03:30 INFO - PROCESS | 8526 | 15:06:32 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38690/tests/dromaeo/cssquery-mootools.html) 15:06:33 INFO - PROCESS | 8526 | RSS: Main: 259162112 15:06:33 INFO - PROCESS | 8526 | 15:09:35 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38690/tests/dromaeo/cssquery-prototype.html) 15:09:36 INFO - PROCESS | 8526 | RSS: Main: 260558848 15:09:36 INFO - PROCESS | 8526 | 15:12:39 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38690/tests/dromaeo/cssquery-yui.html) 15:12:39 INFO - PROCESS | 8526 | RSS: Main: 240193536 15:12:39 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-yui.html (next: http://localhost:38690/tests/dromaeo/cssquery-dojo.html) 15:15:42 INFO - PROCESS | 8526 | RSS: Main: 291778560 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | __start_tp_report 15:15:42 INFO - PROCESS | 8526 | _x_x_mozilla_page_load 15:15:42 INFO - PROCESS | 8526 | _x_x_mozilla_page_load_details 15:15:42 INFO - PROCESS | 8526 | |i|pagename|runs| 15:15:42 INFO - PROCESS | 8526 | |0;dojo.html;2632.6182703507993;2636.7626913577774;2666.4000599865026;2679.1962411276622;2690.0719251858104;4731.00648863739;4814.590759785418;4835.443923948747;4931.630127740415;4970.1302272102375;4756.857294281169;4781.306710526971;4816.229403295473;4859.246816743402;4869.561739443449;4360.171567402183;4449.621782148505;4458.680713705754;4504.481984571784;4603.033362993775;4409.338599210112;4543.454785425737;4556.612687921531;4569.063342014879;4582.221022426195;4342.761148136851;4384.364267181273;4389.297712366006;4408.765545647224;4456.710313829623;4406.779661016936;4418.248897687401;4437.689361744679;4445.866624001253;4458.308962110846;4453.421055262827;4454.933176002362;4456.086502267028;4457.1977044132045;4493.9101217975785;4685.835995740167;4692.624590032823;4862.124817532843;4907;4921.876953076166;5071.061853557104;5091.592672586185;5133.486651334874;5141.434442211354;5143.562797162208;5136.768845401966;5161.509656582619;5166.948330516684;5180.844574662766;5187.8184263550975;4656.8137274508645;4796.112719146969;4830.734309613005;4840.177169881058;4842.564169224752;5364.329458817648;5368.91946620801;5375.6774593524515;5378.73106344689;5389.730513474311;5133.101707201225;5156.20078887773;5158.458361872024;5158.896822063538;5160.509751573594;5014.924776128361;5130.050940576006;5204.869878253074;5212.374515058217;5244;5118.436971933084;5151.484851514819;5173.637845350864;5175.378954525481;5230.398504172069;5153.484651534892;5177.870553236124;5180.6891586504935;5182.689038657692;5229.424763276036;4312.676549258818;4349.369341445473;4399.64802815774;4442.400275962704;4445.310976798602;3839.1361943562474;3851.056491159684;3858.112634094174;3874.1864208516527;3928.0769019280447;4439.955600444019;4466.7766611669285;4473.821047158077;4491.101779644085;4515.525869783691;5026.396832380138;5140.049090918192;5155.226715992556;5240.6069544784295;5296.841094767086;4407.537208593116;4439.489458712224;4466.129104824593;4473.821047158142;4479.3057076153245;4698.8355407560575;4700.835470758507;4701.741404222732;4703.212779143972;4739.86243301612;4633.4903160652975;4657.441107067174;4854.223324268241;4859.7327147005835;4893.388326459192;5008.273800299009;5051.646384753032;5101.770420331169;5103.515166059218;5104.1067813133295;4698.859034228979;4700.76496175183;4700.92948605778;4704.50602686713;4751.121042607128;4959.578435832995;4988.077205716954;4995.17579599362;5000.949990500194;5043.571296439697;5098.974505127599;5199.194124910645;5214.634975551675;5244.895102098013;5245.396779370269;5037.370328708911;5043.394792624908;5057.671251368649;5088.287639730367;5104.540591346797;4874.878128046827;4949.406071271471;5081.263216833465;5095.15929871567;5095.439501654889;4931.827386041471;5025.673331233458;5071.087204303113;5072.721000345016;5074.188129899198;5098.031374038921;5098.694078355311;5102.566281866083;5109.514596113363;5159.767810448614;4831.637627177905;4834.154023045882;4840.588549973291;5004.724740139181;5053.166227572409 15:15:42 INFO - PROCESS | 8526 | |1;ext.html;552.9850432048805;575.3900865083011;579.4032146888703;584.5937073733757;588.129568239006;26916.59625105625;40088;41099.178016439655;41286.38070428946;41415.378769318406;41521.16957660845;41808.37287440691;41829;41843.16313673725;41997.790011049976;7460.664270107858;7854.332381747544;8018.839623207532;8027.799305017363;10198.286119971568;9892.703218903445;10285.79428411435;10290.639827606035;10314.690559283234;10323.174146068297;10336.276460647758;10375.221858360615;10375.896241037568;10390.116840068604;10393.32443391181;7601.429892758038;10129.797404051878;10293.330933489298;10393.584256629802;10406.79186416275;10244.846327305097;10322.174226061898;10325.948370258177;10329.070383665507;10333.896661033368;38416.615833841584;38636;38682;38704.22591548153;38855.41716874249;3069.754419646445;3124.5313203019728;3653.6163702811086;3683.410654295327;3726.571444283915;28787.56818647722;29299.70700292991;29304.706952930625;29690;29795.004065993926;3442.8278586070846;3503.754737168399;3510.473428985647;3534.5581802274714;3605.2248766515327;260279;261271;261601;262367;262806;51151;51450;51481.48518514767;51499.742501287255;51503.74248128735;32505;33544;33574.49638255428;35349.82325088358;35356.82321588427;14048.578542643738;14168.645783855485;14217;14302.57092287233;14358.784618230735;10260.384376937407;11074.612388566522;11318.094552435785;11351.091912647134;11602.477888495037;18112.45662630123;18312.725309120375;18322.175502102436;18362;18372.540686482946;6709.228438729511;6717.932820671731;6720.361565651256;6902.827429314308;6930.613877224575;812.5287333346645;883.1698203688512;888.5201990924958;953.9189168920581;961.9706913602379;26873.731262687514;28203;28345.149645510668;28631.856840715664;28861.56707649387;865.2472349056236;919.7654598077447;973.9853902191472;981.9950900245453;991.2714155095998;14453.49412770548;14755.852441475663;14911;15157.621059473602;15304.158271294962;393261;395831;398265;400045;401479;48714;48972.75513622409;49057.75471122622;49422.752886235336;49458.752706236235;1042.4475028235047;1144.5021415684205;1176.4647085576041;1184.9335597961904;1211.854577450694;27950.16149515518;28880.277993050342;29054.12837614875;29178.228068334323;29436.264093397836;40755.7962210187;41335.586644133175;41392.172156556095;41392.37911431391;41398.79300603478;236771;242224;242409;243093;243213;22050.44873878166;23808;24604.507909841344;25020.249392518253;26652.733472665026;41861;42082;42200.15599687928;42827.357589635554;43149.78425107854;34481.31037379288;35776.8211158953;36119.45820812743;36511.26977460489;36925.23060770399;35595;35731.10672233215;35889.282214355044;35933.64066359303;36177.81911090533;35756.82121589375;35833.46249806307;36859.63140368562;37587.248255035294;37776.24447511089;30930.690693093682;33005.66994330026;33279;33409.66590334163;33703;25178.74821251764;25697.871510642326;25835.870820645778;25868;25934.481310374063 15:15:42 INFO - PROCESS | 8526 | |2;jquery.html;374.1301474072781;375.8402678861483;380.53194570678085;389.9746516476429;391.02634440243804;15885.523434296974;17459.3016279349;17631.29474821007;17912;17940.102994850255;17102.743458848126;17120.229589668463;17268;17582.384616538424;17611.471655850313;5094.032133894558;5307.548858347045;5326.280952071479;5340.706261155635;5353.9196912046355;3752.8874133775894;3948.1708841143395;5933.258342707161;6233.283172435183;6251.062340648917;5976.013957696975;6271.874562508747;6282.465990390822;6294.811155665315;6308.684565771716;6152.16945712332;6180.629162250257;6188.566800323979;6195.721192546302;6216.036514340284;3431.1422144463886;5009.974950125263;5373;5373.81191658294;5458.044842152647;20022.79977200224;20711.5857682847;20765.79234207669;20779.480512987295;20898.477538061517;1992.7708313543983;2181.9345419637434;2354.7409784923643;2461.692288463942;2518.609615509599;12180.330081845495;13000.414981325768;13190.47238110484;13214.537491187762;13554.457821687121;1729.6021914959629;1779.8487128594086;1796.2455768577229;1807.3132209760206;1873.5222518257758;65552.3444765551;65557.3444265556;66575;67525.9999999995;67805.66097169532;9652.75868103303;9737.22102231834;9906.829814459448;10210.081092701692;10308.32995855267;13521.391537380645;13596.11625244356;13598.93200533991;13621.727565448635;13627.659308517168;7001.439884809203;7018.403435708022;7064.858702825914;7192.100987376578;7193.784186474414;6640.800775976729;6733.192016957898;6760;6846.486513511407;6869.141357330333;6156.8758778221445;6167.599106058092;6247.937520624736;6263.404976527223;6283.214598175228;1577.4557777566952;1666.6749983753052;1763.021523054717;1771.9822801772075;1780.910954452272;816.3142959913582;871.54679566625;895.8118795052982;917.499962520428;960.1694534227983;15105.47130850415;16931.492055238363;18392.540186495444;18500.814991850177;18687.81312186888;876.027609353617;889.1819526036062;900.9954950225207;933.2394098809449;949.5442187749919;8131.674733010614;9540.761480962892;9850.605975761033;9924;10005.549750261256;382402;387627;387694;390334;398723;74594.62702686452;78707.21292786999;81137.59431202806;81201;82070.58964705138;946.8911075226437;956.3496822160859;960.6397600899662;996.2428554298785;1005.9346142500714;16223.269952852386;16332.510024699279;16390.508284751475;16404.425845095364;16467.83532164663;36281.09297267589;36349;36667;37197;37319.25361492809;49964.50035499599;50433;51549;52181.95636087181;52495.475045249055;7678.654460549177;7679.2704693054075;7742.845143097219;7945.8410831784195;7962.641681124479;10736.838947415952;12200.75598488043;12215.938920305342;12342.13605047638;12369.257844529357;10223.948880255552;10414.271001030158;10434.530446130095;10436.686899393031;10508.527116279938;10634.680959571226;10652.09457196147;10675.454680608738;10697.358158510515;10914.072303854262;10449.268551201343;10578.418186999788;10611.628592999208;10641.148708103488;10754.677359679223;7583.544987300779;7806.41451891099;7921.564313962787;8081.515109093473;8124.878126828221;9553.570089346134;10197.898021019695;10306.845397319195;10408.635697750542;10689.9465502672 15:15:42 INFO - PROCESS | 8526 | |3;mootools.html;1186.899113575346;1385.425048604829;1410.1750475971555;1478.70425914817;1702.9659406811863;6538.901916471251;7313.707451701932;7629.923700762991;7659.885101723478;7815.2966233039015;7587.658555365008;7727.304542591166;7737.57443340616;7739.4195435342435;7746.225377462251;1842.9447116586523;2096.622607930572;2119.6290649136376;2145.3992881993067;2182.9890850545726;2116.4179850541145;2138.134055707441;2139.048123585005;2139.497218153733;2144.592527419793;2094.3193462124796;2112.22903640171;2158.859674121185;2165.0257384177103;2170.815480684144;1784.0633667324628;1839.5125291797685;1842.4380563927996;1995.3016444244543;2061.6598261286945;2082.7500699915954;2114.228306668055;2115.5768846230817;2117.523557199633;2118.449203207177;7657.4639775215755;7704;7705.730299439493;7709.190534993857;7716.7684969451;4349.760763158025;4487.102579484116;4496.685232033759;4498.910021799546;4502.189605870942;2693.5690289553577;2783.958240626372;2829.1795379339965;2844.900428485014;2902.680705122435;872.4808738800403;883.7039591736776;885.3669626217221;900.9369344145913;923.3213588012806;10547.314424562379;10569.524371403382;10575;10578;10578.312409693423;4126.628603425646;4155.168966206771;4156.251874662529;4225.852095176716;4283.400323954649;8842.115788421106;8864.73405797827;8872.8669069964;8873.955630221937;8880.289576833968;4704.811807527661;4712.363830882856;4719.315699223594;4726.1492931272705;4730.5032971538185;3678.5401824771902;4105.4662893823615;4208.579142085829;4216.641585465209;4285.721428107163;3628.9274214515563;3652.068722475805;3696.963030369716;3744.681702055356;3801.8669346572738;1148.586508856811;1168.1788480818898;1183.0240051957169;1184.810430331143;1195.3485350484007;739.3493725521506;848.2365870716282;855.1512921733785;860.0453496618749;875.1991927386371;5183.611229157828;5230.843074707765;5317.946820531823;5350.91973620396;5491.148871924858;405.9127287633173;408.2753113224051;410.6571013204008;413.09119936140013;414.2812220796915;3677.7609455385314;3681.9447708284397;3698.4822124902535;3715.5169827922196;3746.138388170736;9100.681476148304;9372.812543749087;9397.389169704084;9464.858027129598;9467.905320946702;9132.954335228282;9350.392224505385;9371.531423428802;9380.95309523448;9408.576614052246;7180.210176880539;7183.173934997542;7282.344588986911;7300.868365403265;7323.450741194431;5080.542751152414;5227.529522343008;5254.343207099113;5339.092354299701;5369.6509726867625;8663.566821659018;8670.956645216733;8671.393002489765;8851.247643950337;8853.38026338176;8227.71203007892;8540.74377768668;8563.143685631387;8889.022207557293;8893.066228045962;5961.791337303173;6172.135900973957;6172.753089876354;6590.47276217911;6742.595444273359;6778.017187507685;6845;6884.965575172092;7064.258252883579;7085.326893945067;6459.192600924885;6559.967200163968;6655.667216639245;6659.533832631863;6685.799426017227;6549.508786841101;6552.148220731275;6581.308962559054;6592.110065141336;6602.801915942529;5887.499562537232;5912.881742365214;5951.404859514014;5957.731902064331;5960.225170727777;4516.345129956204;4572.908541829212;4707.764611769467;4731.408573928259;4789.209780386197;4682.765861706833;4754.762261886823;4755.881102972453;4783.06730187624;4800.35195248637 15:15:42 INFO - PROCESS | 8526 | |4;prototype.html;282.92078218098925;295.6260330681687;297.1531136261654;299.3937277014046;304.11350912091257;4814.446338671054;4923.335349727795;4933.18602430599;4984.875378115545;5003.774830132644;4733.313669517918;4888.217885138379;4888.388951381077;4909.33723947267;4916.041371932466;3875.4961854958815;3877.5346958365035;3887.9805600972027;3891.299566078119;3908.667763240128;3745.8013435700586;3750.49368335274;3888.2612303662354;3889.3193691103943;3907.882763517099;3817.2556351511466;3828.6408325044627;3832.712546559005;3832.7508711933774;3834.8466061357512;3823.483829682999;3847.2690188864167;3851.6726078283377;3858.594847540996;3908.6286802753693;3438.3639026780124;3447.120984149026;3450.8274586270586;3452.1369657585606;3470.548828652259;4639.62882969365;4763.737994410306;4765.690230135065;4769.976150119227;4812.687175333592;4355.80398882051;4371.4098596689355;4379.255526560492;4395.560443955611;4405.493368262659;5104.617153713486;5120.513551212629;5122.897542049175;5162.489507135147;5180.896382072375;3447.7414193935556;3636.890748321761;3645.981770091159;3665;3722.274156539476;5368.677879327252;5381.677099374011;5383.869387428645;5403.459654034605;5412.999999999961;3689.2990331836863;3712.5916149223563;3716.7398282119993;3732;3742.7754334740002;3689.8339574719203;3765.548134223911;3796.0509872531866;3800.8669696560487;3801.315763162602;4273.594008569181;4306.310990241546;4306.655467562588;4324.329728892027;4324.935125973113;5122.282880396748;5130.692158470503;5137.640365174477;5150.19743089923;5193.428722840485;1233.5990802989065;1256.654420034498;1290.148501988683;1301.5965050834272;1304.1066869194633;813.6615267884297;828.8218033122907;836.4897412578322;839.4040231435627;848.7665891879783;4055.9391609125887;4087.3664581989838;4093.570175131628;4104.302268614283;4124.381342798604;4665.300204969214;4674.64435313762;4683.367745354401;4693.037927224911;4780.1873681474235;4044.2720310343834;4079.5308539518337;4082.4488694026522;4099.590040995877;4121.464209652726;2359.528094381131;2526.166365099513;2537.733537978486;2540.2379286214064;2562.8334158279654;4384.254676704968;4431.512533621363;4447.3773671685985;4458.308962110878;4486.416765820488;4856.757162141878;4864.294677271847;4878.585320247747;4900.975495122501;4911.336969509142;4174.666026717855;4376.468236117397;4409.4944519107385;4427.889302767457;4482.977585112054;4648.628109751144;4667.206574882211;4680.461746899014;4699.955519348958;4707.952920470751;4578.931316030329;4582.633389328779;4590.347474908964;4627.282771170474;4660.603848672901;4066.9389959151226;4403.713758605681;4411.7941029485255;4421.513633500248;4429;3380.864765409356;3416.6924976751216;3417.3336199441865;3423.0757695422594;3426.4003799335514;4717.363155974037;4727.220008698526;4734.644901632322;4750.263709125091;5042.672226305279;4998.850034498971;5183.377994640668;5195;5222.321098257202;5233.581313494988;5195.298634684269;5196.168613021899;5235.821940063607;5242.711650859239;5251.422343542131;4884.316195732671;5131.717755523333;5153.845384638467;5159.148740457783;5166.60501664541;5221.817236396708;5247.632665713363;5248.186531087687;5251.501107394792;5257.710825904612;5125.384953805567;5139.460356662496;5142.17725163987;5162.09663308927;5163.199704045879 15:15:42 INFO - PROCESS | 8526 | |5;yui.html;641.1856941684061;645.870825834833;652.1977967100469;722.7759394587677;732.7288903105851;11903.880961190396;12905.548305809298;14682.559523214293;15624.140672263022;15626.453074142408;13709.725805483884;13756.862431375683;13799.310034498285;13814.723705525883;13837.169769813818;628.3841835001701;783.3380793229712;798.620655188785;808.0263282744279;811.1928631012152;794.4915254237264;802.502448481939;803.2008151888879;803.3211935914172;803.3813963248296;837.6146972392706;840.8276303357796;841.7432683031673;842.0232530264894;842.0274582856811;664.2892105447173;814.4095530740166;828.7223780033696;833.170994860115;833.2375876073386;610.8381278961078;610.9236345456818;610.9389061093899;611.4649681528663;611.5169016476978;14040.859591404058;14048.719025619532;14091.50679726215;14106.858931410658;14115.929420352935;11916.34460104694;12363.505459781598;12760.361981900867;12840.293783841886;13098.083134180612;9521.381110227881;9877.160441362494;9929.404235745878;10025.84961225575;10108.191344692481;3325.7173140283103;3332.8333583320978;3356.446186379269;3384.5430866833153;3460.9307813843584;50829.745851270876;52062.739686301706;52200.21699674508;57121.71439142778;58190;10424.635137770141;10648.840267395995;10683.25217234786;10856.2400631955;10984.670459886216;18441.90779046123;18555.536111597048;18578.721319180222;18587.34944276944;18618.81381186198;7110.502264841515;7171.784846454615;7206.747763828241;7295.088113985752;7423.517471364344;3451.6720911513366;3530.3468858261303;3600.71194304455;3668.816559172031;3714.1086139326367;2898.826070435781;3002.639683237982;3012.9548056779167;3021.0483697635173;3022.1084779989956;504.5685938522584;511.19997204375034;518.9610779191576;520.2378515474848;526.8709166254292;462.4427564784427;473.5288388053908;479.76011994003;502.36200025966815;592.5526227698147;8048.436609437284;8265.545395003333;8270.462419942685;8375.706850260334;8480.109588493242;588.832182827892;589.354656650975;599.310792588518;601.7442586900637;620.3920158244945;3926.391409331558;4003.139325045129;4226.915461690811;4331.6534677225745;4369.6722745794195;100628.49685751525;101685.49157254166;101742;102210;103023.48488257511;85406.57296713477;85846;87656.12343876607;90381.09618903858;91553.54223228975;47386.289205661946;48206.75896620494;60698.39301607016;74284;75673.24326756662;8988.730338089868;8991.78476483651;9063.504521753837;9160.450372977642;9167.44995300284;44924;45129.774351129345;45558.54441455543;46663.53336466592;47821.28268076051;54588.45411545993;56368.7181564106;70142.64928675324;73623.63188184025;74193;10301.484925753532;10550.366977981346;10774.353538787698;11086.390248536409;11270.761142310923;11137.387443690352;11565.306081635128;12519.248845069325;13075.869241307466;13357.065005449525;11145.832812507657;12074.879251207727;12375.381230938237;12615.621531354074;13323.733525329246;12419.93790031044;12696.746065078461;12763.553275635308;13151.671208219488;13244.271565064015;11310.660680179608;11353.607869190677;11558.595449159238;12058.698532536757;12156.75686486283;9518.524073796421;9829.017098290115;9844.114029737359;9844.261680374144;9996.60013599477;9773.951130244588;9913.256505762241;10481.161507079263;10542.57829686804;10609.522571484147 15:15:42 INFO - PROCESS | 8526 | __end_tp_report 15:15:42 INFO - PROCESS | 8526 | __start_cc_report 15:15:42 INFO - PROCESS | 8526 | _x_x_mozilla_cycle_collect,941 15:15:42 INFO - PROCESS | 8526 | __end_cc_report 15:15:42 INFO - PROCESS | 8526 | __startTimestamp1466806542945__endTimestamp 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | ------- Summary: start ------- 15:15:42 INFO - PROCESS | 8526 | Number of tests: 6 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#0] dojo.html Cycles:165 Average:4774.27 Median:4869.56 stddev:503.76 (10.3%) stddev-sans-first:476.47 15:15:42 INFO - PROCESS | 8526 | Values: 2632.6 2636.8 2666.4 2679.2 2690.1 4731.0 4814.6 4835.4 4931.6 4970.1 4756.9 4781.3 4816.2 4859.2 4869.6 4360.2 4449.6 4458.7 4504.5 4603.0 4409.3 4543.5 4556.6 4569.1 4582.2 4342.8 4384.4 4389.3 4408.8 4456.7 4406.8 4418.2 4437.7 4445.9 4458.3 4453.4 4454.9 4456.1 4457.2 4493.9 4685.8 4692.6 4862.1 4907.0 4921.9 5071.1 5091.6 5133.5 5141.4 5143.6 5136.8 5161.5 5166.9 5180.8 5187.8 4656.8 4796.1 4830.7 4840.2 4842.6 5364.3 5368.9 5375.7 5378.7 5389.7 5133.1 5156.2 5158.5 5158.9 5160.5 5014.9 5130.1 5204.9 5212.4 5244.0 5118.4 5151.5 5173.6 5175.4 5230.4 5153.5 5177.9 5180.7 5182.7 5229.4 4312.7 4349.4 4399.6 4442.4 4445.3 3839.1 3851.1 3858.1 3874.2 3928.1 4440.0 4466.8 4473.8 4491.1 4515.5 5026.4 5140.0 5155.2 5240.6 5296.8 4407.5 4439.5 4466.1 4473.8 4479.3 4698.8 4700.8 4701.7 4703.2 4739.9 4633.5 4657.4 4854.2 4859.7 4893.4 5008.3 5051.6 5101.8 5103.5 5104.1 4698.9 4700.8 4700.9 4704.5 4751.1 4959.6 4988.1 4995.2 5000.9 5043.6 5099.0 5199.2 5214.6 5244.9 5245.4 5037.4 5043.4 5057.7 5088.3 5104.5 4874.9 4949.4 5081.3 5095.2 5095.4 4931.8 5025.7 5071.1 5072.7 5074.2 5098.0 5098.7 5102.6 5109.5 5159.8 4831.6 4834.2 4840.6 5004.7 5053.2 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#1] ext.html Cycles:180 Average:45578.17 Median:18962.07 stddev:81007.41 (427.2%) stddev-sans-first:81164.12 15:15:42 INFO - PROCESS | 8526 | Values: 553.0 575.4 579.4 584.6 588.1 26916.6 40088.0 41099.2 41286.4 41415.4 41521.2 41808.4 41829.0 41843.2 41997.8 7460.7 7854.3 8018.8 8027.8 10198.3 9892.7 10285.8 10290.6 10314.7 10323.2 10336.3 10375.2 10375.9 10390.1 10393.3 7601.4 10129.8 10293.3 10393.6 10406.8 10244.8 10322.2 10325.9 10329.1 10333.9 38416.6 38636.0 38682.0 38704.2 38855.4 3069.8 3124.5 3653.6 3683.4 3726.6 28787.6 29299.7 29304.7 29690.0 29795.0 3442.8 3503.8 3510.5 3534.6 3605.2 260279.0 261271.0 261601.0 262367.0 262806.0 51151.0 51450.0 51481.5 51499.7 51503.7 32505.0 33544.0 33574.5 35349.8 35356.8 14048.6 14168.6 14217.0 14302.6 14358.8 10260.4 11074.6 11318.1 11351.1 11602.5 18112.5 18312.7 18322.2 18362.0 18372.5 6709.2 6717.9 6720.4 6902.8 6930.6 812.5 883.2 888.5 953.9 962.0 26873.7 28203.0 28345.1 28631.9 28861.6 865.2 919.8 974.0 982.0 991.3 14453.5 14755.9 14911.0 15157.6 15304.2 393261.0 395831.0 398265.0 400045.0 401479.0 48714.0 48972.8 49057.8 49422.8 49458.8 1042.4 1144.5 1176.5 1184.9 1211.9 27950.2 28880.3 29054.1 29178.2 29436.3 40755.8 41335.6 41392.2 41392.4 41398.8 236771.0 242224.0 242409.0 243093.0 243213.0 22050.4 23808.0 24604.5 25020.2 26652.7 41861.0 42082.0 42200.2 42827.4 43149.8 34481.3 35776.8 36119.5 36511.3 36925.2 35595.0 35731.1 35889.3 35933.6 36177.8 35756.8 35833.5 36859.6 37587.2 37776.2 30930.7 33005.7 33279.0 33409.7 33703.0 25178.7 25697.9 25835.9 25868.0 25934.5 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#2] jquery.html Cycles:180 Average:24595.33 Median:194041.99 stddev:64247.33 (33.1%) stddev-sans-first:64401.83 15:15:42 INFO - PROCESS | 8526 | Values: 374.1 375.8 380.5 390.0 391.0 15885.5 17459.3 17631.3 17912.0 17940.1 17102.7 17120.2 17268.0 17582.4 17611.5 5094.0 5307.5 5326.3 5340.7 5353.9 3752.9 3948.2 5933.3 6233.3 6251.1 5976.0 6271.9 6282.5 6294.8 6308.7 6152.2 6180.6 6188.6 6195.7 6216.0 3431.1 5010.0 5373.0 5373.8 5458.0 20022.8 20711.6 20765.8 20779.5 20898.5 1992.8 2181.9 2354.7 2461.7 2518.6 12180.3 13000.4 13190.5 13214.5 13554.5 1729.6 1779.8 1796.2 1807.3 1873.5 65552.3 65557.3 66575.0 67526.0 67805.7 9652.8 9737.2 9906.8 10210.1 10308.3 13521.4 13596.1 13598.9 13621.7 13627.7 7001.4 7018.4 7064.9 7192.1 7193.8 6640.8 6733.2 6760.0 6846.5 6869.1 6156.9 6167.6 6247.9 6263.4 6283.2 1577.5 1666.7 1763.0 1772.0 1780.9 816.3 871.5 895.8 917.5 960.2 15105.5 16931.5 18392.5 18500.8 18687.8 876.0 889.2 901.0 933.2 949.5 8131.7 9540.8 9850.6 9924.0 10005.5 382402.0 387627.0 387694.0 390334.0 398723.0 74594.6 78707.2 81137.6 81201.0 82070.6 946.9 956.3 960.6 996.2 1005.9 16223.3 16332.5 16390.5 16404.4 16467.8 36281.1 36349.0 36667.0 37197.0 37319.3 49964.5 50433.0 51549.0 52182.0 52495.5 7678.7 7679.3 7742.8 7945.8 7962.6 10736.8 12200.8 12215.9 12342.1 12369.3 10223.9 10414.3 10434.5 10436.7 10508.5 10634.7 10652.1 10675.5 10697.4 10914.1 10449.3 10578.4 10611.6 10641.1 10754.7 7583.5 7806.4 7921.6 8081.5 8124.9 9553.6 10197.9 10306.8 10408.6 10689.9 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#3] mootools.html Cycles:180 Average:5019.81 Median:5132.08 stddev:2816.81 (54.9%) stddev-sans-first:2809.99 15:15:42 INFO - PROCESS | 8526 | Values: 1186.9 1385.4 1410.2 1478.7 1703.0 6538.9 7313.7 7629.9 7659.9 7815.3 7587.7 7727.3 7737.6 7739.4 7746.2 1842.9 2096.6 2119.6 2145.4 2183.0 2116.4 2138.1 2139.0 2139.5 2144.6 2094.3 2112.2 2158.9 2165.0 2170.8 1784.1 1839.5 1842.4 1995.3 2061.7 2082.8 2114.2 2115.6 2117.5 2118.4 7657.5 7704.0 7705.7 7709.2 7716.8 4349.8 4487.1 4496.7 4498.9 4502.2 2693.6 2784.0 2829.2 2844.9 2902.7 872.5 883.7 885.4 900.9 923.3 10547.3 10569.5 10575.0 10578.0 10578.3 4126.6 4155.2 4156.3 4225.9 4283.4 8842.1 8864.7 8872.9 8874.0 8880.3 4704.8 4712.4 4719.3 4726.1 4730.5 3678.5 4105.5 4208.6 4216.6 4285.7 3628.9 3652.1 3697.0 3744.7 3801.9 1148.6 1168.2 1183.0 1184.8 1195.3 739.3 848.2 855.2 860.0 875.2 5183.6 5230.8 5317.9 5350.9 5491.1 405.9 408.3 410.7 413.1 414.3 3677.8 3681.9 3698.5 3715.5 3746.1 9100.7 9372.8 9397.4 9464.9 9467.9 9133.0 9350.4 9371.5 9381.0 9408.6 7180.2 7183.2 7282.3 7300.9 7323.5 5080.5 5227.5 5254.3 5339.1 5369.7 8663.6 8671.0 8671.4 8851.2 8853.4 8227.7 8540.7 8563.1 8889.0 8893.1 5961.8 6172.1 6172.8 6590.5 6742.6 6778.0 6845.0 6885.0 7064.3 7085.3 6459.2 6560.0 6655.7 6659.5 6685.8 6549.5 6552.1 6581.3 6592.1 6602.8 5887.5 5912.9 5951.4 5957.7 5960.2 4516.3 4572.9 4707.8 4731.4 4789.2 4682.8 4754.8 4755.9 4783.1 4800.4 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#4] prototype.html Cycles:180 Average:4113.95 Median:4439.44 stddev:1195.30 (26.9%) stddev-sans-first:1163.55 15:15:42 INFO - PROCESS | 8526 | Values: 282.9 295.6 297.2 299.4 304.1 4814.4 4923.3 4933.2 4984.9 5003.8 4733.3 4888.2 4888.4 4909.3 4916.0 3875.5 3877.5 3888.0 3891.3 3908.7 3745.8 3750.5 3888.3 3889.3 3907.9 3817.3 3828.6 3832.7 3832.8 3834.8 3823.5 3847.3 3851.7 3858.6 3908.6 3438.4 3447.1 3450.8 3452.1 3470.5 4639.6 4763.7 4765.7 4770.0 4812.7 4355.8 4371.4 4379.3 4395.6 4405.5 5104.6 5120.5 5122.9 5162.5 5180.9 3447.7 3636.9 3646.0 3665.0 3722.3 5368.7 5381.7 5383.9 5403.5 5413.0 3689.3 3712.6 3716.7 3732.0 3742.8 3689.8 3765.5 3796.1 3800.9 3801.3 4273.6 4306.3 4306.7 4324.3 4324.9 5122.3 5130.7 5137.6 5150.2 5193.4 1233.6 1256.7 1290.1 1301.6 1304.1 813.7 828.8 836.5 839.4 848.8 4055.9 4087.4 4093.6 4104.3 4124.4 4665.3 4674.6 4683.4 4693.0 4780.2 4044.3 4079.5 4082.4 4099.6 4121.5 2359.5 2526.2 2537.7 2540.2 2562.8 4384.3 4431.5 4447.4 4458.3 4486.4 4856.8 4864.3 4878.6 4901.0 4911.3 4174.7 4376.5 4409.5 4427.9 4483.0 4648.6 4667.2 4680.5 4700.0 4708.0 4578.9 4582.6 4590.3 4627.3 4660.6 4066.9 4403.7 4411.8 4421.5 4429.0 3380.9 3416.7 3417.3 3423.1 3426.4 4717.4 4727.2 4734.6 4750.3 5042.7 4998.9 5183.4 5195.0 5222.3 5233.6 5195.3 5196.2 5235.8 5242.7 5251.4 4884.3 5131.7 5153.8 5159.1 5166.6 5221.8 5247.6 5248.2 5251.5 5257.7 5125.4 5139.5 5142.2 5162.1 5163.2 15:15:42 INFO - PROCESS | 8526 | 15:15:42 INFO - PROCESS | 8526 | [#5] yui.html Cycles:180 Average:17661.91 Median:23929.91 stddev:25218.81 (105.4%) stddev-sans-first:25257.17 15:15:42 INFO - PROCESS | 8526 | Values: 641.2 645.9 652.2 722.8 732.7 11903.9 12905.5 14682.6 15624.1 15626.5 13709.7 13756.9 13799.3 13814.7 13837.2 628.4 783.3 798.6 808.0 811.2 794.5 802.5 803.2 803.3 803.4 837.6 840.8 841.7 842.0 842.0 664.3 814.4 828.7 833.2 833.2 610.8 610.9 610.9 611.5 611.5 14040.9 14048.7 14091.5 14106.9 14115.9 11916.3 12363.5 12760.4 12840.3 13098.1 9521.4 9877.2 9929.4 10025.8 10108.2 3325.7 3332.8 3356.4 3384.5 3460.9 50829.7 52062.7 52200.2 57121.7 58190.0 10424.6 10648.8 10683.3 10856.2 10984.7 18441.9 18555.5 18578.7 18587.3 18618.8 7110.5 7171.8 7206.7 7295.1 7423.5 3451.7 3530.3 3600.7 3668.8 3714.1 2898.8 3002.6 3013.0 3021.0 3022.1 504.6 511.2 519.0 520.2 526.9 462.4 473.5 479.8 502.4 592.6 8048.4 8265.5 8270.5 8375.7 8480.1 588.8 589.4 599.3 601.7 620.4 3926.4 4003.1 4226.9 4331.7 4369.7 100628.5 101685.5 101742.0 102210.0 103023.5 85406.6 85846.0 87656.1 90381.1 91553.5 47386.3 48206.8 60698.4 74284.0 75673.2 8988.7 8991.8 9063.5 9160.5 9167.4 44924.0 45129.8 45558.5 46663.5 47821.3 54588.5 56368.7 70142.6 73623.6 74193.0 10301.5 10550.4 10774.4 11086.4 11270.8 11137.4 11565.3 12519.2 13075.9 13357.1 11145.8 12074.9 12375.4 12615.6 13323.7 12419.9 12696.7 12763.6 13151.7 13244.3 11310.7 11353.6 11558.6 12058.7 12156.8 9518.5 9829.0 9844.1 9844.3 9996.6 9774.0 9913.3 10481.2 10542.6 10609.5 15:15:42 INFO - PROCESS | 8526 | -------- Summary: end -------- 15:15:42 INFO - PROCESS | 8526 | 15:15:43 INFO - TEST-INFO | 8526: exit 0 15:15:43 INFO - TEST-OK | dromaeo_css | took 1119813ms 15:15:43 INFO - TEST-START | kraken 15:15:43 INFO - operating with platform_type : linux_ 15:15:43 INFO - Initialising browser for kraken test... 15:15:43 INFO - TEST-INFO | started process 8704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVP_Up/profile http://localhost:38690/getInfo.html) 15:15:47 INFO - PROCESS | 8704 | __metrics Screen width/height:1600/1200 15:15:47 INFO - PROCESS | 8704 | colorDepth:24 15:15:47 INFO - PROCESS | 8704 | Browser inner width/height: 1024/697 15:15:47 INFO - PROCESS | 8704 | __metrics 15:15:48 INFO - PROCESS | 8704 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:15:49 INFO - TEST-INFO | 8704: exit 0 15:15:49 INFO - Browser initialized. 15:15:49 INFO - Running cycle 1/1 for kraken test... 15:15:49 INFO - TEST-INFO | started process 8784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVP_Up/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:02 INFO - PROCESS | 8784 | RSS: Main: 175423488 15:16:02 INFO - PROCESS | 8784 | 15:16:04 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-beat-detection) 15:16:05 INFO - PROCESS | 8784 | RSS: Main: 233439232 15:16:05 INFO - PROCESS | 8784 | 15:16:08 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-dft) 15:16:09 INFO - PROCESS | 8784 | RSS: Main: 221450240 15:16:09 INFO - PROCESS | 8784 | 15:16:12 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-fft) 15:16:13 INFO - PROCESS | 8784 | RSS: Main: 287551488 15:16:13 INFO - PROCESS | 8784 | 15:16:15 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-oscillator) 15:16:15 INFO - PROCESS | 8784 | RSS: Main: 198221824 15:16:15 INFO - PROCESS | 8784 | 15:16:18 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:16:18 INFO - PROCESS | 8784 | RSS: Main: 202690560 15:16:18 INFO - PROCESS | 8784 | 15:16:21 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-darkroom) 15:16:22 INFO - PROCESS | 8784 | RSS: Main: 238555136 15:16:22 INFO - PROCESS | 8784 | 15:16:25 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-desaturate) 15:16:26 INFO - PROCESS | 8784 | RSS: Main: 239075328 15:16:26 INFO - PROCESS | 8784 | 15:16:29 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38690/tests/kraken/driver.html?testName=json-parse-financial) 15:16:30 INFO - PROCESS | 8784 | RSS: Main: 238841856 15:16:30 INFO - PROCESS | 8784 | 15:16:31 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:16:32 INFO - PROCESS | 8784 | RSS: Main: 226775040 15:16:32 INFO - PROCESS | 8784 | 15:16:34 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:16:34 INFO - PROCESS | 8784 | RSS: Main: 232099840 15:16:34 INFO - PROCESS | 8784 | 15:16:37 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:16:37 INFO - PROCESS | 8784 | RSS: Main: 237953024 15:16:37 INFO - PROCESS | 8784 | 15:16:40 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:16:41 INFO - PROCESS | 8784 | RSS: Main: 241463296 15:16:41 INFO - PROCESS | 8784 | 15:16:44 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:16:44 INFO - PROCESS | 8784 | RSS: Main: 240824320 15:16:44 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38690/tests/kraken/driver.html?testName=ai-astar) 15:16:46 INFO - PROCESS | 8784 | RSS: Main: 283783168 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | __start_tp_report 15:16:46 INFO - PROCESS | 8784 | _x_x_mozilla_page_load 15:16:46 INFO - PROCESS | 8784 | _x_x_mozilla_page_load_details 15:16:46 INFO - PROCESS | 8784 | |i|pagename|runs| 15:16:46 INFO - PROCESS | 8784 | |0;ai-astar;104;113;113;113;112;114;112;113;112;113 15:16:46 INFO - PROCESS | 8784 | |1;audio-beat-detection;157;129;131;192;133;131;153;129;186;133 15:16:46 INFO - PROCESS | 8784 | |2;audio-dft;162;161;159;161;161;162;162;161;161;161 15:16:46 INFO - PROCESS | 8784 | |3;audio-fft;75;78;76;117;77;76;74;75;112;75 15:16:46 INFO - PROCESS | 8784 | |4;audio-oscillator;86;86;115;85;85;86;120;85;85;128 15:16:46 INFO - PROCESS | 8784 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;117;118;116 15:16:46 INFO - PROCESS | 8784 | |6;imaging-darkroom;146;146;147;147;146;146;146;147;146;146 15:16:46 INFO - PROCESS | 8784 | |7;imaging-desaturate;94;94;95;95;94;94;94;95;95;94 15:16:46 INFO - PROCESS | 8784 | |8;json-parse-financial;64;64;64;64;64;63;67;64;66;64 15:16:46 INFO - PROCESS | 8784 | |9;json-stringify-tinderbox;65;65;64;65;65;65;66;66;71;66 15:16:46 INFO - PROCESS | 8784 | |10;stanford-crypto-aes;88;84;90;82;87;84;84;84;109;90 15:16:46 INFO - PROCESS | 8784 | |11;stanford-crypto-ccm;131;132;142;138;133;126;132;131;136;130 15:16:46 INFO - PROCESS | 8784 | |12;stanford-crypto-pbkdf2;180;168;165;169;167;166;166;166;164;172 15:16:46 INFO - PROCESS | 8784 | |13;stanford-crypto-sha256-iterative;70;67;70;68;66;66;66;66;66;66 15:16:46 INFO - PROCESS | 8784 | __end_tp_report 15:16:46 INFO - PROCESS | 8784 | __start_cc_report 15:16:46 INFO - PROCESS | 8784 | _x_x_mozilla_cycle_collect,1896 15:16:46 INFO - PROCESS | 8784 | __end_cc_report 15:16:46 INFO - PROCESS | 8784 | __startTimestamp1466806606663__endTimestamp 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | ------- Summary: start ------- 15:16:46 INFO - PROCESS | 8784 | Number of tests: 14 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.85 (2.5%) stddev-sans-first:0.67 15:16:46 INFO - PROCESS | 8784 | Values: 104.0 113.0 113.0 113.0 112.0 114.0 112.0 113.0 112.0 113.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:143.00 stddev:24.11 (16.9%) stddev-sans-first:25.32 15:16:46 INFO - PROCESS | 8784 | Values: 157.0 129.0 131.0 192.0 133.0 131.0 153.0 129.0 186.0 133.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 15:16:46 INFO - PROCESS | 8784 | Values: 162.0 161.0 159.0 161.0 161.0 162.0 162.0 161.0 161.0 161.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.50 stddev:16.42 (21.7%) stddev-sans-first:17.13 15:16:46 INFO - PROCESS | 8784 | Values: 75.0 78.0 76.0 117.0 77.0 76.0 74.0 75.0 112.0 75.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:17.46 (20.5%) stddev-sans-first:18.14 15:16:46 INFO - PROCESS | 8784 | Values: 86.0 86.0 115.0 85.0 85.0 86.0 120.0 85.0 85.0 128.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 15:16:46 INFO - PROCESS | 8784 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 116.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:16:46 INFO - PROCESS | 8784 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:16:46 INFO - PROCESS | 8784 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 15:16:46 INFO - PROCESS | 8784 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 67.0 64.0 66.0 64.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.50 stddev:1.93 (2.9%) stddev-sans-first:2.03 15:16:46 INFO - PROCESS | 8784 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 66.0 66.0 71.0 66.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:85.50 stddev:7.81 (9.1%) stddev-sans-first:8.29 15:16:46 INFO - PROCESS | 8784 | Values: 88.0 84.0 90.0 82.0 87.0 84.0 84.0 84.0 109.0 90.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:132.50 stddev:4.51 (3.4%) stddev-sans-first:4.72 15:16:46 INFO - PROCESS | 8784 | Values: 131.0 132.0 142.0 138.0 133.0 126.0 132.0 131.0 136.0 130.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:167.50 stddev:4.69 (2.8%) stddev-sans-first:2.40 15:16:46 INFO - PROCESS | 8784 | Values: 180.0 168.0 165.0 169.0 167.0 166.0 166.0 166.0 164.0 172.0 15:16:46 INFO - PROCESS | 8784 | 15:16:46 INFO - PROCESS | 8784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:1.66 (2.5%) stddev-sans-first:1.39 15:16:46 INFO - PROCESS | 8784 | Values: 70.0 67.0 70.0 68.0 66.0 66.0 66.0 66.0 66.0 66.0 15:16:46 INFO - PROCESS | 8784 | -------- Summary: end -------- 15:16:46 INFO - PROCESS | 8784 | 15:16:47 INFO - TEST-INFO | 8784: exit 0 15:16:47 INFO - TEST-OK | kraken | took 64160ms 15:16:47 INFO - SUITE-END | took 1183s 15:16:48 INFO - Completed test suite (00:19:44) 15:16:48 INFO - javascript benchmark 15:16:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.6182703507993, 2636.7626913577774, 2666.4000599865026, 2679.1962411276622, 2690.0719251858104, 4731.00648863739, 4814.590759785418, 4835.443923948747, 4931.630127740415, 4970.1302272102375, 4756.857294281169, 4781.306710526971, 4816.229403295473, 4859.246816743402, 4869.561739443449, 4360.171567402183, 4449.621782148505, 4458.680713705754, 4504.481984571784, 4603.033362993775, 4409.338599210112, 4543.454785425737, 4556.612687921531, 4569.063342014879, 4582.221022426195, 4342.761148136851, 4384.364267181273, 4389.297712366006, 4408.765545647224, 4456.710313829623, 4406.779661016936, 4418.248897687401, 4437.689361744679, 4445.866624001253, 4458.308962110846, 4453.421055262827, 4454.933176002362, 4456.086502267028, 4457.1977044132045, 4493.9101217975785, 4685.835995740167, 4692.624590032823, 4862.124817532843, 4907.0, 4921.876953076166, 5071.061853557104, 5091.592672586185, 5133.486651334874, 5141.434442211354, 5143.562797162208, 5136.768845401966, 5161.509656582619, 5166.948330516684, 5180.844574662766, 5187.8184263550975, 4656.8137274508645, 4796.112719146969, 4830.734309613005, 4840.177169881058, 4842.564169224752, 5364.329458817648, 5368.91946620801, 5375.6774593524515, 5378.73106344689, 5389.730513474311, 5133.101707201225, 5156.20078887773, 5158.458361872024, 5158.896822063538, 5160.509751573594, 5014.924776128361, 5130.050940576006, 5204.869878253074, 5212.374515058217, 5244.0, 5118.436971933084, 5151.484851514819, 5173.637845350864, 5175.378954525481, 5230.398504172069, 5153.484651534892, 5177.870553236124, 5180.6891586504935, 5182.689038657692, 5229.424763276036, 4312.676549258818, 4349.369341445473, 4399.64802815774, 4442.400275962704, 4445.310976798602, 3839.1361943562474, 3851.056491159684, 3858.112634094174, 3874.1864208516527, 3928.0769019280447, 4439.955600444019, 4466.7766611669285, 4473.821047158077, 4491.101779644085, 4515.525869783691, 5026.396832380138, 5140.049090918192, 5155.226715992556, 5240.6069544784295, 5296.841094767086, 4407.537208593116, 4439.489458712224, 4466.129104824593, 4473.821047158142, 4479.3057076153245, 4698.8355407560575, 4700.835470758507, 4701.741404222732, 4703.212779143972, 4739.86243301612, 4633.4903160652975, 4657.441107067174, 4854.223324268241, 4859.7327147005835, 4893.388326459192, 5008.273800299009, 5051.646384753032, 5101.770420331169, 5103.515166059218, 5104.1067813133295, 4698.859034228979, 4700.76496175183, 4700.92948605778, 4704.50602686713, 4751.121042607128, 4959.578435832995, 4988.077205716954, 4995.17579599362, 5000.949990500194, 5043.571296439697, 5098.974505127599, 5199.194124910645, 5214.634975551675, 5244.895102098013, 5245.396779370269, 5037.370328708911, 5043.394792624908, 5057.671251368649, 5088.287639730367, 5104.540591346797, 4874.878128046827, 4949.406071271471, 5081.263216833465, 5095.15929871567, 5095.439501654889, 4931.827386041471, 5025.673331233458, 5071.087204303113, 5072.721000345016, 5074.188129899198, 5098.031374038921, 5098.694078355311, 5102.566281866083, 5109.514596113363, 5159.767810448614, 4831.637627177905, 4834.154023045882, 4840.588549973291, 5004.724740139181, 5053.166227572409], "value": 4741.769547182844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9850432048805, 575.3900865083011, 579.4032146888703, 584.5937073733757, 588.129568239006, 26916.59625105625, 40088.0, 41099.178016439655, 41286.38070428946, 41415.378769318406, 41521.16957660845, 41808.37287440691, 41829.0, 41843.16313673725, 41997.790011049976, 7460.664270107858, 7854.332381747544, 8018.839623207532, 8027.799305017363, 10198.286119971568, 9892.703218903445, 10285.79428411435, 10290.639827606035, 10314.690559283234, 10323.174146068297, 10336.276460647758, 10375.221858360615, 10375.896241037568, 10390.116840068604, 10393.32443391181, 7601.429892758038, 10129.797404051878, 10293.330933489298, 10393.584256629802, 10406.79186416275, 10244.846327305097, 10322.174226061898, 10325.948370258177, 10329.070383665507, 10333.896661033368, 38416.615833841584, 38636.0, 38682.0, 38704.22591548153, 38855.41716874249, 3069.754419646445, 3124.5313203019728, 3653.6163702811086, 3683.410654295327, 3726.571444283915, 28787.56818647722, 29299.70700292991, 29304.706952930625, 29690.0, 29795.004065993926, 3442.8278586070846, 3503.754737168399, 3510.473428985647, 3534.5581802274714, 3605.2248766515327, 260279.0, 261271.0, 261601.0, 262367.0, 262806.0, 51151.0, 51450.0, 51481.48518514767, 51499.742501287255, 51503.74248128735, 32505.0, 33544.0, 33574.49638255428, 35349.82325088358, 35356.82321588427, 14048.578542643738, 14168.645783855485, 14217.0, 14302.57092287233, 14358.784618230735, 10260.384376937407, 11074.612388566522, 11318.094552435785, 11351.091912647134, 11602.477888495037, 18112.45662630123, 18312.725309120375, 18322.175502102436, 18362.0, 18372.540686482946, 6709.228438729511, 6717.932820671731, 6720.361565651256, 6902.827429314308, 6930.613877224575, 812.5287333346645, 883.1698203688512, 888.5201990924958, 953.9189168920581, 961.9706913602379, 26873.731262687514, 28203.0, 28345.149645510668, 28631.856840715664, 28861.56707649387, 865.2472349056236, 919.7654598077447, 973.9853902191472, 981.9950900245453, 991.2714155095998, 14453.49412770548, 14755.852441475663, 14911.0, 15157.621059473602, 15304.158271294962, 393261.0, 395831.0, 398265.0, 400045.0, 401479.0, 48714.0, 48972.75513622409, 49057.75471122622, 49422.752886235336, 49458.752706236235, 1042.4475028235047, 1144.5021415684205, 1176.4647085576041, 1184.9335597961904, 1211.854577450694, 27950.16149515518, 28880.277993050342, 29054.12837614875, 29178.228068334323, 29436.264093397836, 40755.7962210187, 41335.586644133175, 41392.172156556095, 41392.37911431391, 41398.79300603478, 236771.0, 242224.0, 242409.0, 243093.0, 243213.0, 22050.44873878166, 23808.0, 24604.507909841344, 25020.249392518253, 26652.733472665026, 41861.0, 42082.0, 42200.15599687928, 42827.357589635554, 43149.78425107854, 34481.31037379288, 35776.8211158953, 36119.45820812743, 36511.26977460489, 36925.23060770399, 35595.0, 35731.10672233215, 35889.282214355044, 35933.64066359303, 36177.81911090533, 35756.82121589375, 35833.46249806307, 36859.63140368562, 37587.248255035294, 37776.24447511089, 30930.690693093682, 33005.66994330026, 33279.0, 33409.66590334163, 33703.0, 25178.74821251764, 25697.871510642326, 25835.870820645778, 25868.0, 25934.481310374063], "value": 17773.683097252433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1301474072781, 375.8402678861483, 380.53194570678085, 389.9746516476429, 391.02634440243804, 15885.523434296974, 17459.3016279349, 17631.29474821007, 17912.0, 17940.102994850255, 17102.743458848126, 17120.229589668463, 17268.0, 17582.384616538424, 17611.471655850313, 5094.032133894558, 5307.548858347045, 5326.280952071479, 5340.706261155635, 5353.9196912046355, 3752.8874133775894, 3948.1708841143395, 5933.258342707161, 6233.283172435183, 6251.062340648917, 5976.013957696975, 6271.874562508747, 6282.465990390822, 6294.811155665315, 6308.684565771716, 6152.16945712332, 6180.629162250257, 6188.566800323979, 6195.721192546302, 6216.036514340284, 3431.1422144463886, 5009.974950125263, 5373.0, 5373.81191658294, 5458.044842152647, 20022.79977200224, 20711.5857682847, 20765.79234207669, 20779.480512987295, 20898.477538061517, 1992.7708313543983, 2181.9345419637434, 2354.7409784923643, 2461.692288463942, 2518.609615509599, 12180.330081845495, 13000.414981325768, 13190.47238110484, 13214.537491187762, 13554.457821687121, 1729.6021914959629, 1779.8487128594086, 1796.2455768577229, 1807.3132209760206, 1873.5222518257758, 65552.3444765551, 65557.3444265556, 66575.0, 67525.9999999995, 67805.66097169532, 9652.75868103303, 9737.22102231834, 9906.829814459448, 10210.081092701692, 10308.32995855267, 13521.391537380645, 13596.11625244356, 13598.93200533991, 13621.727565448635, 13627.659308517168, 7001.439884809203, 7018.403435708022, 7064.858702825914, 7192.100987376578, 7193.784186474414, 6640.800775976729, 6733.192016957898, 6760.0, 6846.486513511407, 6869.141357330333, 6156.8758778221445, 6167.599106058092, 6247.937520624736, 6263.404976527223, 6283.214598175228, 1577.4557777566952, 1666.6749983753052, 1763.021523054717, 1771.9822801772075, 1780.910954452272, 816.3142959913582, 871.54679566625, 895.8118795052982, 917.499962520428, 960.1694534227983, 15105.47130850415, 16931.492055238363, 18392.540186495444, 18500.814991850177, 18687.81312186888, 876.027609353617, 889.1819526036062, 900.9954950225207, 933.2394098809449, 949.5442187749919, 8131.674733010614, 9540.761480962892, 9850.605975761033, 9924.0, 10005.549750261256, 382402.0, 387627.0, 387694.0, 390334.0, 398723.0, 74594.62702686452, 78707.21292786999, 81137.59431202806, 81201.0, 82070.58964705138, 946.8911075226437, 956.3496822160859, 960.6397600899662, 996.2428554298785, 1005.9346142500714, 16223.269952852386, 16332.510024699279, 16390.508284751475, 16404.425845095364, 16467.83532164663, 36281.09297267589, 36349.0, 36667.0, 37197.0, 37319.25361492809, 49964.50035499599, 50433.0, 51549.0, 52181.95636087181, 52495.475045249055, 7678.654460549177, 7679.2704693054075, 7742.845143097219, 7945.8410831784195, 7962.641681124479, 10736.838947415952, 12200.75598488043, 12215.938920305342, 12342.13605047638, 12369.257844529357, 10223.948880255552, 10414.271001030158, 10434.530446130095, 10436.686899393031, 10508.527116279938, 10634.680959571226, 10652.09457196147, 10675.454680608738, 10697.358158510515, 10914.072303854262, 10449.268551201343, 10578.418186999788, 10611.628592999208, 10641.148708103488, 10754.677359679223, 7583.544987300779, 7806.41451891099, 7921.564313962787, 8081.515109093473, 8124.878126828221, 9553.570089346134, 10197.898021019695, 10306.845397319195, 10408.635697750542, 10689.9465502672], "value": 8546.108405425382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1186.899113575346, 1385.425048604829, 1410.1750475971555, 1478.70425914817, 1702.9659406811863, 6538.901916471251, 7313.707451701932, 7629.923700762991, 7659.885101723478, 7815.2966233039015, 7587.658555365008, 7727.304542591166, 7737.57443340616, 7739.4195435342435, 7746.225377462251, 1842.9447116586523, 2096.622607930572, 2119.6290649136376, 2145.3992881993067, 2182.9890850545726, 2116.4179850541145, 2138.134055707441, 2139.048123585005, 2139.497218153733, 2144.592527419793, 2094.3193462124796, 2112.22903640171, 2158.859674121185, 2165.0257384177103, 2170.815480684144, 1784.0633667324628, 1839.5125291797685, 1842.4380563927996, 1995.3016444244543, 2061.6598261286945, 2082.7500699915954, 2114.228306668055, 2115.5768846230817, 2117.523557199633, 2118.449203207177, 7657.4639775215755, 7704.0, 7705.730299439493, 7709.190534993857, 7716.7684969451, 4349.760763158025, 4487.102579484116, 4496.685232033759, 4498.910021799546, 4502.189605870942, 2693.5690289553577, 2783.958240626372, 2829.1795379339965, 2844.900428485014, 2902.680705122435, 872.4808738800403, 883.7039591736776, 885.3669626217221, 900.9369344145913, 923.3213588012806, 10547.314424562379, 10569.524371403382, 10575.0, 10578.0, 10578.312409693423, 4126.628603425646, 4155.168966206771, 4156.251874662529, 4225.852095176716, 4283.400323954649, 8842.115788421106, 8864.73405797827, 8872.8669069964, 8873.955630221937, 8880.289576833968, 4704.811807527661, 4712.363830882856, 4719.315699223594, 4726.1492931272705, 4730.5032971538185, 3678.5401824771902, 4105.4662893823615, 4208.579142085829, 4216.641585465209, 4285.721428107163, 3628.9274214515563, 3652.068722475805, 3696.963030369716, 3744.681702055356, 3801.8669346572738, 1148.586508856811, 1168.1788480818898, 1183.0240051957169, 1184.810430331143, 1195.3485350484007, 739.3493725521506, 848.2365870716282, 855.1512921733785, 860.0453496618749, 875.1991927386371, 5183.611229157828, 5230.843074707765, 5317.946820531823, 5350.91973620396, 5491.148871924858, 405.9127287633173, 408.2753113224051, 410.6571013204008, 413.09119936140013, 414.2812220796915, 3677.7609455385314, 3681.9447708284397, 3698.4822124902535, 3715.5169827922196, 3746.138388170736, 9100.681476148304, 9372.812543749087, 9397.389169704084, 9464.858027129598, 9467.905320946702, 9132.954335228282, 9350.392224505385, 9371.531423428802, 9380.95309523448, 9408.576614052246, 7180.210176880539, 7183.173934997542, 7282.344588986911, 7300.868365403265, 7323.450741194431, 5080.542751152414, 5227.529522343008, 5254.343207099113, 5339.092354299701, 5369.6509726867625, 8663.566821659018, 8670.956645216733, 8671.393002489765, 8851.247643950337, 8853.38026338176, 8227.71203007892, 8540.74377768668, 8563.143685631387, 8889.022207557293, 8893.066228045962, 5961.791337303173, 6172.135900973957, 6172.753089876354, 6590.47276217911, 6742.595444273359, 6778.017187507685, 6845.0, 6884.965575172092, 7064.258252883579, 7085.326893945067, 6459.192600924885, 6559.967200163968, 6655.667216639245, 6659.533832631863, 6685.799426017227, 6549.508786841101, 6552.148220731275, 6581.308962559054, 6592.110065141336, 6602.801915942529, 5887.499562537232, 5912.881742365214, 5951.404859514014, 5957.731902064331, 5960.225170727777, 4516.345129956204, 4572.908541829212, 4707.764611769467, 4731.408573928259, 4789.209780386197, 4682.765861706833, 4754.762261886823, 4755.881102972453, 4783.06730187624, 4800.35195248637], "value": 3975.7424147757765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.92078218098925, 295.6260330681687, 297.1531136261654, 299.3937277014046, 304.11350912091257, 4814.446338671054, 4923.335349727795, 4933.18602430599, 4984.875378115545, 5003.774830132644, 4733.313669517918, 4888.217885138379, 4888.388951381077, 4909.33723947267, 4916.041371932466, 3875.4961854958815, 3877.5346958365035, 3887.9805600972027, 3891.299566078119, 3908.667763240128, 3745.8013435700586, 3750.49368335274, 3888.2612303662354, 3889.3193691103943, 3907.882763517099, 3817.2556351511466, 3828.6408325044627, 3832.712546559005, 3832.7508711933774, 3834.8466061357512, 3823.483829682999, 3847.2690188864167, 3851.6726078283377, 3858.594847540996, 3908.6286802753693, 3438.3639026780124, 3447.120984149026, 3450.8274586270586, 3452.1369657585606, 3470.548828652259, 4639.62882969365, 4763.737994410306, 4765.690230135065, 4769.976150119227, 4812.687175333592, 4355.80398882051, 4371.4098596689355, 4379.255526560492, 4395.560443955611, 4405.493368262659, 5104.617153713486, 5120.513551212629, 5122.897542049175, 5162.489507135147, 5180.896382072375, 3447.7414193935556, 3636.890748321761, 3645.981770091159, 3665.0, 3722.274156539476, 5368.677879327252, 5381.677099374011, 5383.869387428645, 5403.459654034605, 5412.999999999961, 3689.2990331836863, 3712.5916149223563, 3716.7398282119993, 3732.0, 3742.7754334740002, 3689.8339574719203, 3765.548134223911, 3796.0509872531866, 3800.8669696560487, 3801.315763162602, 4273.594008569181, 4306.310990241546, 4306.655467562588, 4324.329728892027, 4324.935125973113, 5122.282880396748, 5130.692158470503, 5137.640365174477, 5150.19743089923, 5193.428722840485, 1233.5990802989065, 1256.654420034498, 1290.148501988683, 1301.5965050834272, 1304.1066869194633, 813.6615267884297, 828.8218033122907, 836.4897412578322, 839.4040231435627, 848.7665891879783, 4055.9391609125887, 4087.3664581989838, 4093.570175131628, 4104.302268614283, 4124.381342798604, 4665.300204969214, 4674.64435313762, 4683.367745354401, 4693.037927224911, 4780.1873681474235, 4044.2720310343834, 4079.5308539518337, 4082.4488694026522, 4099.590040995877, 4121.464209652726, 2359.528094381131, 2526.166365099513, 2537.733537978486, 2540.2379286214064, 2562.8334158279654, 4384.254676704968, 4431.512533621363, 4447.3773671685985, 4458.308962110878, 4486.416765820488, 4856.757162141878, 4864.294677271847, 4878.585320247747, 4900.975495122501, 4911.336969509142, 4174.666026717855, 4376.468236117397, 4409.4944519107385, 4427.889302767457, 4482.977585112054, 4648.628109751144, 4667.206574882211, 4680.461746899014, 4699.955519348958, 4707.952920470751, 4578.931316030329, 4582.633389328779, 4590.347474908964, 4627.282771170474, 4660.603848672901, 4066.9389959151226, 4403.713758605681, 4411.7941029485255, 4421.513633500248, 4429.0, 3380.864765409356, 3416.6924976751216, 3417.3336199441865, 3423.0757695422594, 3426.4003799335514, 4717.363155974037, 4727.220008698526, 4734.644901632322, 4750.263709125091, 5042.672226305279, 4998.850034498971, 5183.377994640668, 5195.0, 5222.321098257202, 5233.581313494988, 5195.298634684269, 5196.168613021899, 5235.821940063607, 5242.711650859239, 5251.422343542131, 4884.316195732671, 5131.717755523333, 5153.845384638467, 5159.148740457783, 5166.60501664541, 5221.817236396708, 5247.632665713363, 5248.186531087687, 5251.501107394792, 5257.710825904612, 5125.384953805567, 5139.460356662496, 5142.17725163987, 5162.09663308927, 5163.199704045879], "value": 3734.579296961231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.1856941684061, 645.870825834833, 652.1977967100469, 722.7759394587677, 732.7288903105851, 11903.880961190396, 12905.548305809298, 14682.559523214293, 15624.140672263022, 15626.453074142408, 13709.725805483884, 13756.862431375683, 13799.310034498285, 13814.723705525883, 13837.169769813818, 628.3841835001701, 783.3380793229712, 798.620655188785, 808.0263282744279, 811.1928631012152, 794.4915254237264, 802.502448481939, 803.2008151888879, 803.3211935914172, 803.3813963248296, 837.6146972392706, 840.8276303357796, 841.7432683031673, 842.0232530264894, 842.0274582856811, 664.2892105447173, 814.4095530740166, 828.7223780033696, 833.170994860115, 833.2375876073386, 610.8381278961078, 610.9236345456818, 610.9389061093899, 611.4649681528663, 611.5169016476978, 14040.859591404058, 14048.719025619532, 14091.50679726215, 14106.858931410658, 14115.929420352935, 11916.34460104694, 12363.505459781598, 12760.361981900867, 12840.293783841886, 13098.083134180612, 9521.381110227881, 9877.160441362494, 9929.404235745878, 10025.84961225575, 10108.191344692481, 3325.7173140283103, 3332.8333583320978, 3356.446186379269, 3384.5430866833153, 3460.9307813843584, 50829.745851270876, 52062.739686301706, 52200.21699674508, 57121.71439142778, 58190.0, 10424.635137770141, 10648.840267395995, 10683.25217234786, 10856.2400631955, 10984.670459886216, 18441.90779046123, 18555.536111597048, 18578.721319180222, 18587.34944276944, 18618.81381186198, 7110.502264841515, 7171.784846454615, 7206.747763828241, 7295.088113985752, 7423.517471364344, 3451.6720911513366, 3530.3468858261303, 3600.71194304455, 3668.816559172031, 3714.1086139326367, 2898.826070435781, 3002.639683237982, 3012.9548056779167, 3021.0483697635173, 3022.1084779989956, 504.5685938522584, 511.19997204375034, 518.9610779191576, 520.2378515474848, 526.8709166254292, 462.4427564784427, 473.5288388053908, 479.76011994003, 502.36200025966815, 592.5526227698147, 8048.436609437284, 8265.545395003333, 8270.462419942685, 8375.706850260334, 8480.109588493242, 588.832182827892, 589.354656650975, 599.310792588518, 601.7442586900637, 620.3920158244945, 3926.391409331558, 4003.139325045129, 4226.915461690811, 4331.6534677225745, 4369.6722745794195, 100628.49685751525, 101685.49157254166, 101742.0, 102210.0, 103023.48488257511, 85406.57296713477, 85846.0, 87656.12343876607, 90381.09618903858, 91553.54223228975, 47386.289205661946, 48206.75896620494, 60698.39301607016, 74284.0, 75673.24326756662, 8988.730338089868, 8991.78476483651, 9063.504521753837, 9160.450372977642, 9167.44995300284, 44924.0, 45129.774351129345, 45558.54441455543, 46663.53336466592, 47821.28268076051, 54588.45411545993, 56368.7181564106, 70142.64928675324, 73623.63188184025, 74193.0, 10301.484925753532, 10550.366977981346, 10774.353538787698, 11086.390248536409, 11270.761142310923, 11137.387443690352, 11565.306081635128, 12519.248845069325, 13075.869241307466, 13357.065005449525, 11145.832812507657, 12074.879251207727, 12375.381230938237, 12615.621531354074, 13323.733525329246, 12419.93790031044, 12696.746065078461, 12763.553275635308, 13151.671208219488, 13244.271565064015, 11310.660680179608, 11353.607869190677, 11558.595449159238, 12058.698532536757, 12156.75686486283, 9518.524073796421, 9829.017098290115, 9844.114029737359, 9844.261680374144, 9996.60013599477, 9773.951130244588, 9913.256505762241, 10481.161507079263, 10542.57829686804, 10609.522571484147], "value": 6608.947827704641, "unit": "score"}], "name": "dromaeo_css", "value": 6430.16164711879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 131.0, 192.0, 133.0, 131.0, 153.0, 129.0, 186.0, 133.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 117.0, 77.0, 76.0, 74.0, 75.0, 112.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 85.0, 85.0, 86.0, 120.0, 85.0, 85.0, 128.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 67.0, 64.0, 66.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 66.0, 71.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 90.0, 82.0, 87.0, 84.0, 84.0, 84.0, 109.0, 90.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 142.0, 138.0, 133.0, 126.0, 132.0, 131.0, 136.0, 130.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 168.0, 165.0, 169.0, 167.0, 166.0, 166.0, 166.0, 164.0, 172.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1544.7999999999997, "alertThreshold": 2.0}]} 15:16:48 INFO - Return code: 0 15:16:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:16:48 INFO - # TBPL SUCCESS # 15:16:48 INFO - Running post-action listener: _resource_record_post_action 15:16:48 INFO - ##### 15:16:48 INFO - ##### Finished run-tests step (success) 15:16:48 INFO - ##### 15:16:48 INFO - Running post-run listener: _resource_record_post_run 15:16:48 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545398784; Read time: 16; Write time: 565896 15:16:48 INFO - TinderboxPrint: CPU usage
13.3% 15:16:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:16:48 INFO - TinderboxPrint: I/O write bytes / time
545,398,784 / 565,896 15:16:48 INFO - TinderboxPrint: CPU idle
8,319.3 (86.7%) 15:16:48 INFO - TinderboxPrint: CPU user
1,223.2 (12.8%) 15:16:48 INFO - TinderboxPrint: Swap in / out
0 / 0 15:16:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252354560; Read time: 0; Write time: 270168 15:16:48 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293044224; Read time: 16; Write time: 295728 15:16:49 INFO - Running post-run listener: _upload_blobber_files 15:16:49 INFO - Blob upload gear active. 15:16:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:49 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 15:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:16:49 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:16:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:50 INFO - (blobuploader) - INFO - Done attempting. 15:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:16:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:50 INFO - (blobuploader) - INFO - Done attempting. 15:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:54 INFO - (blobuploader) - INFO - Done attempting. 15:16:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:54 INFO - Return code: 0 15:16:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f595677625b14baa7b236a3b17ba1b71f862726d99e578c5d8eb2c9d61ebc1fb345b1d3432033277097c751d3db2405b78b34b3b9b3c778b468ad099dc02a9d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e682bab01e8fe44683eaebdd4e0978bbcf97f5572a25c81e71983003cde49caa850e2a20a0693b517fce59c88ccfc3ae219b7760ba0a6abab2514d2db37df7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a995f71ae86b9e6bc851e52c2b27ebe97dd05b5f9942653bf77f32daccb8f5fe7788aed3807735156f40ea751a98b416a92bbc752518b7255cf89f42eb2608f"} 15:16:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:54 INFO - Contents: 15:16:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f595677625b14baa7b236a3b17ba1b71f862726d99e578c5d8eb2c9d61ebc1fb345b1d3432033277097c751d3db2405b78b34b3b9b3c778b468ad099dc02a9d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e682bab01e8fe44683eaebdd4e0978bbcf97f5572a25c81e71983003cde49caa850e2a20a0693b517fce59c88ccfc3ae219b7760ba0a6abab2514d2db37df7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a995f71ae86b9e6bc851e52c2b27ebe97dd05b5f9942653bf77f32daccb8f5fe7788aed3807735156f40ea751a98b416a92bbc752518b7255cf89f42eb2608f"} 15:16:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:54 INFO - Copying logs to upload dir... 15:16:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.776387 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-24 15:16:54.242770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:54.248632) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 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-Non-PGO/sha512/f595677625b14baa7b236a3b17ba1b71f862726d99e578c5d8eb2c9d61ebc1fb345b1d3432033277097c751d3db2405b78b34b3b9b3c778b468ad099dc02a9d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e682bab01e8fe44683eaebdd4e0978bbcf97f5572a25c81e71983003cde49caa850e2a20a0693b517fce59c88ccfc3ae219b7760ba0a6abab2514d2db37df7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a995f71ae86b9e6bc851e52c2b27ebe97dd05b5f9942653bf77f32daccb8f5fe7788aed3807735156f40ea751a98b416a92bbc752518b7255cf89f42eb2608f"} build_url:https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/Scx9cr5qQqGkV6GgveiNHg/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-Non-PGO/sha512/f595677625b14baa7b236a3b17ba1b71f862726d99e578c5d8eb2c9d61ebc1fb345b1d3432033277097c751d3db2405b78b34b3b9b3c778b468ad099dc02a9d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e682bab01e8fe44683eaebdd4e0978bbcf97f5572a25c81e71983003cde49caa850e2a20a0693b517fce59c88ccfc3ae219b7760ba0a6abab2514d2db37df7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a995f71ae86b9e6bc851e52c2b27ebe97dd05b5f9942653bf77f32daccb8f5fe7788aed3807735156f40ea751a98b416a92bbc752518b7255cf89f42eb2608f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:54.278098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:54.278718) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466805354.193793-1921688828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:54.362247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:16:54.362957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:16:54.363585) ========= ========= Total master_lag: 0.19 =========