builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1465475965.67 results: success (0) buildid: 20160609030247 builduid: d600bdbc5a39477ba57a97cdd26595d9 revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.673081) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.673634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.673979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.690246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.690564) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 05:39:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-06-09 05:39:26 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118609 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.827001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.827358) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016365 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.879923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:25.880733) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --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 cb493102af8a50946ac601a86cc3d076703faa57 --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=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 05:39:26,375 truncating revision to first 12 chars 2016-06-09 05:39:26,375 Setting DEBUG logging. 2016-06-09 05:39:26,375 attempt 1/10 2016-06-09 05:39:26,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb493102af8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 05:39:26,700 unpacking tar archive at: mozilla-central-cb493102af8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:26.583673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:26.584413) ========= script_repo_revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:26.585226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:26.585578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:26.596998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-09 05:39:26.597686) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:27 INFO - MultiFileLogger online at 20160609 05:39:27 in /builds/slave/test 05:39:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:27 INFO - {'append_to_log': False, 05:39:27 INFO - 'base_work_dir': '/builds/slave/test', 05:39:27 INFO - 'blob_upload_branch': 'Firefox', 05:39:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:27 INFO - 'branch': 'Firefox', 05:39:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:27 INFO - 'config_files': ('talos/linux_config.py',), 05:39:27 INFO - 'default_actions': ('clobber', 05:39:27 INFO - 'read-buildbot-config', 05:39:27 INFO - 'download-and-extract', 05:39:27 INFO - 'populate-webroot', 05:39:27 INFO - 'create-virtualenv', 05:39:27 INFO - 'install', 05:39:27 INFO - 'run-tests'), 05:39:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:27 INFO - 'download_minidump_stackwalk': True, 05:39:27 INFO - 'download_symbols': 'ondemand', 05:39:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:27 INFO - 'installer_path': 'installer.exe', 05:39:27 INFO - 'log_level': 'info', 05:39:27 INFO - 'log_name': 'talos', 05:39:27 INFO - 'log_to_console': True, 05:39:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:27 INFO - 'opt_config_files': (), 05:39:27 INFO - 'pip_index': False, 05:39:27 INFO - 'sps_profile': False, 05:39:27 INFO - 'sps_profile_interval': 0, 05:39:27 INFO - 'suite': 'dromaeojs', 05:39:27 INFO - 'system_bits': '32', 05:39:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:27 INFO - 'title': 'talos-linux64-ix-022', 05:39:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:27 INFO - 'use_talos_json': True, 05:39:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:27 INFO - 'work_dir': 'build'} 05:39:27 INFO - ##### 05:39:27 INFO - ##### Running clobber step. 05:39:27 INFO - ##### 05:39:27 INFO - Running pre-action listener: _resource_record_pre_action 05:39:27 INFO - Running main action method: clobber 05:39:27 INFO - rmtree: /builds/slave/test/build 05:39:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:27 INFO - Running post-action listener: _resource_record_post_action 05:39:27 INFO - ##### 05:39:27 INFO - ##### Finished clobber step (success) 05:39:27 INFO - ##### 05:39:27 INFO - ##### 05:39:27 INFO - ##### Running read-buildbot-config step. 05:39:27 INFO - ##### 05:39:27 INFO - Running pre-action listener: _resource_record_pre_action 05:39:27 INFO - Running main action method: read_buildbot_config 05:39:27 INFO - Using buildbot properties: 05:39:27 INFO - { 05:39:27 INFO - "project": "", 05:39:27 INFO - "product": "firefox", 05:39:27 INFO - "script_repo_revision": "production", 05:39:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:39:27 INFO - "repository": "", 05:39:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:39:27 INFO - "buildid": "20160609030247", 05:39:27 INFO - "stage_platform": "linux64-pgo", 05:39:27 INFO - "basedir": "/builds/slave/test", 05:39:27 INFO - "nightly_build": "True", 05:39:27 INFO - "buildnumber": 330, 05:39:27 INFO - "slavename": "talos-linux64-ix-022", 05:39:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:27 INFO - "platform": "ubuntu64_hw", 05:39:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:27 INFO - "branch": "mozilla-central", 05:39:27 INFO - "repo_path": "mozilla-central", 05:39:27 INFO - "revision": "cb493102af8a50946ac601a86cc3d076703faa57", 05:39:27 INFO - "pgo_build": "True", 05:39:27 INFO - "builduid": "d600bdbc5a39477ba57a97cdd26595d9", 05:39:27 INFO - "slavebuilddir": "test" 05:39:27 INFO - } 05:39:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:39:27 INFO - Running post-action listener: _resource_record_post_action 05:39:27 INFO - ##### 05:39:27 INFO - ##### Finished read-buildbot-config step (success) 05:39:27 INFO - ##### 05:39:27 INFO - ##### 05:39:27 INFO - ##### Running download-and-extract step. 05:39:27 INFO - ##### 05:39:27 INFO - Running pre-action listener: _resource_record_pre_action 05:39:27 INFO - Running main action method: download_and_extract 05:39:27 INFO - mkdir: /builds/slave/test/build/tests 05:39: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')]} 05:39:27 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:28 INFO - Downloaded 1361 bytes. 05:39:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:28 INFO - Using the following test package requirements: 05:39:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'jsshell-linux-x86_64.zip'], 05:39:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:28 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:29 INFO - Downloaded 24451981 bytes. 05:39:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:39:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:39:30 INFO - Return code: 0 05:39:30 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 05:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:30 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:31 INFO - Downloaded 24451981 bytes. 05:39:31 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'] 05:39:31 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 05:39:33 INFO - Return code: 0 05:39:33 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')]} 05:39:33 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:34 INFO - Downloaded 10833377 bytes. 05:39:34 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'] 05:39:34 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 05:39:34 INFO - Return code: 0 05:39: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')]} 05:39:34 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:36 INFO - Downloaded 59350640 bytes. 05:39:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:36 INFO - mkdir: /builds/slave/test/properties 05:39:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:36 INFO - Contents: 05:39:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:36 INFO - Running post-action listener: _resource_record_post_action 05:39:36 INFO - Running post-action listener: set_extra_try_arguments 05:39:36 INFO - ##### 05:39:36 INFO - ##### Finished download-and-extract step (success) 05:39:36 INFO - ##### 05:39:36 INFO - ##### 05:39:36 INFO - ##### Running populate-webroot step. 05:39:36 INFO - ##### 05:39:36 INFO - Running pre-action listener: _resource_record_pre_action 05:39:36 INFO - Running main action method: populate_webroot 05:39:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:36 INFO - '--tppagecycles', 05:39:36 INFO - '7'], 05:39:36 INFO - 'tests': ['tsvgm']}}, 05:39:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['damp', 'tps']}, 05:39:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'tests': ['damp', 'tps']}, 05:39:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['dromaeo_dom']}, 05:39:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['a11yr', 05:39:36 INFO - 'ts_paint', 05:39:36 INFO - 'tpaint', 05:39:36 INFO - 'sessionrestore', 05:39:36 INFO - 'sessionrestore_no_auto_restore', 05:39:36 INFO - 'tabpaint']}, 05:39:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['tsvgx', 05:39:36 INFO - 'tsvgr_opacity', 05:39:36 INFO - 'tart', 05:39:36 INFO - 'tscrollx', 05:39:36 INFO - 'cart']}, 05:39:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:36 INFO - 'tsvgr_opacity', 05:39:36 INFO - 'tart', 05:39:36 INFO - 'tscrollx', 05:39:36 INFO - 'cart']}, 05:39:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'talos_options': ['--disable-e10s'], 05:39:36 INFO - 'tests': ['tp5o']}, 05:39:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'tests': ['tp5o']}, 05:39:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'talos_options': ['--disable-e10s', 05:39:36 INFO - '--xperf_path', 05:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:36 INFO - 'tests': ['tp5n']}, 05:39:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:36 INFO - 'talos_options': ['--xperf_path', 05:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:36 INFO - 'tests': ['tp5n']}}, 05:39:36 INFO - 'talos.zip': {'path': '', 05:39:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:36 INFO - Running post-action listener: _resource_record_post_action 05:39:36 INFO - ##### 05:39:36 INFO - ##### Finished populate-webroot step (success) 05:39:36 INFO - ##### 05:39:36 INFO - ##### 05:39:36 INFO - ##### Running create-virtualenv step. 05:39:36 INFO - ##### 05:39:36 INFO - Running pre-action listener: _resource_record_pre_action 05:39:36 INFO - Running main action method: create_virtualenv 05:39:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:36 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 05:39:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:36 INFO - Using real prefix '/usr' 05:39:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:39 INFO - Installing pip.................done. 05:39:39 INFO - Return code: 0 05:39:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:39 INFO - Using env: {'DISPLAY': ':0', 05:39:39 INFO - 'HOME': '/home/cltbld', 05:39:39 INFO - 'LANG': 'en_US.UTF-8', 05:39:39 INFO - 'LANGUAGE': 'en_US:en', 05:39:39 INFO - 'LOGNAME': 'cltbld', 05:39:39 INFO - 'MAIL': '/var/mail/cltbld', 05:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:39 INFO - 'MOZ_NO_REMOTE': '1', 05:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:39 INFO - 'NO_EM_RESTART': '1', 05:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:39 INFO - 'PWD': '/builds/slave/test', 05:39:39 INFO - 'SHELL': '/bin/bash', 05:39:39 INFO - 'SHLVL': '1', 05:39:39 INFO - 'TERM': 'linux', 05:39:39 INFO - 'TMOUT': '86400', 05:39:39 INFO - 'USER': 'cltbld', 05:39:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:39 INFO - '_': '/tools/buildbot/bin/python'} 05:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:39 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 05:39:39 INFO - Cleaning up... 05:39:39 INFO - Return code: 0 05:39:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:39 INFO - Using env: {'DISPLAY': ':0', 05:39:39 INFO - 'HOME': '/home/cltbld', 05:39:39 INFO - 'LANG': 'en_US.UTF-8', 05:39:39 INFO - 'LANGUAGE': 'en_US:en', 05:39:39 INFO - 'LOGNAME': 'cltbld', 05:39:39 INFO - 'MAIL': '/var/mail/cltbld', 05:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:39 INFO - 'MOZ_NO_REMOTE': '1', 05:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:39 INFO - 'NO_EM_RESTART': '1', 05:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:39 INFO - 'PWD': '/builds/slave/test', 05:39:39 INFO - 'SHELL': '/bin/bash', 05:39:39 INFO - 'SHLVL': '1', 05:39:39 INFO - 'TERM': 'linux', 05:39:39 INFO - 'TMOUT': '86400', 05:39:39 INFO - 'USER': 'cltbld', 05:39:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:39 INFO - '_': '/tools/buildbot/bin/python'} 05:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:39 INFO - Downloading/unpacking psutil>=3.1.1 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:41 INFO - Installing collected packages: psutil 05:39:41 INFO - Running setup.py install for psutil 05:39:41 INFO - building 'psutil._psutil_linux' extension 05:39:41 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 05:39:42 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 05:39:42 INFO - building 'psutil._psutil_posix' extension 05:39:42 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 05:39:42 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 05:39:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:42 INFO - Successfully installed psutil 05:39:42 INFO - Cleaning up... 05:39:42 INFO - Return code: 0 05:39:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:39: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 mozsystemmonitor==0.3 05:39:42 INFO - Using env: {'DISPLAY': ':0', 05:39:42 INFO - 'HOME': '/home/cltbld', 05:39:42 INFO - 'LANG': 'en_US.UTF-8', 05:39:42 INFO - 'LANGUAGE': 'en_US:en', 05:39:42 INFO - 'LOGNAME': 'cltbld', 05:39:42 INFO - 'MAIL': '/var/mail/cltbld', 05:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:42 INFO - 'MOZ_NO_REMOTE': '1', 05:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:42 INFO - 'NO_EM_RESTART': '1', 05:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:42 INFO - 'PWD': '/builds/slave/test', 05:39:42 INFO - 'SHELL': '/bin/bash', 05:39:42 INFO - 'SHLVL': '1', 05:39:42 INFO - 'TERM': 'linux', 05:39:42 INFO - 'TMOUT': '86400', 05:39:42 INFO - 'USER': 'cltbld', 05:39:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:42 INFO - '_': '/tools/buildbot/bin/python'} 05:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:44 INFO - Installing collected packages: mozsystemmonitor 05:39:44 INFO - Running setup.py install for mozsystemmonitor 05:39:44 INFO - Successfully installed mozsystemmonitor 05:39:44 INFO - Cleaning up... 05:39:44 INFO - Return code: 0 05:39:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:39:44 INFO - Using env: {'DISPLAY': ':0', 05:39:44 INFO - 'HOME': '/home/cltbld', 05:39:44 INFO - 'LANG': 'en_US.UTF-8', 05:39:44 INFO - 'LANGUAGE': 'en_US:en', 05:39:44 INFO - 'LOGNAME': 'cltbld', 05:39:44 INFO - 'MAIL': '/var/mail/cltbld', 05:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:44 INFO - 'MOZ_NO_REMOTE': '1', 05:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:44 INFO - 'NO_EM_RESTART': '1', 05:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:44 INFO - 'PWD': '/builds/slave/test', 05:39:44 INFO - 'SHELL': '/bin/bash', 05:39:44 INFO - 'SHLVL': '1', 05:39:44 INFO - 'TERM': 'linux', 05:39:44 INFO - 'TMOUT': '86400', 05:39:44 INFO - 'USER': 'cltbld', 05:39:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:44 INFO - '_': '/tools/buildbot/bin/python'} 05:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:47 INFO - warning: no files found matching '*.txt' 05:39:47 INFO - no previously-included directories found matching 'build' 05:39:47 INFO - no previously-included directories found matching 'dist' 05:39:47 INFO - no previously-included directories found matching '.git*' 05:39:47 INFO - Installing collected packages: jsonschema, functools32 05:39:47 INFO - Running setup.py install for functools32 05:39:47 INFO - warning: no files found matching '*.txt' 05:39:47 INFO - no previously-included directories found matching 'build' 05:39:47 INFO - no previously-included directories found matching 'dist' 05:39:47 INFO - no previously-included directories found matching '.git*' 05:39:47 INFO - Successfully installed jsonschema functools32 05:39:47 INFO - Cleaning up... 05:39:47 INFO - Return code: 0 05:39:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:47 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')]} 05:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:47 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')]} 05:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:47 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:47 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 05:39:47 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 05:39:47 INFO - Using env: {'DISPLAY': ':0', 05:39:47 INFO - 'HOME': '/home/cltbld', 05:39:47 INFO - 'LANG': 'en_US.UTF-8', 05:39:47 INFO - 'LANGUAGE': 'en_US:en', 05:39:47 INFO - 'LOGNAME': 'cltbld', 05:39:47 INFO - 'MAIL': '/var/mail/cltbld', 05:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:47 INFO - 'MOZ_NO_REMOTE': '1', 05:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:47 INFO - 'NO_EM_RESTART': '1', 05:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:47 INFO - 'PWD': '/builds/slave/test', 05:39:47 INFO - 'SHELL': '/bin/bash', 05:39:47 INFO - 'SHLVL': '1', 05:39:47 INFO - 'TERM': 'linux', 05:39:47 INFO - 'TMOUT': '86400', 05:39:47 INFO - 'USER': 'cltbld', 05:39:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:47 INFO - '_': '/tools/buildbot/bin/python'} 05:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:50 INFO - Downloading docopt-0.6.1.tar.gz 05:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:50 INFO - Running setup.py install for blobuploader 05:39:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:50 INFO - Running setup.py install for requests 05:39:50 INFO - Running setup.py install for docopt 05:39:50 INFO - Successfully installed blobuploader requests docopt 05:39:50 INFO - Cleaning up... 05:39:50 INFO - Return code: 0 05:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:50 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')]} 05:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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')]} 05:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:50 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 05:39:50 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 05:39:50 INFO - Using env: {'DISPLAY': ':0', 05:39:50 INFO - 'HOME': '/home/cltbld', 05:39:50 INFO - 'LANG': 'en_US.UTF-8', 05:39:50 INFO - 'LANGUAGE': 'en_US:en', 05:39:50 INFO - 'LOGNAME': 'cltbld', 05:39:50 INFO - 'MAIL': '/var/mail/cltbld', 05:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:50 INFO - 'MOZ_NO_REMOTE': '1', 05:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:50 INFO - 'NO_EM_RESTART': '1', 05:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:50 INFO - 'PWD': '/builds/slave/test', 05:39:50 INFO - 'SHELL': '/bin/bash', 05:39:50 INFO - 'SHLVL': '1', 05:39:50 INFO - 'TERM': 'linux', 05:39:50 INFO - 'TMOUT': '86400', 05:39:50 INFO - 'USER': 'cltbld', 05:39:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:50 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:51 INFO - Running setup.py (path:/tmp/pip-GWcVnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:51 INFO - Running setup.py (path:/tmp/pip-T1aRwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:51 INFO - Running setup.py (path:/tmp/pip-h6E0Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:51 INFO - Running setup.py (path:/tmp/pip-w3c06u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:51 INFO - Running setup.py (path:/tmp/pip-jkZxDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:51 INFO - Running setup.py (path:/tmp/pip-KUIlQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:51 INFO - Running setup.py (path:/tmp/pip-lvwM4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:51 INFO - Running setup.py (path:/tmp/pip-9LwNou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:51 INFO - Running setup.py (path:/tmp/pip-8YX75q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:51 INFO - Running setup.py (path:/tmp/pip-nXGuZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:51 INFO - Running setup.py (path:/tmp/pip-IGCmT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:51 INFO - Running setup.py (path:/tmp/pip-by2Fte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:51 INFO - Running setup.py (path:/tmp/pip-CWkU0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:51 INFO - Running setup.py (path:/tmp/pip-sQsyhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:52 INFO - Running setup.py (path:/tmp/pip-qUcGST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:52 INFO - Running setup.py (path:/tmp/pip-lD8h75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:52 INFO - Running setup.py (path:/tmp/pip-FaWn9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:52 INFO - Running setup.py install for manifestparser 05:39:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:52 INFO - Running setup.py install for mozcrash 05:39:52 INFO - Running setup.py install for mozdebug 05:39:52 INFO - Running setup.py install for mozdevice 05:39:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:52 INFO - Running setup.py install for mozfile 05:39:52 INFO - Running setup.py install for mozhttpd 05:39:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:52 INFO - Running setup.py install for mozinfo 05:39:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:52 INFO - Running setup.py install for mozInstall 05:39:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Running setup.py install for mozleak 05:39:53 INFO - Running setup.py install for mozlog 05:39:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Running setup.py install for moznetwork 05:39:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Running setup.py install for mozprocess 05:39:53 INFO - Running setup.py install for mozprofile 05:39:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Running setup.py install for mozrunner 05:39:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:53 INFO - Running setup.py install for mozscreenshot 05:39:53 INFO - Running setup.py install for moztest 05:39:53 INFO - Running setup.py install for mozversion 05:39:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:54 INFO - Cleaning up... 05:39:54 INFO - Return code: 0 05:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:54 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')]} 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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')]} 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:54 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 05:39:54 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 05:39:54 INFO - Using env: {'DISPLAY': ':0', 05:39:54 INFO - 'HOME': '/home/cltbld', 05:39:54 INFO - 'LANG': 'en_US.UTF-8', 05:39:54 INFO - 'LANGUAGE': 'en_US:en', 05:39:54 INFO - 'LOGNAME': 'cltbld', 05:39:54 INFO - 'MAIL': '/var/mail/cltbld', 05:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:54 INFO - 'MOZ_NO_REMOTE': '1', 05:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:54 INFO - 'NO_EM_RESTART': '1', 05:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:54 INFO - 'PWD': '/builds/slave/test', 05:39:54 INFO - 'SHELL': '/bin/bash', 05:39:54 INFO - 'SHLVL': '1', 05:39:54 INFO - 'TERM': 'linux', 05:39:54 INFO - 'TMOUT': '86400', 05:39:54 INFO - 'USER': 'cltbld', 05:39:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:54 INFO - '_': '/tools/buildbot/bin/python'} 05:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:54 INFO - Running setup.py (path:/tmp/pip-uehibg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:54 INFO - Running setup.py (path:/tmp/pip-eQewP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:54 INFO - Running setup.py (path:/tmp/pip-DECLHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:54 INFO - Running setup.py (path:/tmp/pip-2S7z4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:54 INFO - Running setup.py (path:/tmp/pip-zxjBA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:54 INFO - Running setup.py (path:/tmp/pip-xBQcaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:54 INFO - Running setup.py (path:/tmp/pip-62zTq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:54 INFO - Running setup.py (path:/tmp/pip-4jXRGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:54 INFO - Running setup.py (path:/tmp/pip-6Gi0VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:54 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)) 05:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:54 INFO - Running setup.py (path:/tmp/pip-wdxbR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:55 INFO - Running setup.py (path:/tmp/pip-EkDCMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:55 INFO - Running setup.py (path:/tmp/pip-7MLIlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:55 INFO - Running setup.py (path:/tmp/pip-JS5A6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:55 INFO - Running setup.py (path:/tmp/pip-U49dZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:55 INFO - Running setup.py (path:/tmp/pip-5PPCVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:55 INFO - Running setup.py (path:/tmp/pip-pwHKi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:55 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)) 05:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:55 INFO - Running setup.py (path:/tmp/pip-OSYb57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:55 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)) 05:39:55 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)) 05:39:55 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)) 05:39:55 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)) 05:39:55 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)) 05:39:55 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)) 05:39:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - Downloading blessings-1.6.tar.gz 05:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:57 INFO - Installing collected packages: blessings 05:39:57 INFO - Running setup.py install for blessings 05:39:57 INFO - Successfully installed blessings 05:39:57 INFO - Cleaning up... 05:39:57 INFO - Return code: 0 05:39:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:57 INFO - Reading from file tmpfile_stdout 05:39:57 INFO - Current package versions: 05:39:57 INFO - argparse == 1.2.1 05:39:57 INFO - blessings == 1.6 05:39:57 INFO - blobuploader == 1.2.4 05:39:57 INFO - docopt == 0.6.1 05:39:57 INFO - functools32 == 3.2.3-2 05:39:57 INFO - jsonschema == 2.5.1 05:39:57 INFO - manifestparser == 1.1 05:39:57 INFO - mozInstall == 1.12 05:39:57 INFO - mozcrash == 0.17 05:39:57 INFO - mozdebug == 0.1 05:39:57 INFO - mozdevice == 0.48 05:39:57 INFO - mozfile == 1.2 05:39:57 INFO - mozhttpd == 0.7 05:39:57 INFO - mozinfo == 0.9 05:39:57 INFO - mozleak == 0.1 05:39:57 INFO - mozlog == 3.2 05:39:57 INFO - moznetwork == 0.27 05:39:57 INFO - mozprocess == 0.22 05:39:57 INFO - mozprofile == 0.28 05:39:57 INFO - mozrunner == 6.11 05:39:57 INFO - mozscreenshot == 0.1 05:39:57 INFO - mozsystemmonitor == 0.3 05:39:57 INFO - moztest == 0.7 05:39:57 INFO - mozversion == 1.4 05:39:57 INFO - psutil == 3.1.1 05:39:57 INFO - requests == 1.2.3 05:39:57 INFO - wsgiref == 0.1.2 05:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:57 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 05:39:57 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 05:39:57 INFO - Using env: {'DISPLAY': ':0', 05:39:57 INFO - 'HOME': '/home/cltbld', 05:39:57 INFO - 'LANG': 'en_US.UTF-8', 05:39:57 INFO - 'LANGUAGE': 'en_US:en', 05:39:57 INFO - 'LOGNAME': 'cltbld', 05:39:57 INFO - 'MAIL': '/var/mail/cltbld', 05:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:57 INFO - 'MOZ_NO_REMOTE': '1', 05:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:57 INFO - 'NO_EM_RESTART': '1', 05:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:57 INFO - 'PWD': '/builds/slave/test', 05:39:57 INFO - 'SHELL': '/bin/bash', 05:39:57 INFO - 'SHLVL': '1', 05:39:57 INFO - 'TERM': 'linux', 05:39:57 INFO - 'TMOUT': '86400', 05:39:57 INFO - 'USER': 'cltbld', 05:39:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:57 INFO - '_': '/tools/buildbot/bin/python'} 05:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 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)) 05:39:58 INFO - Cleaning up... 05:39:58 INFO - Return code: 0 05:39:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:58 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:58 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 05:39:58 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 05:39:58 INFO - Using env: {'DISPLAY': ':0', 05:39:58 INFO - 'HOME': '/home/cltbld', 05:39:58 INFO - 'LANG': 'en_US.UTF-8', 05:39:58 INFO - 'LANGUAGE': 'en_US:en', 05:39:58 INFO - 'LOGNAME': 'cltbld', 05:39:58 INFO - 'MAIL': '/var/mail/cltbld', 05:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:58 INFO - 'MOZ_NO_REMOTE': '1', 05:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:58 INFO - 'NO_EM_RESTART': '1', 05:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:58 INFO - 'PWD': '/builds/slave/test', 05:39:58 INFO - 'SHELL': '/bin/bash', 05:39:58 INFO - 'SHLVL': '1', 05:39:58 INFO - 'TERM': 'linux', 05:39:58 INFO - 'TMOUT': '86400', 05:39:58 INFO - 'USER': 'cltbld', 05:39:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:58 INFO - '_': '/tools/buildbot/bin/python'} 05:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:58 INFO - Cleaning up... 05:39:58 INFO - Return code: 0 05:39:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:58 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 0x7f577d411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', '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 05:39:58 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 05:39:58 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 05:39:58 INFO - Using env: {'DISPLAY': ':0', 05:39:58 INFO - 'HOME': '/home/cltbld', 05:39:58 INFO - 'LANG': 'en_US.UTF-8', 05:39:58 INFO - 'LANGUAGE': 'en_US:en', 05:39:58 INFO - 'LOGNAME': 'cltbld', 05:39:58 INFO - 'MAIL': '/var/mail/cltbld', 05:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:58 INFO - 'MOZ_NO_REMOTE': '1', 05:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:58 INFO - 'NO_EM_RESTART': '1', 05:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:58 INFO - 'PWD': '/builds/slave/test', 05:39:58 INFO - 'SHELL': '/bin/bash', 05:39:58 INFO - 'SHLVL': '1', 05:39:58 INFO - 'TERM': 'linux', 05:39:58 INFO - 'TMOUT': '86400', 05:39:58 INFO - 'USER': 'cltbld', 05:39:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:58 INFO - '_': '/tools/buildbot/bin/python'} 05:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:58 INFO - Downloading/unpacking flake8 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:00 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 05:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:01 INFO - no previously-included directories found matching 'docs/_build' 05:40:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:01 INFO - Running setup.py install for pep8 05:40:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:01 INFO - no previously-included directories found matching 'docs/_build' 05:40:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:40:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:01 INFO - Cleaning up... 05:40:01 INFO - Return code: 0 05:40:01 INFO - Running post-action listener: _resource_record_post_action 05:40:01 INFO - Running post-action listener: _start_resource_monitoring 05:40:01 INFO - Starting resource monitoring. 05:40:01 INFO - ##### 05:40:01 INFO - ##### Finished create-virtualenv step (success) 05:40:01 INFO - ##### 05:40:01 INFO - ##### 05:40:01 INFO - ##### Running install step. 05:40:01 INFO - ##### 05:40:01 INFO - Running pre-action listener: _resource_record_pre_action 05:40:01 INFO - Running main action method: install 05:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:01 INFO - Reading from file tmpfile_stdout 05:40:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:01 INFO - Reading from file tmpfile_stdout 05:40:01 INFO - Output received: 05:40:01 INFO - Usage: mozinstall [options] installer 05:40:01 INFO - Options: 05:40:01 INFO - -h, --help show this help message and exit 05:40:01 INFO - -d DEST, --destination=DEST 05:40:01 INFO - Directory to install application into. [default: 05:40:01 INFO - "/builds/slave/test"] 05:40:01 INFO - --app=APP Application being installed. [default: firefox] 05:40:01 INFO - mkdir: /builds/slave/test/build/application 05:40:01 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'] 05:40:01 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 05:40:18 INFO - Reading from file tmpfile_stdout 05:40:18 INFO - Output received: 05:40:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:18 INFO - Running post-action listener: _resource_record_post_action 05:40:18 INFO - ##### 05:40:18 INFO - ##### Finished install step (success) 05:40:18 INFO - ##### 05:40:18 INFO - ##### 05:40:18 INFO - ##### Running run-tests step. 05:40:18 INFO - ##### 05:40:18 INFO - Running pre-action listener: _resource_record_pre_action 05:40:18 INFO - Running main action method: run_tests 05:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:18 INFO - Python 2.7.3 05:40:18 INFO - Return code: 0 05:40:18 INFO - grabbing minidump binary from tooltool 05:40:18 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')]} 05:40:18 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 0xede1c0>, '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 0xedf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:18 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 05:40:18 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 05:40:18 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 05:40:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:18 INFO - Return code: 0 05:40:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:40:19 INFO - Return code: 0 05:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 05:40:19 INFO - Using env: {'DISPLAY': ':0', 05:40:19 INFO - 'HOME': '/home/cltbld', 05:40:19 INFO - 'LANG': 'en_US.UTF-8', 05:40:19 INFO - 'LANGUAGE': 'en_US:en', 05:40:19 INFO - 'LOGNAME': 'cltbld', 05:40:19 INFO - 'MAIL': '/var/mail/cltbld', 05:40:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:19 INFO - 'MOZ_NO_REMOTE': '1', 05:40:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:19 INFO - 'NO_EM_RESTART': '1', 05:40:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:19 INFO - 'PWD': '/builds/slave/test', 05:40:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:19 INFO - 'SHELL': '/bin/bash', 05:40:19 INFO - 'SHLVL': '1', 05:40:19 INFO - 'TERM': 'linux', 05:40:19 INFO - 'TMOUT': '86400', 05:40:19 INFO - 'USER': 'cltbld', 05:40:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648', 05:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:19 INFO - '_': '/tools/buildbot/bin/python'} 05:40:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:40:19 INFO - mozversion application_buildid: 20160609030247 05:40:19 INFO - mozversion application_changeset: cb493102af8a50946ac601a86cc3d076703faa57 05:40:19 INFO - mozversion application_display_name: Nightly 05:40:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:19 INFO - mozversion application_name: Firefox 05:40:19 INFO - mozversion application_remotingname: firefox 05:40:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:19 INFO - mozversion application_vendor: Mozilla 05:40:19 INFO - mozversion application_version: 50.0a1 05:40:19 INFO - mozversion platform_buildid: 20160609030247 05:40:19 INFO - mozversion platform_changeset: cb493102af8a50946ac601a86cc3d076703faa57 05:40:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:19 INFO - mozversion platform_version: 50.0a1 05:40:19 INFO - using testdate: 1465476019 05:40:19 INFO - actual date: 1465476019 05:40:19 INFO - starting webserver on 'localhost:52060' 05:40:19 INFO - SUITE-START | Running 2 tests 05:40:19 INFO - TEST-START | dromaeo_css 05:40:19 INFO - operating with platform_type : linux_ 05:40:19 INFO - Initialising browser for dromaeo_css test... 05:40:19 INFO - TEST-INFO | started process 2345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZIV_8/profile http://localhost:52060/getInfo.html) 05:40:24 INFO - PROCESS | 2345 | __metrics Screen width/height:1600/1200 05:40:24 INFO - PROCESS | 2345 | colorDepth:24 05:40:24 INFO - PROCESS | 2345 | Browser inner width/height: 1024/697 05:40:24 INFO - PROCESS | 2345 | __metrics 05:40:25 ERROR - PROCESS | 2345 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:40:25 INFO - PROCESS | 2345 | console.error: PushService: 05:40:25 INFO - PROCESS | 2345 | stateChangeProcessEnqueue: Error transitioning state 05:40:25 INFO - PROCESS | 2345 | UnknownError 05:40:26 INFO - TEST-INFO | 2345: exit 0 05:40:26 INFO - Browser initialized. 05:40:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:26 INFO - TEST-INFO | started process 2504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZIV_8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:38 INFO - PROCESS | 2504 | RSS: Main: 173203456 05:40:38 INFO - PROCESS | 2504 | 05:41:29 INFO - PROCESS | 2504 | 1465476089953 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:43:37 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52060/tests/dromaeo/cssquery-ext.html) 05:43:39 INFO - PROCESS | 2504 | RSS: Main: 247881728 05:43:39 INFO - PROCESS | 2504 | 05:46:41 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-ext.html (next: http://localhost:52060/tests/dromaeo/cssquery-jquery.html) 05:46:42 INFO - PROCESS | 2504 | RSS: Main: 261271552 05:46:42 INFO - PROCESS | 2504 | 05:49:44 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52060/tests/dromaeo/cssquery-mootools.html) 05:49:44 INFO - PROCESS | 2504 | RSS: Main: 262017024 05:49:44 INFO - PROCESS | 2504 | 05:52:46 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52060/tests/dromaeo/cssquery-prototype.html) 05:52:47 INFO - PROCESS | 2504 | RSS: Main: 254320640 05:52:47 INFO - PROCESS | 2504 | 05:55:50 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52060/tests/dromaeo/cssquery-yui.html) 05:55:50 INFO - PROCESS | 2504 | RSS: Main: 236498944 05:55:50 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-yui.html (next: http://localhost:52060/tests/dromaeo/cssquery-dojo.html) 05:58:53 INFO - PROCESS | 2504 | RSS: Main: 313233408 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | __start_tp_report 05:58:53 INFO - PROCESS | 2504 | _x_x_mozilla_page_load 05:58:53 INFO - PROCESS | 2504 | _x_x_mozilla_page_load_details 05:58:53 INFO - PROCESS | 2504 | |i|pagename|runs| 05:58:53 INFO - PROCESS | 2504 | |0;dojo.html;3104.3946430446067;3105.3168302973336;3119.189010857177;3126.6248050233976;3166.271757495776;5228.947710522893;5284.920726189105;5304.787808487666;5380.219868119125;5416.566674666027;5283.947160528393;5287.735613219343;5294.311739473863;5318.680879147244;5385.380681221661;4743.430788305408;4806.855794326176;4847.345608342864;4856;5008.824691135811;4940.97529512352;4944.4313903900975;5005.974970125162;5011.3485246918035;5018.573421259197;4721.787519561611;4760.8333708320215;4799.256115302099;4869.805207791684;4886.144924638192;4789.880252993703;4806.423229212517;4808.735519546423;4875.926861097051;4970.378702662168;4800.399950006249;4845.685030473008;4847.224444088929;4848.10310092634;4882.853514394574;5200.401953775288;5240.082985477564;5341.359036915556;5345.518903298722;5380.461953804588;5771.769129234825;5776.075827867563;5817.563682723812;5822.359540450547;5825.038868586678;5844.561657875676;5857.092150716646;5858.091995740667;5859.970700146472;5873.471387575139;5203.739813009334;5245.449227831099;5285.286486324374;5288.021715982555;5458.61789674723;5828.970855145697;5887.322957859816;5888.676122813286;5892.440218179266;5895.20414744004;5659.26429564154;5668.489835914787;5670.659760414388;5678.432156784289;5681.318241811009;5531.059719847635;5650.180723795027;5679.659220446786;5683.7442315095095;5760.452756988079;5694.117411801095;5718;5719.542436605062;5720.542356611461;5720.971395142998;5540.63985840919;5728.742206600713;5740.13897915316;5742.052561327418;5744.310682718101;4318.050028993616;4368.912621747547;4385.495667998157;4399.758013309299;4432.955670443319;3930.8034598269974;3932.5870783567884;3945.033466800652;3978.7015973801504;3990.780507072081;5213.191955246943;5402.729863506809;5436.673799572039;5451.672899625956;5452.727363631882;5656.519195868315;5664.773409063674;5697.259356283739;5764.942350576524;5836.708164591753;5425.9186112208345;5430.212619170198;5432.674039557639;5433.809816656398;5434.945650543523;4838.274258861128;4991.925121123186;4993.151164302078;5010.924836127461;5043.470435604208;5863.413658634103;5903.321118071391;5947.1376650385455;5998.100284957204;6049.516038716892;5810.564207684356;5811.418858114154;5817.592768506164;5817.650940943557;5821.70891455417;5755.223044889054;5965.880682386415;5970.820875373745;5976.701164941823;5977.3126090500145;5597.272354593877;5603.159526071122;5612.045952188057;5664.461876121762;5670.546356291569;5727.4845263926445;5766.077427611562;5768.711564421846;5769.278840144982;5769.8557536061935;5443.510084092451;5487.094629386266;5548.833534993957;5598.608097433304;5606.523445507178;5552.861178470409;5563.109902415594;5563.7496312666835;5566.332040155207;5567.053600887778;5478.424765399575;5481.780728770805;5484.506394424521;5486.286782718221;5489.423610520837;5551.417101204315;5614.69119198448;5619.409961953936;5658;5718.542516598579;5344.518993290622;5375.731213439391;5455.099908515051;5462.016836969384;5504.4495550444635 05:58:53 INFO - PROCESS | 2504 | |1;ext.html;599.757098375158;623.6538721009838;633.0504243634548;638.8881945659508;640.0303540136694;31073.06780796577;31587;33739;33763.99999999997;42419.363709544305;41646.58353416465;46039;46166.53833461664;46171;46175;8819.338549608789;8993.595288212013;8998.14517620825;8999.280057595377;9002.144796244347;8787.824243515126;8875.644974201057;8884.378093533454;8895.421797583169;8898.199162075412;8894.155055269739;8943.284537237038;8945.284377249804;8951.865722014143;8955.417897836653;8855.114488551159;8895.555222238927;8906.777330566723;8909.064548222408;8913.598888050054;8874.378793484459;8944.060873608307;8947.105289471066;8948.194662480408;8955.776105597348;42918.14163716739;43273.78363108164;43299.56700432987;43324.566754332365;43375.13249735019;3314.055494184146;3496.825158742078;3562.5546806649168;3596.4245720684567;3770.7926064066464;32441.513377299358;32650.673493265;33043.33913321744;33589;33790;3956.287868183726;4064.7764372959477;4107.794610269475;4136.751794892316;4172.4784401949755;344324;344534;345024;345550.9057182986;346132.9999999975;46983.76508117437;52040.739796300775;52720;53243.201351979755;53340.733296334045;58857;58952;59010.819783604085;59028.39230273117;59152.40847591469;14834.851651483346;14844.257787110817;14990.850091499164;15031.173285469185;15052.623684407758;10700.78598428027;10749.462526873625;10782.568697252022;10782.892171078345;10790.622328218631;15755.291011904263;16859;17108.828911710723;17138.657226855394;17169.656606867793;6227.626342419469;6317.684115794192;6471.385218404244;6612.2726500084955;6632.137822083098;991.375433476905;995.6166875752888;1000.4247557654232;1088.8532142109311;1168.5165697039554;32753.344933101205;32851.67148328486;32866.342673146406;33065.50401743976;33430.66569334324;1076.235872530512;1093.283899046126;1159.9710007249887;1174.2543484887158;1201.4473342262656;16644.83355166457;17048.318067277418;17078.402255920984;17110.82889171117;17305.39431119905;575370;581692;585832;586483;588490;58406.70796645989;58729.70635146883;58764.7061764697;58864;58880.11679824806;1295.6307452376216;1323.616151316127;1338.1703343927022;1353.0393420671433;1357.7963305504056;31025.8448707755;31634.683653163174;31931.840340798146;31948.6805131955;32631.18422039468;51268.74365628148;51429.742851285504;51532.74233628808;52117;52117.739411302704;456660;469080;469180;469443;471509;36140.09649758777;40473.59526404816;41259.7937010313;41736.3739543901;42441;48312;48455.75772121117;48780.2682959763;49789.50210497993;50152.749236253585;40864.79567602143;41025;41300.38049429321;42419.57580424156;42473.57526424696;40805.32782817523;41269.38095928624;41308.58691413168;41653.79173104115;41930.161396772506;41470;42163.156736864476;42513.14973700447;42833.35749963815;42879;35313.82343088268;36883.262334753694;36888.26223475569;37150.628493714714;37574;27929.022484212954;28063.28043380959;28143.99714857161;28216.85891570529;28256.753062796815 05:58:53 INFO - PROCESS | 2504 | |2;jquery.html;380.41796052040377;382.81050879814495;383.5205992509363;395.5056179775281;398.5695448915172;14827.77758333626;16231;17110.14449277536;19978.90010549947;20002.69995950062;18180.09099545021;19270.22919083235;19577.902110489427;19630.901845490753;19674;5614.2701448811595;5748.080307150857;5799.18811366409;5851.50262227709;5858.648481091127;5608.186812912125;5737.454941780524;5765.509931655814;5771.884562308751;5774.942250577483;5618.185363122345;5654.406287339832;5678.801241956532;5718.513926316247;5725.856853578653;5732.197492351074;5751.079827227665;5765.1928729977835;5765.884682306351;5766.279215098113;4952;5092.083424983502;5147.6654017488745;5154.948450515484;5170.689758614495;22647.547049059092;22908.770912291;23136.074557017866;23269.185578504672;23282;2269.4326418395403;2813.887444502238;2934.11976407077;2940.0885725425187;3052.526858336961;13824.930875345659;14448.711025779425;14525.854741452556;15014.474493392789;15063;1913.9234430622757;1936.912838922252;1993.4219076467807;2015.828654564364;2080.781517940625;67483;78230;80621.19378806255;84037.57981210116;84325.57837210836;10679;10792.136629069655;10843.78312433747;10994.450277486094;11040.503177357039;14810.11139331622;14871.553853384416;14909;14935.477258295907;14967;7602.353799926957;7860.842783144305;7923.6830526778285;8050.396220283385;8199.71301004462;7393.371563417062;7601.505902116345;7664.233576642403;7714.190010048977;7767.766966990999;6450.967745161338;6521.315261897527;6610.900836487456;6739.224989126314;6743.797686069426;1874.3158747057225;1902.9524261893287;1946.1331051568693;1958.6278607064612;1973.5756812285429;892.5180402582532;964.9083337082966;969.3602222533235;1005.6228914157191;1043.5147656339839;17877.642447150985;17950.640987180184;19500.31748888782;19705.90147049284;20230.942264433892;968.3076600230728;978.7699890525721;985.8521221816642;1026.030401270792;1033.379972016784;10681.412522311191;11156.832647510293;11174.329540227449;11180.217384782987;11215.158863085302;547971;550314;558646;561326;562912;63356.36643633505;82000.12999544987;97484.51257743807;97635.51182244185;100595.49702251442;931.2782593490099;988.7478692933256;996.9501524923725;1037.5382954585136;1041.3231399590327;17731.11344432799;17823.73264401009;18133.546661333574;18166.72749908779;18335.26658933681;42066;42600;42754.57245427506;43145.921351966455;44215.55784442114;58876;60404.69797650984;60471.69764151151;61033;62199;7306;7893.052833659997;7917.524948503108;8022.237887400687;8050.355971522381;13377.464901403835;13425.597232083053;13671.79492307636;13726;13782.724345513234;11835.11236657237;11934.940325298665;11969.341686207343;12137.332446715516;12221.877781222074;11727.648170554898;11793.941030294794;11841.348725820162;11902.583409580624;12292.631221063382;11159.27464714791;11466.197366184288;11762.647120586396;12099.939500302795;12124.151309408257;7815.8436831261915;7853.764387068397;7870.386570752868;8030.5181689098845;8081.4747041442115;10780.38294255868;12002.886505586523;12010.519579217083;12067.51729930828;12239.75520489603 05:58:53 INFO - PROCESS | 2504 | |3;mootools.html;1327.933603319835;1445.5807815733435;1498.318265189339;1575.8109026916773;1778.0576294563878;8395.244428001479;8831;8834.072422395653;8834.955825220874;9040.547972601376;8451.492910425379;8644.870326945085;8918.77703057424;8931.732048038553;8933.106689331064;2014.6071516054376;2275.567642147995;2296.0586159674494;2336.4275752440676;2348.495073559184;2296.2881506732965;2307.3654744945106;2308.572914010905;2312;2312.2022902098834;2063.1128614695676;2074.284371891695;2094.0262777808316;2096.622607930572;2097.947551311222;1937.3994061840804;2192.8136108430645;2244.8316376271846;2250.797428231467;2259.807916327114;2304.665823455606;2315.8842057897036;2334.1947028275217;2334.48641298914;2336.0188720737333;8979;9045.728628141167;9068.773280668036;9074.818503629956;9078.727638170865;5209.374875014984;5329.25390445338;5344.412114667383;5348.251244825728;5348.465153484659;3201.807891526516;3324.16895776056;3390.932181356384;3394.2362968332172;3453.930921381558;1083.063150374928;1136.8351589019546;1139.8632164140356;1177.8174382970653;2040.7347044884218;12609.432575534123;13118.47526098955;13146.539871104562;13155.736885262337;13159.07886447949;4435.822567097344;4601.976990115028;4659.930101048487;4696.178168820443;4696.647751418657;10777.515011824487;10823.729406764895;10884.61903833362;10886.29239099456;10893.945530272298;5219.060569097523;5226.033183860998;5231.843044708665;5257.553107985864;5271.182966640177;4173.874783756492;4748;4871.074495845849;4871.244957031666;4938.234573641092;3825.5218097737784;3884.320243957296;3915.7454765440157;3952.505936757905;4006.659433948147;1167.4279602994472;1193.1051711216587;1205.7528206717777;1205.8552973643218;1220.664317312746;858.2533196119416;930.0559931669361;933.7245512573807;944.4852555357347;967.2455484721928;5828;5872.588918775645;5950.494207992369;5952.851178720567;6081.996470582393;460.11198387112523;477.85903158568306;478.38049725605424;480.9903801923942;482.312704396234;3893.863714770026;3989.122393073519;3997.920041599152;4013.618706222904;4049.797510124541;10945.233833631728;11191.776164476827;11343.829842552368;11578.71053223676;11594.710132246593;11435.59975400857;11471.942640286745;11516.712082197844;11555.480003399867;11579.13156513248;8401.789955251168;8591.6992905248;8593.52735599548;8594.742157735278;8598.656053757779;5681.176229446624;5834.716362400265;5906.645601263938;6020.397960203944;6037.305709843425;10168;10647.574097036031;10711.196660250356;10793.082587979796;10819.296745711503;10710.089642380484;10892.564297428014;10935.28920620157;11031;11032.393218372745;7643.770686879402;7882.802929926797;7893.131755506774;8136.75589732309;8307.584620769057;8602.39783215169;8612.569371531523;8622.655093796178;8681.609327580149;8752.21230089295;7603.581803000667;7886.960565197137;7915.287624113857;7916.960415197887;7923.445358824827;7472.439567032386;7591.316781489692;7746.264104910025;7851.175626559129;7903.170167132598;7225.494215404871;7246.60143692102;7264.091988501437;7280.9271907280245;7335.266473352622;4870.391201099863;4995.600351971761;5131.87170320745;5174.301469301596;5178.922316165336;4935.333729946411;5116;5117.897642047213;5200.089984252816;5237.319148510669 05:58:53 INFO - PROCESS | 2504 | |4;prototype.html;319.99200019999495;321.3829447460875;327.19510005386746;329.59295270341124;330.5141442080143;5258;5301.549368303698;5307.36311642603;5308.389535203452;5355.518003379695;5205.375354957401;5213.165893457048;5235.450277720842;5274.393444753845;5301.151815709487;3935.449037134796;4000.5999400059904;4113.794310284488;4123.6083071818275;4142.399352093945;4079.7348172368847;4105.460452330376;4113.56807535209;4128.02991297045;4149.91700165998;3908.8045597720143;4107.199096176232;4121.938170927424;4139.482564679415;4165.5834416558255;4072.857449989251;4136.937945930828;4147.937780933288;4154.605312495339;4177.603127702863;3676.8161591920566;3682.6869716074166;3692.1170203196293;3709.925801483982;3710.7402481826284;5108.565771909392;5125.38495380553;5143;5182.922256166161;5222.4255331913455;4515.05183911379;4739.241721324572;4745.16959532084;4761.4524329701835;4768.61851051915;5577.498025177713;5586.35756887959;5588.832335029955;5601.271834661468;5613.2422123013275;3986.960130398688;3995.7802320872343;4017.799110044515;4029.37544680575;4030.858919937788;5544.667319960775;5658.104534980786;5714.885702285973;5719.656820590778;5736.598438109334;4018.0758425562285;4024.95351208682;4047.696422768245;4056.7363121397016;4063.22798668258;4096.569860164699;4099.692523060782;4103.7948102594755;4105.58944105593;4132.33882578792;4595.609373203315;4694.929576056362;4697.530246975275;4699.694519856198;4705.835295764632;5479.890402191933;5492.615516913777;5518.475744804237;5531.557475401958;5549.916751248735;1390.2214759734582;1399.7760358342616;1408.9225092620004;1425.209009000015;1426.5577670922048;844.9788755281044;868.7828042989253;920.1672486399818;927.355487935878;958.9760255993656;5263.763130659129;5275.577953763766;5277.8416647500635;5303;5304.549113325411;5585.413531579207;5587.351731239294;5594.328680558359;5613.550915926716;5624.21261023457;5076.0863044652315;5227.921581176285;5254.4220135785035;5275.709835958983;5286.524212820865;2910.359720861407;2932.563044108414;2940.9264768380963;2959.1714319990438;2996.711414091918;5702.714864256854;5705.286839145107;5712.314522257273;5715.771369145187;5733.283339582552;5454.809081682201;5694.259746233046;5694.629849059798;5706.543476521868;5749.453801888814;5769.221155144086;5772.884542309214;5789.681567513827;5791.884162316815;5846.766129354948;5396.9730151348995;5623.718814059363;5661.207430959586;5707.20099186106;5745.91381129275;5638.746256418389;5642.6614403135945;5643.492085712305;5667.234923285304;5674.744636491285;5837.824865254049;5842.328132264844;5881.147233651182;5883.764169615519;5890.9116363253725;3906.2187562487047;3991.381335892941;4004.6796256298844;4006.979965100156;4065.390191471303;5659;5731.420860612824;5752.798652047159;5753.1370294456165;5755.510781583613;5374.220737992891;5423.647462914898;5546.916796247979;5633.211350410864;5650.858728531655;5568.805091821767;5594.272744543184;5595.720213989202;5605.411431799603;5613.46672066153;5237.816676416307;5469.589780766538;5506;5542.473465020817;5565.972170139124;5522.420145884625;5530.834074977757;5554.91667624994;5569.54939826475;5570.470805273655;5409.323834520685;5449.23710680513;5451.591130665137;5461.453854614507;5493.423190564933 05:58:53 INFO - PROCESS | 2504 | |5;yui.html;676.9289224631415;699.4563631237107;734.0897287363671;769.9846003079936;779.8089468080321;14903.925480372596;15000.09999400034;15315.157666328347;15518.844811551868;15527.689446211069;14533.128012319268;14575.416983320682;14648.414063437476;14696.485623003196;14702.926485367558;663.2969052804019;777.7705576854842;779.1935346915928;793.1275596843484;805.5730462854667;800.8958835351397;802.6588699802589;804.6660635836121;804.8873157757919;805.1304591041661;835.4277320035765;835.9749207523754;836.995815020924;837.2172019162073;837.2924878477677;694.3542505469911;817.3951276055706;828.4656396624174;838.337713206566;839.2991851803752;616.8334549671608;617.2099712368176;617.2253821454046;617.3178637605471;617.6695467924638;15147.469838555598;15225.543233703007;15230.847691523053;15237.466688665843;15237.923810380877;13981.580552583438;14312.785308220386;14436.855631443656;14451.927740361336;14494.130352178903;12040.277583345027;12104.515819367303;12218.75562488754;12272.938635306855;12460.065495087814;4402.25161722508;4433.069055498349;4447.466304043503;4618.861434156947;4634.374359461463;74720;75076;77066;77771.6111419445;77772;11330.433478326215;11462.254953428;11498.482568284448;11548.538058477734;11609.883901161049;21055.789442105382;21218.363449096552;21224.893875530524;21271.89364053201;21408;7594;7785.688572457151;7799.103103143211;7847.84304313922;8393.286570641441;4445.155420470101;4465.910681786411;4527.2303708369;4575.9084818303445;4660.161170989254;3300.950485742716;3366.882159124419;3382.0530251529613;3401.40475416806;3404.7105995990123;608.248812716295;615.2954866677629;616.5499185594541;635.1330433957614;638.4381744065286;623.2645478335608;638.0493065332621;671.5131529640971;685.1606781692387;700.2892064554482;9000.909990900138;9655;9694;9739.513024348755;9754.268429867789;667.5360624366116;672.744357144282;684.117488439907;684.7192651013061;708.7767353283699;4381.583749543788;4397.802098905557;4551.817927282872;4580.106879158532;4610.492054565415;94475;97610.51194743981;99210.5039474798;110123.44938275257;111215;93080;93395.53302233445;93879;98346;98750;84993.15006849976;87458.56270718733;87555.56222218975;88977;89139;9583;9824.901750982684;9926.503674816086;9957.900420995697;9973.551190196313;37247.441288380156;42762.57237427586;49149;49700;50777.23834142565;67471;72227.63886180536;73587;73652.63173684098;76297.6185119093;12396.442160102637;12794.168379055332;13114;13258.933705331412;13519.526816561372;13310.334483275603;13488.460461581426;14490.637734056732;14503.564893053226;14938.925305373403;12680.936595316964;12852.636412642123;12908;13290.20258784476;14046.578602641937;13156.60530184096;13245.80131298012;14014.159150451005;14024.719505610035;14556.85443145555;13596.59210223695;13665.556375531172;13846.515371961934;13869.237191954137;13870.237136957565;10613.628523001658;10883.346999180074;10934.78130437371;10990.780184396108;11588.304701717923;11556.711082222675;11558.30650160993;11703.156380947727;11984.880151198726;11987.76024479523 05:58:53 INFO - PROCESS | 2504 | __end_tp_report 05:58:53 INFO - PROCESS | 2504 | __start_cc_report 05:58:53 INFO - PROCESS | 2504 | _x_x_mozilla_cycle_collect,1410 05:58:53 INFO - PROCESS | 2504 | __end_cc_report 05:58:53 INFO - PROCESS | 2504 | __startTimestamp1465477133438__endTimestamp 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | ------- Summary: start ------- 05:58:53 INFO - PROCESS | 2504 | Number of tests: 6 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#0] dojo.html Cycles:165 Average:5320.47 Median:5484.51 stddev:602.88 (11.0%) stddev-sans-first:579.12 05:58:53 INFO - PROCESS | 2504 | Values: 3104.4 3105.3 3119.2 3126.6 3166.3 5228.9 5284.9 5304.8 5380.2 5416.6 5283.9 5287.7 5294.3 5318.7 5385.4 4743.4 4806.9 4847.3 4856.0 5008.8 4941.0 4944.4 5006.0 5011.3 5018.6 4721.8 4760.8 4799.3 4869.8 4886.1 4789.9 4806.4 4808.7 4875.9 4970.4 4800.4 4845.7 4847.2 4848.1 4882.9 5200.4 5240.1 5341.4 5345.5 5380.5 5771.8 5776.1 5817.6 5822.4 5825.0 5844.6 5857.1 5858.1 5860.0 5873.5 5203.7 5245.4 5285.3 5288.0 5458.6 5829.0 5887.3 5888.7 5892.4 5895.2 5659.3 5668.5 5670.7 5678.4 5681.3 5531.1 5650.2 5679.7 5683.7 5760.5 5694.1 5718.0 5719.5 5720.5 5721.0 5540.6 5728.7 5740.1 5742.1 5744.3 4318.1 4368.9 4385.5 4399.8 4433.0 3930.8 3932.6 3945.0 3978.7 3990.8 5213.2 5402.7 5436.7 5451.7 5452.7 5656.5 5664.8 5697.3 5764.9 5836.7 5425.9 5430.2 5432.7 5433.8 5434.9 4838.3 4991.9 4993.2 5010.9 5043.5 5863.4 5903.3 5947.1 5998.1 6049.5 5810.6 5811.4 5817.6 5817.7 5821.7 5755.2 5965.9 5970.8 5976.7 5977.3 5597.3 5603.2 5612.0 5664.5 5670.5 5727.5 5766.1 5768.7 5769.3 5769.9 5443.5 5487.1 5548.8 5598.6 5606.5 5552.9 5563.1 5563.7 5566.3 5567.1 5478.4 5481.8 5484.5 5486.3 5489.4 5551.4 5614.7 5619.4 5658.0 5718.5 5344.5 5375.7 5455.1 5462.0 5504.4 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#1] ext.html Cycles:180 Average:62223.38 Median:42046.66 stddev:126403.13 (300.6%) stddev-sans-first:126673.05 05:58:53 INFO - PROCESS | 2504 | Values: 599.8 623.7 633.1 638.9 640.0 31073.1 31587.0 33739.0 33764.0 42419.4 41646.6 46039.0 46166.5 46171.0 46175.0 8819.3 8993.6 8998.1 8999.3 9002.1 8787.8 8875.6 8884.4 8895.4 8898.2 8894.2 8943.3 8945.3 8951.9 8955.4 8855.1 8895.6 8906.8 8909.1 8913.6 8874.4 8944.1 8947.1 8948.2 8955.8 42918.1 43273.8 43299.6 43324.6 43375.1 3314.1 3496.8 3562.6 3596.4 3770.8 32441.5 32650.7 33043.3 33589.0 33790.0 3956.3 4064.8 4107.8 4136.8 4172.5 344324.0 344534.0 345024.0 345550.9 346133.0 46983.8 52040.7 52720.0 53243.2 53340.7 58857.0 58952.0 59010.8 59028.4 59152.4 14834.9 14844.3 14990.9 15031.2 15052.6 10700.8 10749.5 10782.6 10782.9 10790.6 15755.3 16859.0 17108.8 17138.7 17169.7 6227.6 6317.7 6471.4 6612.3 6632.1 991.4 995.6 1000.4 1088.9 1168.5 32753.3 32851.7 32866.3 33065.5 33430.7 1076.2 1093.3 1160.0 1174.3 1201.4 16644.8 17048.3 17078.4 17110.8 17305.4 575370.0 581692.0 585832.0 586483.0 588490.0 58406.7 58729.7 58764.7 58864.0 58880.1 1295.6 1323.6 1338.2 1353.0 1357.8 31025.8 31634.7 31931.8 31948.7 32631.2 51268.7 51429.7 51532.7 52117.0 52117.7 456660.0 469080.0 469180.0 469443.0 471509.0 36140.1 40473.6 41259.8 41736.4 42441.0 48312.0 48455.8 48780.3 49789.5 50152.7 40864.8 41025.0 41300.4 42419.6 42473.6 40805.3 41269.4 41308.6 41653.8 41930.2 41470.0 42163.2 42513.1 42833.4 42879.0 35313.8 36883.3 36888.3 37150.6 37574.0 27929.0 28063.3 28144.0 28216.9 28256.8 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#2] jquery.html Cycles:180 Average:30903.83 Median:2996.31 stddev:91330.11 (3048.1%) stddev-sans-first:91557.56 05:58:53 INFO - PROCESS | 2504 | Values: 380.4 382.8 383.5 395.5 398.6 14827.8 16231.0 17110.1 19978.9 20002.7 18180.1 19270.2 19577.9 19630.9 19674.0 5614.3 5748.1 5799.2 5851.5 5858.6 5608.2 5737.5 5765.5 5771.9 5774.9 5618.2 5654.4 5678.8 5718.5 5725.9 5732.2 5751.1 5765.2 5765.9 5766.3 4952.0 5092.1 5147.7 5154.9 5170.7 22647.5 22908.8 23136.1 23269.2 23282.0 2269.4 2813.9 2934.1 2940.1 3052.5 13824.9 14448.7 14525.9 15014.5 15063.0 1913.9 1936.9 1993.4 2015.8 2080.8 67483.0 78230.0 80621.2 84037.6 84325.6 10679.0 10792.1 10843.8 10994.5 11040.5 14810.1 14871.6 14909.0 14935.5 14967.0 7602.4 7860.8 7923.7 8050.4 8199.7 7393.4 7601.5 7664.2 7714.2 7767.8 6451.0 6521.3 6610.9 6739.2 6743.8 1874.3 1903.0 1946.1 1958.6 1973.6 892.5 964.9 969.4 1005.6 1043.5 17877.6 17950.6 19500.3 19705.9 20230.9 968.3 978.8 985.9 1026.0 1033.4 10681.4 11156.8 11174.3 11180.2 11215.2 547971.0 550314.0 558646.0 561326.0 562912.0 63356.4 82000.1 97484.5 97635.5 100595.5 931.3 988.7 997.0 1037.5 1041.3 17731.1 17823.7 18133.5 18166.7 18335.3 42066.0 42600.0 42754.6 43145.9 44215.6 58876.0 60404.7 60471.7 61033.0 62199.0 7306.0 7893.1 7917.5 8022.2 8050.4 13377.5 13425.6 13671.8 13726.0 13782.7 11835.1 11934.9 11969.3 12137.3 12221.9 11727.6 11793.9 11841.3 11902.6 12292.6 11159.3 11466.2 11762.6 12099.9 12124.2 7815.8 7853.8 7870.4 8030.5 8081.5 10780.4 12002.9 12010.5 12067.5 12239.8 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#3] mootools.html Cycles:180 Average:5907.79 Median:4696.41 stddev:3514.32 (74.8%) stddev-sans-first:3507.32 05:58:53 INFO - PROCESS | 2504 | Values: 1327.9 1445.6 1498.3 1575.8 1778.1 8395.2 8831.0 8834.1 8835.0 9040.5 8451.5 8644.9 8918.8 8931.7 8933.1 2014.6 2275.6 2296.1 2336.4 2348.5 2296.3 2307.4 2308.6 2312.0 2312.2 2063.1 2074.3 2094.0 2096.6 2097.9 1937.4 2192.8 2244.8 2250.8 2259.8 2304.7 2315.9 2334.2 2334.5 2336.0 8979.0 9045.7 9068.8 9074.8 9078.7 5209.4 5329.3 5344.4 5348.3 5348.5 3201.8 3324.2 3390.9 3394.2 3453.9 1083.1 1136.8 1139.9 1177.8 2040.7 12609.4 13118.5 13146.5 13155.7 13159.1 4435.8 4602.0 4659.9 4696.2 4696.6 10777.5 10823.7 10884.6 10886.3 10893.9 5219.1 5226.0 5231.8 5257.6 5271.2 4173.9 4748.0 4871.1 4871.2 4938.2 3825.5 3884.3 3915.7 3952.5 4006.7 1167.4 1193.1 1205.8 1205.9 1220.7 858.3 930.1 933.7 944.5 967.2 5828.0 5872.6 5950.5 5952.9 6082.0 460.1 477.9 478.4 481.0 482.3 3893.9 3989.1 3997.9 4013.6 4049.8 10945.2 11191.8 11343.8 11578.7 11594.7 11435.6 11471.9 11516.7 11555.5 11579.1 8401.8 8591.7 8593.5 8594.7 8598.7 5681.2 5834.7 5906.6 6020.4 6037.3 10168.0 10647.6 10711.2 10793.1 10819.3 10710.1 10892.6 10935.3 11031.0 11032.4 7643.8 7882.8 7893.1 8136.8 8307.6 8602.4 8612.6 8622.7 8681.6 8752.2 7603.6 7887.0 7915.3 7917.0 7923.4 7472.4 7591.3 7746.3 7851.2 7903.2 7225.5 7246.6 7264.1 7280.9 7335.3 4870.4 4995.6 5131.9 5174.3 5178.9 4935.3 5116.0 5117.9 5200.1 5237.3 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#4] prototype.html Cycles:180 Average:4651.79 Median:5302.27 stddev:1368.76 (25.8%) stddev-sans-first:1333.43 05:58:53 INFO - PROCESS | 2504 | Values: 320.0 321.4 327.2 329.6 330.5 5258.0 5301.5 5307.4 5308.4 5355.5 5205.4 5213.2 5235.5 5274.4 5301.2 3935.4 4000.6 4113.8 4123.6 4142.4 4079.7 4105.5 4113.6 4128.0 4149.9 3908.8 4107.2 4121.9 4139.5 4165.6 4072.9 4136.9 4147.9 4154.6 4177.6 3676.8 3682.7 3692.1 3709.9 3710.7 5108.6 5125.4 5143.0 5182.9 5222.4 4515.1 4739.2 4745.2 4761.5 4768.6 5577.5 5586.4 5588.8 5601.3 5613.2 3987.0 3995.8 4017.8 4029.4 4030.9 5544.7 5658.1 5714.9 5719.7 5736.6 4018.1 4025.0 4047.7 4056.7 4063.2 4096.6 4099.7 4103.8 4105.6 4132.3 4595.6 4694.9 4697.5 4699.7 4705.8 5479.9 5492.6 5518.5 5531.6 5549.9 1390.2 1399.8 1408.9 1425.2 1426.6 845.0 868.8 920.2 927.4 959.0 5263.8 5275.6 5277.8 5303.0 5304.5 5585.4 5587.4 5594.3 5613.6 5624.2 5076.1 5227.9 5254.4 5275.7 5286.5 2910.4 2932.6 2940.9 2959.2 2996.7 5702.7 5705.3 5712.3 5715.8 5733.3 5454.8 5694.3 5694.6 5706.5 5749.5 5769.2 5772.9 5789.7 5791.9 5846.8 5397.0 5623.7 5661.2 5707.2 5745.9 5638.7 5642.7 5643.5 5667.2 5674.7 5837.8 5842.3 5881.1 5883.8 5890.9 3906.2 3991.4 4004.7 4007.0 4065.4 5659.0 5731.4 5752.8 5753.1 5755.5 5374.2 5423.6 5546.9 5633.2 5650.9 5568.8 5594.3 5595.7 5605.4 5613.5 5237.8 5469.6 5506.0 5542.5 5566.0 5522.4 5530.8 5554.9 5569.5 5570.5 5409.3 5449.2 5451.6 5461.5 5493.4 05:58:53 INFO - PROCESS | 2504 | 05:58:53 INFO - PROCESS | 2504 | [#5] yui.html Cycles:180 Average:20179.91 Median:4614.68 stddev:28512.48 (617.9%) stddev-sans-first:28554.86 05:58:53 INFO - PROCESS | 2504 | Values: 676.9 699.5 734.1 770.0 779.8 14903.9 15000.1 15315.2 15518.8 15527.7 14533.1 14575.4 14648.4 14696.5 14702.9 663.3 777.8 779.2 793.1 805.6 800.9 802.7 804.7 804.9 805.1 835.4 836.0 837.0 837.2 837.3 694.4 817.4 828.5 838.3 839.3 616.8 617.2 617.2 617.3 617.7 15147.5 15225.5 15230.8 15237.5 15237.9 13981.6 14312.8 14436.9 14451.9 14494.1 12040.3 12104.5 12218.8 12272.9 12460.1 4402.3 4433.1 4447.5 4618.9 4634.4 74720.0 75076.0 77066.0 77771.6 77772.0 11330.4 11462.3 11498.5 11548.5 11609.9 21055.8 21218.4 21224.9 21271.9 21408.0 7594.0 7785.7 7799.1 7847.8 8393.3 4445.2 4465.9 4527.2 4575.9 4660.2 3301.0 3366.9 3382.1 3401.4 3404.7 608.2 615.3 616.5 635.1 638.4 623.3 638.0 671.5 685.2 700.3 9000.9 9655.0 9694.0 9739.5 9754.3 667.5 672.7 684.1 684.7 708.8 4381.6 4397.8 4551.8 4580.1 4610.5 94475.0 97610.5 99210.5 110123.4 111215.0 93080.0 93395.5 93879.0 98346.0 98750.0 84993.2 87458.6 87555.6 88977.0 89139.0 9583.0 9824.9 9926.5 9957.9 9973.6 37247.4 42762.6 49149.0 49700.0 50777.2 67471.0 72227.6 73587.0 73652.6 76297.6 12396.4 12794.2 13114.0 13258.9 13519.5 13310.3 13488.5 14490.6 14503.6 14938.9 12680.9 12852.6 12908.0 13290.2 14046.6 13156.6 13245.8 14014.2 14024.7 14556.9 13596.6 13665.6 13846.5 13869.2 13870.2 10613.6 10883.3 10934.8 10990.8 11588.3 11556.7 11558.3 11703.2 11984.9 11987.8 05:58:53 INFO - PROCESS | 2504 | -------- Summary: end -------- 05:58:53 INFO - PROCESS | 2504 | 05:58:54 INFO - TEST-INFO | 2504: exit 0 05:58:54 INFO - TEST-OK | dromaeo_css | took 1114435ms 05:58:54 INFO - TEST-START | kraken 05:58:54 INFO - operating with platform_type : linux_ 05:58:54 INFO - Initialising browser for kraken test... 05:58:54 INFO - TEST-INFO | started process 2702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjl9Pz/profile http://localhost:52060/getInfo.html) 05:58:58 INFO - PROCESS | 2702 | __metrics Screen width/height:1600/1200 05:58:58 INFO - PROCESS | 2702 | colorDepth:24 05:58:58 INFO - PROCESS | 2702 | Browser inner width/height: 1024/697 05:58:58 INFO - PROCESS | 2702 | __metrics 05:58:59 ERROR - PROCESS | 2702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:58:59 INFO - PROCESS | 2702 | console.error: PushService: 05:58:59 INFO - PROCESS | 2702 | stateChangeProcessEnqueue: Error transitioning state 05:58:59 INFO - PROCESS | 2702 | UnknownError 05:59:00 INFO - TEST-INFO | 2702: exit 0 05:59:00 INFO - Browser initialized. 05:59:00 INFO - Running cycle 1/1 for kraken test... 05:59:00 INFO - TEST-INFO | started process 2849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjl9Pz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:12 INFO - PROCESS | 2849 | RSS: Main: 173142016 05:59:12 INFO - PROCESS | 2849 | 05:59:15 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:15 INFO - PROCESS | 2849 | RSS: Main: 231575552 05:59:15 INFO - PROCESS | 2849 | 05:59:18 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-dft) 05:59:19 INFO - PROCESS | 2849 | RSS: Main: 217452544 05:59:19 INFO - PROCESS | 2849 | 05:59:22 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-fft) 05:59:22 INFO - PROCESS | 2849 | RSS: Main: 285904896 05:59:22 INFO - PROCESS | 2849 | 05:59:25 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-oscillator) 05:59:25 INFO - PROCESS | 2849 | RSS: Main: 196419584 05:59:25 INFO - PROCESS | 2849 | 05:59:27 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:28 INFO - PROCESS | 2849 | RSS: Main: 200740864 05:59:28 INFO - PROCESS | 2849 | 05:59:31 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:32 INFO - PROCESS | 2849 | RSS: Main: 237154304 05:59:32 INFO - PROCESS | 2849 | 05:59:35 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:35 INFO - PROCESS | 2849 | RSS: Main: 237039616 05:59:35 INFO - PROCESS | 2849 | 05:59:38 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52060/tests/kraken/driver.html?testName=json-parse-financial) 05:59:39 INFO - PROCESS | 2849 | RSS: Main: 237473792 05:59:39 INFO - PROCESS | 2849 | 05:59:40 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:41 INFO - PROCESS | 2849 | RSS: Main: 219738112 05:59:41 INFO - PROCESS | 2849 | 05:59:43 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:43 INFO - PROCESS | 2849 | RSS: Main: 224763904 05:59:43 INFO - PROCESS | 2849 | 05:59:45 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:46 INFO - PROCESS | 2849 | RSS: Main: 232796160 05:59:46 INFO - PROCESS | 2849 | 05:59:49 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:49 INFO - PROCESS | 2849 | RSS: Main: 238862336 05:59:49 INFO - PROCESS | 2849 | 05:59:52 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:53 INFO - PROCESS | 2849 | RSS: Main: 238268416 05:59:53 INFO - PROCESS | 2849 | 05:59:54 INFO - PROCESS | 2849 | Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52060/tests/kraken/driver.html?testName=ai-astar) 05:59:55 INFO - PROCESS | 2849 | RSS: Main: 280530944 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | __start_tp_report 05:59:55 INFO - PROCESS | 2849 | _x_x_mozilla_page_load 05:59:55 INFO - PROCESS | 2849 | _x_x_mozilla_page_load_details 05:59:55 INFO - PROCESS | 2849 | |i|pagename|runs| 05:59:55 INFO - PROCESS | 2849 | |0;ai-astar;109;105;110;111;109;111;110;111;111;110 05:59:55 INFO - PROCESS | 2849 | |1;audio-beat-detection;157;124;126;178;125;134;157;125;197;130 05:59:55 INFO - PROCESS | 2849 | |2;audio-dft;160;162;160;162;161;160;161;160;162;161 05:59:55 INFO - PROCESS | 2849 | |3;audio-fft;74;76;77;127;76;85;75;74;102;74 05:59:55 INFO - PROCESS | 2849 | |4;audio-oscillator;84;85;116;86;85;85;122;85;84;137 05:59:55 INFO - PROCESS | 2849 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 05:59:55 INFO - PROCESS | 2849 | |6;imaging-darkroom;147;148;146;146;146;146;147;146;148;146 05:59:55 INFO - PROCESS | 2849 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;95;94 05:59:55 INFO - PROCESS | 2849 | |8;json-parse-financial;54;55;58;55;56;57;56;55;55;55 05:59:55 INFO - PROCESS | 2849 | |9;json-stringify-tinderbox;62;62;62;61;61;61;62;62;62;62 05:59:55 INFO - PROCESS | 2849 | |10;stanford-crypto-aes;82;80;80;81;81;82;81;81;115;80 05:59:55 INFO - PROCESS | 2849 | |11;stanford-crypto-ccm;128;123;124;131;131;129;131;138;122;121 05:59:55 INFO - PROCESS | 2849 | |12;stanford-crypto-pbkdf2;161;162;161;166;164;162;161;161;161;168 05:59:55 INFO - PROCESS | 2849 | |13;stanford-crypto-sha256-iterative;64;66;66;63;62;64;63;63;62;64 05:59:55 INFO - PROCESS | 2849 | __end_tp_report 05:59:55 INFO - PROCESS | 2849 | __start_cc_report 05:59:55 INFO - PROCESS | 2849 | _x_x_mozilla_cycle_collect,1618 05:59:55 INFO - PROCESS | 2849 | __end_cc_report 05:59:55 INFO - PROCESS | 2849 | __startTimestamp1465477195078__endTimestamp 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | ------- Summary: start ------- 05:59:55 INFO - PROCESS | 2849 | Number of tests: 14 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.83 (1.7%) stddev-sans-first:1.92 05:59:55 INFO - PROCESS | 2849 | Values: 109.0 105.0 110.0 111.0 109.0 111.0 110.0 111.0 111.0 110.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:145.50 stddev:25.88 (17.8%) stddev-sans-first:27.10 05:59:55 INFO - PROCESS | 2849 | Values: 157.0 124.0 126.0 178.0 125.0 134.0 157.0 125.0 197.0 130.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 05:59:55 INFO - PROCESS | 2849 | Values: 160.0 162.0 160.0 162.0 161.0 160.0 161.0 160.0 162.0 161.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:17.42 (23.1%) stddev-sans-first:18.10 05:59:55 INFO - PROCESS | 2849 | Values: 74.0 76.0 77.0 127.0 76.0 85.0 75.0 74.0 102.0 74.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:20.06 (23.6%) stddev-sans-first:20.72 05:59:55 INFO - PROCESS | 2849 | Values: 84.0 85.0 116.0 86.0 85.0 85.0 122.0 85.0 84.0 137.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:59:55 INFO - PROCESS | 2849 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 05:59:55 INFO - PROCESS | 2849 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 148.0 146.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:59:55 INFO - PROCESS | 2849 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.09 05:59:55 INFO - PROCESS | 2849 | Values: 54.0 55.0 58.0 55.0 56.0 57.0 56.0 55.0 55.0 55.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:59:55 INFO - PROCESS | 2849 | Values: 62.0 62.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 62.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:10.81 (13.3%) stddev-sans-first:11.44 05:59:55 INFO - PROCESS | 2849 | Values: 82.0 80.0 80.0 81.0 81.0 82.0 81.0 81.0 115.0 80.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:130.00 stddev:5.31 (4.1%) stddev-sans-first:5.63 05:59:55 INFO - PROCESS | 2849 | Values: 128.0 123.0 124.0 131.0 131.0 129.0 131.0 138.0 122.0 121.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.00 stddev:2.50 (1.5%) stddev-sans-first:2.57 05:59:55 INFO - PROCESS | 2849 | Values: 161.0 162.0 161.0 166.0 164.0 162.0 161.0 161.0 161.0 168.0 05:59:55 INFO - PROCESS | 2849 | 05:59:55 INFO - PROCESS | 2849 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 05:59:55 INFO - PROCESS | 2849 | Values: 64.0 66.0 66.0 63.0 62.0 64.0 63.0 63.0 62.0 64.0 05:59:55 INFO - PROCESS | 2849 | -------- Summary: end -------- 05:59:55 INFO - PROCESS | 2849 | 05:59:56 INFO - TEST-INFO | 2849: exit 0 05:59:56 INFO - TEST-OK | kraken | took 61824ms 05:59:56 INFO - SUITE-END | took 1176s 05:59:56 INFO - Completed test suite (00:19:36) 05:59:56 INFO - javascript benchmark 05:59:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.3946430446067, 3105.3168302973336, 3119.189010857177, 3126.6248050233976, 3166.271757495776, 5228.947710522893, 5284.920726189105, 5304.787808487666, 5380.219868119125, 5416.566674666027, 5283.947160528393, 5287.735613219343, 5294.311739473863, 5318.680879147244, 5385.380681221661, 4743.430788305408, 4806.855794326176, 4847.345608342864, 4856.0, 5008.824691135811, 4940.97529512352, 4944.4313903900975, 5005.974970125162, 5011.3485246918035, 5018.573421259197, 4721.787519561611, 4760.8333708320215, 4799.256115302099, 4869.805207791684, 4886.144924638192, 4789.880252993703, 4806.423229212517, 4808.735519546423, 4875.926861097051, 4970.378702662168, 4800.399950006249, 4845.685030473008, 4847.224444088929, 4848.10310092634, 4882.853514394574, 5200.401953775288, 5240.082985477564, 5341.359036915556, 5345.518903298722, 5380.461953804588, 5771.769129234825, 5776.075827867563, 5817.563682723812, 5822.359540450547, 5825.038868586678, 5844.561657875676, 5857.092150716646, 5858.091995740667, 5859.970700146472, 5873.471387575139, 5203.739813009334, 5245.449227831099, 5285.286486324374, 5288.021715982555, 5458.61789674723, 5828.970855145697, 5887.322957859816, 5888.676122813286, 5892.440218179266, 5895.20414744004, 5659.26429564154, 5668.489835914787, 5670.659760414388, 5678.432156784289, 5681.318241811009, 5531.059719847635, 5650.180723795027, 5679.659220446786, 5683.7442315095095, 5760.452756988079, 5694.117411801095, 5718.0, 5719.542436605062, 5720.542356611461, 5720.971395142998, 5540.63985840919, 5728.742206600713, 5740.13897915316, 5742.052561327418, 5744.310682718101, 4318.050028993616, 4368.912621747547, 4385.495667998157, 4399.758013309299, 4432.955670443319, 3930.8034598269974, 3932.5870783567884, 3945.033466800652, 3978.7015973801504, 3990.780507072081, 5213.191955246943, 5402.729863506809, 5436.673799572039, 5451.672899625956, 5452.727363631882, 5656.519195868315, 5664.773409063674, 5697.259356283739, 5764.942350576524, 5836.708164591753, 5425.9186112208345, 5430.212619170198, 5432.674039557639, 5433.809816656398, 5434.945650543523, 4838.274258861128, 4991.925121123186, 4993.151164302078, 5010.924836127461, 5043.470435604208, 5863.413658634103, 5903.321118071391, 5947.1376650385455, 5998.100284957204, 6049.516038716892, 5810.564207684356, 5811.418858114154, 5817.592768506164, 5817.650940943557, 5821.70891455417, 5755.223044889054, 5965.880682386415, 5970.820875373745, 5976.701164941823, 5977.3126090500145, 5597.272354593877, 5603.159526071122, 5612.045952188057, 5664.461876121762, 5670.546356291569, 5727.4845263926445, 5766.077427611562, 5768.711564421846, 5769.278840144982, 5769.8557536061935, 5443.510084092451, 5487.094629386266, 5548.833534993957, 5598.608097433304, 5606.523445507178, 5552.861178470409, 5563.109902415594, 5563.7496312666835, 5566.332040155207, 5567.053600887778, 5478.424765399575, 5481.780728770805, 5484.506394424521, 5486.286782718221, 5489.423610520837, 5551.417101204315, 5614.69119198448, 5619.409961953936, 5658.0, 5718.542516598579, 5344.518993290622, 5375.731213439391, 5455.099908515051, 5462.016836969384, 5504.4495550444635], "value": 5280.227622367826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.757098375158, 623.6538721009838, 633.0504243634548, 638.8881945659508, 640.0303540136694, 31073.06780796577, 31587.0, 33739.0, 33763.99999999997, 42419.363709544305, 41646.58353416465, 46039.0, 46166.53833461664, 46171.0, 46175.0, 8819.338549608789, 8993.595288212013, 8998.14517620825, 8999.280057595377, 9002.144796244347, 8787.824243515126, 8875.644974201057, 8884.378093533454, 8895.421797583169, 8898.199162075412, 8894.155055269739, 8943.284537237038, 8945.284377249804, 8951.865722014143, 8955.417897836653, 8855.114488551159, 8895.555222238927, 8906.777330566723, 8909.064548222408, 8913.598888050054, 8874.378793484459, 8944.060873608307, 8947.105289471066, 8948.194662480408, 8955.776105597348, 42918.14163716739, 43273.78363108164, 43299.56700432987, 43324.566754332365, 43375.13249735019, 3314.055494184146, 3496.825158742078, 3562.5546806649168, 3596.4245720684567, 3770.7926064066464, 32441.513377299358, 32650.673493265, 33043.33913321744, 33589.0, 33790.0, 3956.287868183726, 4064.7764372959477, 4107.794610269475, 4136.751794892316, 4172.4784401949755, 344324.0, 344534.0, 345024.0, 345550.9057182986, 346132.9999999975, 46983.76508117437, 52040.739796300775, 52720.0, 53243.201351979755, 53340.733296334045, 58857.0, 58952.0, 59010.819783604085, 59028.39230273117, 59152.40847591469, 14834.851651483346, 14844.257787110817, 14990.850091499164, 15031.173285469185, 15052.623684407758, 10700.78598428027, 10749.462526873625, 10782.568697252022, 10782.892171078345, 10790.622328218631, 15755.291011904263, 16859.0, 17108.828911710723, 17138.657226855394, 17169.656606867793, 6227.626342419469, 6317.684115794192, 6471.385218404244, 6612.2726500084955, 6632.137822083098, 991.375433476905, 995.6166875752888, 1000.4247557654232, 1088.8532142109311, 1168.5165697039554, 32753.344933101205, 32851.67148328486, 32866.342673146406, 33065.50401743976, 33430.66569334324, 1076.235872530512, 1093.283899046126, 1159.9710007249887, 1174.2543484887158, 1201.4473342262656, 16644.83355166457, 17048.318067277418, 17078.402255920984, 17110.82889171117, 17305.39431119905, 575370.0, 581692.0, 585832.0, 586483.0, 588490.0, 58406.70796645989, 58729.70635146883, 58764.7061764697, 58864.0, 58880.11679824806, 1295.6307452376216, 1323.616151316127, 1338.1703343927022, 1353.0393420671433, 1357.7963305504056, 31025.8448707755, 31634.683653163174, 31931.840340798146, 31948.6805131955, 32631.18422039468, 51268.74365628148, 51429.742851285504, 51532.74233628808, 52117.0, 52117.739411302704, 456660.0, 469080.0, 469180.0, 469443.0, 471509.0, 36140.09649758777, 40473.59526404816, 41259.7937010313, 41736.3739543901, 42441.0, 48312.0, 48455.75772121117, 48780.2682959763, 49789.50210497993, 50152.749236253585, 40864.79567602143, 41025.0, 41300.38049429321, 42419.57580424156, 42473.57526424696, 40805.32782817523, 41269.38095928624, 41308.58691413168, 41653.79173104115, 41930.161396772506, 41470.0, 42163.156736864476, 42513.14973700447, 42833.35749963815, 42879.0, 35313.82343088268, 36883.262334753694, 36888.26223475569, 37150.628493714714, 37574.0, 27929.022484212954, 28063.28043380959, 28143.99714857161, 28216.85891570529, 28256.753062796815], "value": 20047.780216468043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.41796052040377, 382.81050879814495, 383.5205992509363, 395.5056179775281, 398.5695448915172, 14827.77758333626, 16231.0, 17110.14449277536, 19978.90010549947, 20002.69995950062, 18180.09099545021, 19270.22919083235, 19577.902110489427, 19630.901845490753, 19674.0, 5614.2701448811595, 5748.080307150857, 5799.18811366409, 5851.50262227709, 5858.648481091127, 5608.186812912125, 5737.454941780524, 5765.509931655814, 5771.884562308751, 5774.942250577483, 5618.185363122345, 5654.406287339832, 5678.801241956532, 5718.513926316247, 5725.856853578653, 5732.197492351074, 5751.079827227665, 5765.1928729977835, 5765.884682306351, 5766.279215098113, 4952.0, 5092.083424983502, 5147.6654017488745, 5154.948450515484, 5170.689758614495, 22647.547049059092, 22908.770912291, 23136.074557017866, 23269.185578504672, 23282.0, 2269.4326418395403, 2813.887444502238, 2934.11976407077, 2940.0885725425187, 3052.526858336961, 13824.930875345659, 14448.711025779425, 14525.854741452556, 15014.474493392789, 15063.0, 1913.9234430622757, 1936.912838922252, 1993.4219076467807, 2015.828654564364, 2080.781517940625, 67483.0, 78230.0, 80621.19378806255, 84037.57981210116, 84325.57837210836, 10679.0, 10792.136629069655, 10843.78312433747, 10994.450277486094, 11040.503177357039, 14810.11139331622, 14871.553853384416, 14909.0, 14935.477258295907, 14967.0, 7602.353799926957, 7860.842783144305, 7923.6830526778285, 8050.396220283385, 8199.71301004462, 7393.371563417062, 7601.505902116345, 7664.233576642403, 7714.190010048977, 7767.766966990999, 6450.967745161338, 6521.315261897527, 6610.900836487456, 6739.224989126314, 6743.797686069426, 1874.3158747057225, 1902.9524261893287, 1946.1331051568693, 1958.6278607064612, 1973.5756812285429, 892.5180402582532, 964.9083337082966, 969.3602222533235, 1005.6228914157191, 1043.5147656339839, 17877.642447150985, 17950.640987180184, 19500.31748888782, 19705.90147049284, 20230.942264433892, 968.3076600230728, 978.7699890525721, 985.8521221816642, 1026.030401270792, 1033.379972016784, 10681.412522311191, 11156.832647510293, 11174.329540227449, 11180.217384782987, 11215.158863085302, 547971.0, 550314.0, 558646.0, 561326.0, 562912.0, 63356.36643633505, 82000.12999544987, 97484.51257743807, 97635.51182244185, 100595.49702251442, 931.2782593490099, 988.7478692933256, 996.9501524923725, 1037.5382954585136, 1041.3231399590327, 17731.11344432799, 17823.73264401009, 18133.546661333574, 18166.72749908779, 18335.26658933681, 42066.0, 42600.0, 42754.57245427506, 43145.921351966455, 44215.55784442114, 58876.0, 60404.69797650984, 60471.69764151151, 61033.0, 62199.0, 7306.0, 7893.052833659997, 7917.524948503108, 8022.237887400687, 8050.355971522381, 13377.464901403835, 13425.597232083053, 13671.79492307636, 13726.0, 13782.724345513234, 11835.11236657237, 11934.940325298665, 11969.341686207343, 12137.332446715516, 12221.877781222074, 11727.648170554898, 11793.941030294794, 11841.348725820162, 11902.583409580624, 12292.631221063382, 11159.27464714791, 11466.197366184288, 11762.647120586396, 12099.939500302795, 12124.151309408257, 7815.8436831261915, 7853.764387068397, 7870.386570752868, 8030.5181689098845, 8081.4747041442115, 10780.38294255868, 12002.886505586523, 12010.519579217083, 12067.51729930828, 12239.75520489603], "value": 9398.915162859263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.933603319835, 1445.5807815733435, 1498.318265189339, 1575.8109026916773, 1778.0576294563878, 8395.244428001479, 8831.0, 8834.072422395653, 8834.955825220874, 9040.547972601376, 8451.492910425379, 8644.870326945085, 8918.77703057424, 8931.732048038553, 8933.106689331064, 2014.6071516054376, 2275.567642147995, 2296.0586159674494, 2336.4275752440676, 2348.495073559184, 2296.2881506732965, 2307.3654744945106, 2308.572914010905, 2312.0, 2312.2022902098834, 2063.1128614695676, 2074.284371891695, 2094.0262777808316, 2096.622607930572, 2097.947551311222, 1937.3994061840804, 2192.8136108430645, 2244.8316376271846, 2250.797428231467, 2259.807916327114, 2304.665823455606, 2315.8842057897036, 2334.1947028275217, 2334.48641298914, 2336.0188720737333, 8979.0, 9045.728628141167, 9068.773280668036, 9074.818503629956, 9078.727638170865, 5209.374875014984, 5329.25390445338, 5344.412114667383, 5348.251244825728, 5348.465153484659, 3201.807891526516, 3324.16895776056, 3390.932181356384, 3394.2362968332172, 3453.930921381558, 1083.063150374928, 1136.8351589019546, 1139.8632164140356, 1177.8174382970653, 2040.7347044884218, 12609.432575534123, 13118.47526098955, 13146.539871104562, 13155.736885262337, 13159.07886447949, 4435.822567097344, 4601.976990115028, 4659.930101048487, 4696.178168820443, 4696.647751418657, 10777.515011824487, 10823.729406764895, 10884.61903833362, 10886.29239099456, 10893.945530272298, 5219.060569097523, 5226.033183860998, 5231.843044708665, 5257.553107985864, 5271.182966640177, 4173.874783756492, 4748.0, 4871.074495845849, 4871.244957031666, 4938.234573641092, 3825.5218097737784, 3884.320243957296, 3915.7454765440157, 3952.505936757905, 4006.659433948147, 1167.4279602994472, 1193.1051711216587, 1205.7528206717777, 1205.8552973643218, 1220.664317312746, 858.2533196119416, 930.0559931669361, 933.7245512573807, 944.4852555357347, 967.2455484721928, 5828.0, 5872.588918775645, 5950.494207992369, 5952.851178720567, 6081.996470582393, 460.11198387112523, 477.85903158568306, 478.38049725605424, 480.9903801923942, 482.312704396234, 3893.863714770026, 3989.122393073519, 3997.920041599152, 4013.618706222904, 4049.797510124541, 10945.233833631728, 11191.776164476827, 11343.829842552368, 11578.71053223676, 11594.710132246593, 11435.59975400857, 11471.942640286745, 11516.712082197844, 11555.480003399867, 11579.13156513248, 8401.789955251168, 8591.6992905248, 8593.52735599548, 8594.742157735278, 8598.656053757779, 5681.176229446624, 5834.716362400265, 5906.645601263938, 6020.397960203944, 6037.305709843425, 10168.0, 10647.574097036031, 10711.196660250356, 10793.082587979796, 10819.296745711503, 10710.089642380484, 10892.564297428014, 10935.28920620157, 11031.0, 11032.393218372745, 7643.770686879402, 7882.802929926797, 7893.131755506774, 8136.75589732309, 8307.584620769057, 8602.39783215169, 8612.569371531523, 8622.655093796178, 8681.609327580149, 8752.21230089295, 7603.581803000667, 7886.960565197137, 7915.287624113857, 7916.960415197887, 7923.445358824827, 7472.439567032386, 7591.316781489692, 7746.264104910025, 7851.175626559129, 7903.170167132598, 7225.494215404871, 7246.60143692102, 7264.091988501437, 7280.9271907280245, 7335.266473352622, 4870.391201099863, 4995.600351971761, 5131.87170320745, 5174.301469301596, 5178.922316165336, 4935.333729946411, 5116.0, 5117.897642047213, 5200.089984252816, 5237.319148510669], "value": 4587.697007717142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.99200019999495, 321.3829447460875, 327.19510005386746, 329.59295270341124, 330.5141442080143, 5258.0, 5301.549368303698, 5307.36311642603, 5308.389535203452, 5355.518003379695, 5205.375354957401, 5213.165893457048, 5235.450277720842, 5274.393444753845, 5301.151815709487, 3935.449037134796, 4000.5999400059904, 4113.794310284488, 4123.6083071818275, 4142.399352093945, 4079.7348172368847, 4105.460452330376, 4113.56807535209, 4128.02991297045, 4149.91700165998, 3908.8045597720143, 4107.199096176232, 4121.938170927424, 4139.482564679415, 4165.5834416558255, 4072.857449989251, 4136.937945930828, 4147.937780933288, 4154.605312495339, 4177.603127702863, 3676.8161591920566, 3682.6869716074166, 3692.1170203196293, 3709.925801483982, 3710.7402481826284, 5108.565771909392, 5125.38495380553, 5143.0, 5182.922256166161, 5222.4255331913455, 4515.05183911379, 4739.241721324572, 4745.16959532084, 4761.4524329701835, 4768.61851051915, 5577.498025177713, 5586.35756887959, 5588.832335029955, 5601.271834661468, 5613.2422123013275, 3986.960130398688, 3995.7802320872343, 4017.799110044515, 4029.37544680575, 4030.858919937788, 5544.667319960775, 5658.104534980786, 5714.885702285973, 5719.656820590778, 5736.598438109334, 4018.0758425562285, 4024.95351208682, 4047.696422768245, 4056.7363121397016, 4063.22798668258, 4096.569860164699, 4099.692523060782, 4103.7948102594755, 4105.58944105593, 4132.33882578792, 4595.609373203315, 4694.929576056362, 4697.530246975275, 4699.694519856198, 4705.835295764632, 5479.890402191933, 5492.615516913777, 5518.475744804237, 5531.557475401958, 5549.916751248735, 1390.2214759734582, 1399.7760358342616, 1408.9225092620004, 1425.209009000015, 1426.5577670922048, 844.9788755281044, 868.7828042989253, 920.1672486399818, 927.355487935878, 958.9760255993656, 5263.763130659129, 5275.577953763766, 5277.8416647500635, 5303.0, 5304.549113325411, 5585.413531579207, 5587.351731239294, 5594.328680558359, 5613.550915926716, 5624.21261023457, 5076.0863044652315, 5227.921581176285, 5254.4220135785035, 5275.709835958983, 5286.524212820865, 2910.359720861407, 2932.563044108414, 2940.9264768380963, 2959.1714319990438, 2996.711414091918, 5702.714864256854, 5705.286839145107, 5712.314522257273, 5715.771369145187, 5733.283339582552, 5454.809081682201, 5694.259746233046, 5694.629849059798, 5706.543476521868, 5749.453801888814, 5769.221155144086, 5772.884542309214, 5789.681567513827, 5791.884162316815, 5846.766129354948, 5396.9730151348995, 5623.718814059363, 5661.207430959586, 5707.20099186106, 5745.91381129275, 5638.746256418389, 5642.6614403135945, 5643.492085712305, 5667.234923285304, 5674.744636491285, 5837.824865254049, 5842.328132264844, 5881.147233651182, 5883.764169615519, 5890.9116363253725, 3906.2187562487047, 3991.381335892941, 4004.6796256298844, 4006.979965100156, 4065.390191471303, 5659.0, 5731.420860612824, 5752.798652047159, 5753.1370294456165, 5755.510781583613, 5374.220737992891, 5423.647462914898, 5546.916796247979, 5633.211350410864, 5650.858728531655, 5568.805091821767, 5594.272744543184, 5595.720213989202, 5605.411431799603, 5613.46672066153, 5237.816676416307, 5469.589780766538, 5506.0, 5542.473465020817, 5565.972170139124, 5522.420145884625, 5530.834074977757, 5554.91667624994, 5569.54939826475, 5570.470805273655, 5409.323834520685, 5449.23710680513, 5451.591130665137, 5461.453854614507, 5493.423190564933], "value": 4210.563202039702, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.9289224631415, 699.4563631237107, 734.0897287363671, 769.9846003079936, 779.8089468080321, 14903.925480372596, 15000.09999400034, 15315.157666328347, 15518.844811551868, 15527.689446211069, 14533.128012319268, 14575.416983320682, 14648.414063437476, 14696.485623003196, 14702.926485367558, 663.2969052804019, 777.7705576854842, 779.1935346915928, 793.1275596843484, 805.5730462854667, 800.8958835351397, 802.6588699802589, 804.6660635836121, 804.8873157757919, 805.1304591041661, 835.4277320035765, 835.9749207523754, 836.995815020924, 837.2172019162073, 837.2924878477677, 694.3542505469911, 817.3951276055706, 828.4656396624174, 838.337713206566, 839.2991851803752, 616.8334549671608, 617.2099712368176, 617.2253821454046, 617.3178637605471, 617.6695467924638, 15147.469838555598, 15225.543233703007, 15230.847691523053, 15237.466688665843, 15237.923810380877, 13981.580552583438, 14312.785308220386, 14436.855631443656, 14451.927740361336, 14494.130352178903, 12040.277583345027, 12104.515819367303, 12218.75562488754, 12272.938635306855, 12460.065495087814, 4402.25161722508, 4433.069055498349, 4447.466304043503, 4618.861434156947, 4634.374359461463, 74720.0, 75076.0, 77066.0, 77771.6111419445, 77772.0, 11330.433478326215, 11462.254953428, 11498.482568284448, 11548.538058477734, 11609.883901161049, 21055.789442105382, 21218.363449096552, 21224.893875530524, 21271.89364053201, 21408.0, 7594.0, 7785.688572457151, 7799.103103143211, 7847.84304313922, 8393.286570641441, 4445.155420470101, 4465.910681786411, 4527.2303708369, 4575.9084818303445, 4660.161170989254, 3300.950485742716, 3366.882159124419, 3382.0530251529613, 3401.40475416806, 3404.7105995990123, 608.248812716295, 615.2954866677629, 616.5499185594541, 635.1330433957614, 638.4381744065286, 623.2645478335608, 638.0493065332621, 671.5131529640971, 685.1606781692387, 700.2892064554482, 9000.909990900138, 9655.0, 9694.0, 9739.513024348755, 9754.268429867789, 667.5360624366116, 672.744357144282, 684.117488439907, 684.7192651013061, 708.7767353283699, 4381.583749543788, 4397.802098905557, 4551.817927282872, 4580.106879158532, 4610.492054565415, 94475.0, 97610.51194743981, 99210.5039474798, 110123.44938275257, 111215.0, 93080.0, 93395.53302233445, 93879.0, 98346.0, 98750.0, 84993.15006849976, 87458.56270718733, 87555.56222218975, 88977.0, 89139.0, 9583.0, 9824.901750982684, 9926.503674816086, 9957.900420995697, 9973.551190196313, 37247.441288380156, 42762.57237427586, 49149.0, 49700.0, 50777.23834142565, 67471.0, 72227.63886180536, 73587.0, 73652.63173684098, 76297.6185119093, 12396.442160102637, 12794.168379055332, 13114.0, 13258.933705331412, 13519.526816561372, 13310.334483275603, 13488.460461581426, 14490.637734056732, 14503.564893053226, 14938.925305373403, 12680.936595316964, 12852.636412642123, 12908.0, 13290.20258784476, 14046.578602641937, 13156.60530184096, 13245.80131298012, 14014.159150451005, 14024.719505610035, 14556.85443145555, 13596.59210223695, 13665.556375531172, 13846.515371961934, 13869.237191954137, 13870.237136957565, 10613.628523001658, 10883.346999180074, 10934.78130437371, 10990.780184396108, 11588.304701717923, 11556.711082222675, 11558.30650160993, 11703.156380947727, 11984.880151198726, 11987.76024479523], "value": 7434.935266527309, "unit": "score"}], "name": "dromaeo_css", "value": 7230.624153992319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 110.0, 111.0, 109.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 126.0, 178.0, 125.0, 134.0, 157.0, 125.0, 197.0, 130.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 127.0, 76.0, 85.0, 75.0, 74.0, 102.0, 74.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 86.0, 85.0, 85.0, 122.0, 85.0, 84.0, 137.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 55.0, 56.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 81.0, 81.0, 82.0, 81.0, 81.0, 115.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 124.0, 131.0, 131.0, 129.0, 131.0, 138.0, 122.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 166.0, 164.0, 162.0, 161.0, 161.0, 161.0, 168.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 63.0, 62.0, 64.0, 63.0, 63.0, 62.0, 64.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1510.7, "alertThreshold": 2.0}]} 05:59:56 INFO - Return code: 0 05:59:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:56 ERROR - # TBPL SUCCESS # 05:59:56 INFO - Running post-action listener: _resource_record_post_action 05:59:56 INFO - ##### 05:59:56 INFO - ##### Finished run-tests step (success) 05:59:56 INFO - ##### 05:59:56 INFO - Running post-run listener: _resource_record_post_run 05:59:56 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549371904; Read time: 12; Write time: 474564 05:59:56 INFO - TinderboxPrint: CPU usage
13.2% 05:59:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:59:56 INFO - TinderboxPrint: I/O write bytes / time
549,371,904 / 474,564 05:59:56 INFO - TinderboxPrint: CPU idle
8,272.9 (86.8%) 05:59:56 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 05:59:56 INFO - TinderboxPrint: Swap in / out
0 / 0 05:59:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258035712; Read time: 0; Write time: 293380 05:59:56 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291336192; Read time: 12; Write time: 181184 05:59:56 INFO - Running post-run listener: _upload_blobber_files 05:59:56 INFO - Blob upload gear active. 05:59:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:59:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:58 INFO - (blobuploader) - INFO - Done attempting. 05:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:02 INFO - (blobuploader) - INFO - Done attempting. 06:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:03 INFO - (blobuploader) - INFO - Done attempting. 06:00:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:03 INFO - Return code: 0 06:00:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d48e01cee1806a45e995981af2b8951eeedd21fe75807be8f4890833c28afa502858e000974ac64b074a5314674228d339fc6058bf4db984cc78e9a1ea9aea70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/076265bd0b5830025dbdd5999015e77d32cbde7f3d521802de527143746efe1c9ee317aef61323cb5297fe966abbe872fd13eb8940c2935e8c5c54ed8e9f74b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f03c7f44ebed8b6f23302cf1a5f676718c8bb855f96f46bc7dd1ec80d93c83268141549464716db797047038bf1926fa58c053349f8fcfea5f71b6ca62c435"} 06:00:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:03 INFO - Contents: 06:00:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d48e01cee1806a45e995981af2b8951eeedd21fe75807be8f4890833c28afa502858e000974ac64b074a5314674228d339fc6058bf4db984cc78e9a1ea9aea70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/076265bd0b5830025dbdd5999015e77d32cbde7f3d521802de527143746efe1c9ee317aef61323cb5297fe966abbe872fd13eb8940c2935e8c5c54ed8e9f74b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f03c7f44ebed8b6f23302cf1a5f676718c8bb855f96f46bc7dd1ec80d93c83268141549464716db797047038bf1926fa58c053349f8fcfea5f71b6ca62c435"} 06:00:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:03 INFO - Copying logs to upload dir... 06:00:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.908752 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-09 06:00:03.559417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:00:03.568035) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d48e01cee1806a45e995981af2b8951eeedd21fe75807be8f4890833c28afa502858e000974ac64b074a5314674228d339fc6058bf4db984cc78e9a1ea9aea70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/076265bd0b5830025dbdd5999015e77d32cbde7f3d521802de527143746efe1c9ee317aef61323cb5297fe966abbe872fd13eb8940c2935e8c5c54ed8e9f74b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f03c7f44ebed8b6f23302cf1a5f676718c8bb855f96f46bc7dd1ec80d93c83268141549464716db797047038bf1926fa58c053349f8fcfea5f71b6ca62c435"} build_url:https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d48e01cee1806a45e995981af2b8951eeedd21fe75807be8f4890833c28afa502858e000974ac64b074a5314674228d339fc6058bf4db984cc78e9a1ea9aea70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/076265bd0b5830025dbdd5999015e77d32cbde7f3d521802de527143746efe1c9ee317aef61323cb5297fe966abbe872fd13eb8940c2935e8c5c54ed8e9f74b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f03c7f44ebed8b6f23302cf1a5f676718c8bb855f96f46bc7dd1ec80d93c83268141549464716db797047038bf1926fa58c053349f8fcfea5f71b6ca62c435"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:00:03.595697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:00:03.596072) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465474674.111546-1653912648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:00:03.678243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:00:03.678591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:00:03.678937) ========= ========= Total master_lag: 0.22 =========