builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1466179116.27 results: success (0) buildid: 20160617061051 builduid: ea1893d8d521470eb1151cd91e22136f revision: 53826630a9c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.269505) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.269922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.270205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.299610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.299873) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 08:58:36-- 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% 46.7M=0s 2016-06-17 08:58:36 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.475924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.476234) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016735 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.529166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:36.532553) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 53826630a9c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 53826630a9c1 --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=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 08:58:36,832 Setting DEBUG logging. 2016-06-17 08:58:36,832 attempt 1/10 2016-06-17 08:58:36,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/53826630a9c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 08:58:37,135 unpacking tar archive at: mozilla-inbound-53826630a9c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:37.187408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:37.187726) ========= script_repo_revision: 53826630a9c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:37.188081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:37.188355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:58:37.199119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-17 08:58:37.199393) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:58:37 INFO - MultiFileLogger online at 20160617 08:58:37 in /builds/slave/test 08:58:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:58:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:37 INFO - {'append_to_log': False, 08:58:37 INFO - 'base_work_dir': '/builds/slave/test', 08:58:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:58:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:37 INFO - 'branch': 'Mozilla-Inbound', 08:58:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:37 INFO - 'config_files': ('talos/linux_config.py',), 08:58:37 INFO - 'default_actions': ('clobber', 08:58:37 INFO - 'read-buildbot-config', 08:58:37 INFO - 'download-and-extract', 08:58:37 INFO - 'populate-webroot', 08:58:37 INFO - 'create-virtualenv', 08:58:37 INFO - 'install', 08:58:37 INFO - 'run-tests'), 08:58:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:37 INFO - 'download_minidump_stackwalk': True, 08:58:37 INFO - 'download_symbols': 'ondemand', 08:58:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:37 INFO - 'installer_path': 'installer.exe', 08:58:37 INFO - 'log_level': 'info', 08:58:37 INFO - 'log_name': 'talos', 08:58:37 INFO - 'log_to_console': True, 08:58:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:58:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:58:37 INFO - 'opt_config_files': (), 08:58:37 INFO - 'pip_index': False, 08:58:37 INFO - 'sps_profile': False, 08:58:37 INFO - 'sps_profile_interval': 0, 08:58:37 INFO - 'suite': 'dromaeojs-e10s', 08:58:37 INFO - 'system_bits': '32', 08:58:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:37 INFO - 'title': 'talos-linux64-ix-023', 08:58:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:37 INFO - 'use_talos_json': True, 08:58:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:37 INFO - 'work_dir': 'build'} 08:58:37 INFO - ##### 08:58:37 INFO - ##### Running clobber step. 08:58:37 INFO - ##### 08:58:37 INFO - Running pre-action listener: _resource_record_pre_action 08:58:37 INFO - Running main action method: clobber 08:58:37 INFO - rmtree: /builds/slave/test/build 08:58:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:38 INFO - Running post-action listener: _resource_record_post_action 08:58:38 INFO - ##### 08:58:38 INFO - ##### Finished clobber step (success) 08:58:38 INFO - ##### 08:58:38 INFO - ##### 08:58:38 INFO - ##### Running read-buildbot-config step. 08:58:38 INFO - ##### 08:58:38 INFO - Running pre-action listener: _resource_record_pre_action 08:58:38 INFO - Running main action method: read_buildbot_config 08:58:38 INFO - Using buildbot properties: 08:58:38 INFO - { 08:58:38 INFO - "project": "", 08:58:38 INFO - "product": "firefox", 08:58:38 INFO - "script_repo_revision": "production", 08:58:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:58:38 INFO - "repository": "", 08:58:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 08:58:38 INFO - "buildid": "20160617061051", 08:58:38 INFO - "pgo_build": "True", 08:58:38 INFO - "basedir": "/builds/slave/test", 08:58:38 INFO - "buildnumber": 1169, 08:58:38 INFO - "slavename": "talos-linux64-ix-023", 08:58:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:58:38 INFO - "platform": "ubuntu64_hw", 08:58:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 08:58:38 INFO - "branch": "mozilla-inbound", 08:58:38 INFO - "repo_path": "integration/mozilla-inbound", 08:58:38 INFO - "revision": "53826630a9c1", 08:58:38 INFO - "stage_platform": "linux64-pgo", 08:58:38 INFO - "builduid": "ea1893d8d521470eb1151cd91e22136f", 08:58:38 INFO - "slavebuilddir": "test" 08:58:38 INFO - } 08:58:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:58:38 INFO - Running post-action listener: _resource_record_post_action 08:58:38 INFO - ##### 08:58:38 INFO - ##### Finished read-buildbot-config step (success) 08:58:38 INFO - ##### 08:58:38 INFO - ##### 08:58:38 INFO - ##### Running download-and-extract step. 08:58:38 INFO - ##### 08:58:38 INFO - Running pre-action listener: _resource_record_pre_action 08:58:38 INFO - Running main action method: download_and_extract 08:58:38 INFO - mkdir: /builds/slave/test/build/tests 08:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:38 INFO - https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:51 INFO - Downloaded 1361 bytes. 08:58:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:58:51 INFO - Using the following test package requirements: 08:58:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:58:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:58:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:58:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'jsshell-linux-x86_64.zip'], 08:58:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:58:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:58:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:58:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:58:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:58:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:58:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:51 INFO - https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:55 INFO - Downloaded 24221412 bytes. 08:58:55 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'] 08:58:55 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 08:58:57 INFO - Return code: 0 08:58:57 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 08:58: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')]} 08:58:57 INFO - https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:58:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:58:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:58:58 INFO - Downloaded 24221412 bytes. 08:58:58 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'] 08:58:58 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 08:59:00 INFO - Return code: 0 08:59:00 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')]} 08:59:00 INFO - https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:59:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:59:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:59:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:59:01 INFO - Downloaded 14405384 bytes. 08:59:01 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'] 08:59:01 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 08:59:01 INFO - Return code: 0 08:59:01 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')]} 08:59:01 INFO - https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/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 08:59:04 INFO - Downloaded 59437769 bytes. 08:59:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:59:04 INFO - mkdir: /builds/slave/test/properties 08:59:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:04 INFO - Contents: 08:59:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:59:04 INFO - Running post-action listener: _resource_record_post_action 08:59:04 INFO - Running post-action listener: set_extra_try_arguments 08:59:04 INFO - ##### 08:59:04 INFO - ##### Finished download-and-extract step (success) 08:59:04 INFO - ##### 08:59:04 INFO - ##### 08:59:04 INFO - ##### Running populate-webroot step. 08:59:04 INFO - ##### 08:59:04 INFO - Running pre-action listener: _resource_record_pre_action 08:59:04 INFO - Running main action method: populate_webroot 08:59:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:05 INFO - '--tppagecycles', 08:59:05 INFO - '7'], 08:59:05 INFO - 'tests': ['tsvgm']}}, 08:59:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['damp', 'tps']}, 08:59:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'tests': ['damp', 'tps']}, 08:59:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['dromaeo_dom']}, 08:59:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['basic_compositor_video']}, 08:59:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['a11yr', 08:59:05 INFO - 'ts_paint', 08:59:05 INFO - 'tpaint', 08:59:05 INFO - 'sessionrestore', 08:59:05 INFO - 'sessionrestore_no_auto_restore', 08:59:05 INFO - 'tabpaint']}, 08:59:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['tsvgx', 08:59:05 INFO - 'tsvgr_opacity', 08:59:05 INFO - 'tart', 08:59:05 INFO - 'tscrollx', 08:59:05 INFO - 'cart']}, 08:59:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:05 INFO - 'tsvgr_opacity', 08:59:05 INFO - 'tart', 08:59:05 INFO - 'tscrollx', 08:59:05 INFO - 'cart']}, 08:59:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'talos_options': ['--disable-e10s'], 08:59:05 INFO - 'tests': ['tp5o']}, 08:59:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'tests': ['tp5o']}, 08:59:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'talos_options': ['--disable-e10s', 08:59:05 INFO - '--xperf_path', 08:59:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:05 INFO - 'tests': ['tp5n']}, 08:59:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:05 INFO - 'talos_options': ['--xperf_path', 08:59:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:05 INFO - 'tests': ['tp5n']}}, 08:59:05 INFO - 'talos.zip': {'path': '', 08:59:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:05 INFO - Running post-action listener: _resource_record_post_action 08:59:05 INFO - ##### 08:59:05 INFO - ##### Finished populate-webroot step (success) 08:59:05 INFO - ##### 08:59:05 INFO - ##### 08:59:05 INFO - ##### Running create-virtualenv step. 08:59:05 INFO - ##### 08:59:05 INFO - Running pre-action listener: _resource_record_pre_action 08:59:05 INFO - Running main action method: create_virtualenv 08:59:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:05 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 08:59:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:05 INFO - Using real prefix '/usr' 08:59:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:07 INFO - Installing pip.................done. 08:59:07 INFO - Return code: 0 08:59:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:07 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 08:59:07 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 08:59:07 INFO - Using env: {'DISPLAY': ':0', 08:59:07 INFO - 'HOME': '/home/cltbld', 08:59:07 INFO - 'LANG': 'en_US.UTF-8', 08:59:07 INFO - 'LANGUAGE': 'en_US:en', 08:59:07 INFO - 'LOGNAME': 'cltbld', 08:59:07 INFO - 'MAIL': '/var/mail/cltbld', 08:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:07 INFO - 'MOZ_NO_REMOTE': '1', 08:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:07 INFO - 'NO_EM_RESTART': '1', 08:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:07 INFO - 'PWD': '/builds/slave/test', 08:59:07 INFO - 'SHELL': '/bin/bash', 08:59:07 INFO - 'SHLVL': '1', 08:59:07 INFO - 'TERM': 'linux', 08:59:07 INFO - 'TMOUT': '86400', 08:59:07 INFO - 'USER': 'cltbld', 08:59:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:07 INFO - '_': '/tools/buildbot/bin/python'} 08:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:07 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 08:59:07 INFO - Cleaning up... 08:59:07 INFO - Return code: 0 08:59:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:07 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 08:59:07 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 08:59:07 INFO - Using env: {'DISPLAY': ':0', 08:59:07 INFO - 'HOME': '/home/cltbld', 08:59:07 INFO - 'LANG': 'en_US.UTF-8', 08:59:07 INFO - 'LANGUAGE': 'en_US:en', 08:59:07 INFO - 'LOGNAME': 'cltbld', 08:59:07 INFO - 'MAIL': '/var/mail/cltbld', 08:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:07 INFO - 'MOZ_NO_REMOTE': '1', 08:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:07 INFO - 'NO_EM_RESTART': '1', 08:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:07 INFO - 'PWD': '/builds/slave/test', 08:59:07 INFO - 'SHELL': '/bin/bash', 08:59:07 INFO - 'SHLVL': '1', 08:59:07 INFO - 'TERM': 'linux', 08:59:07 INFO - 'TMOUT': '86400', 08:59:07 INFO - 'USER': 'cltbld', 08:59:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:07 INFO - '_': '/tools/buildbot/bin/python'} 08:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:08 INFO - Downloading/unpacking psutil>=3.1.1 08:59:08 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 08:59:08 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 08:59:08 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 08:59:08 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 08:59:08 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 08:59:08 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 08:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:09 INFO - Installing collected packages: psutil 08:59:09 INFO - Running setup.py install for psutil 08:59:10 INFO - building 'psutil._psutil_linux' extension 08:59:10 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 08:59:10 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 08:59:10 INFO - building 'psutil._psutil_posix' extension 08:59:10 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 08:59:10 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 08:59:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:10 INFO - Successfully installed psutil 08:59:10 INFO - Cleaning up... 08:59:10 INFO - Return code: 0 08:59:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59:10 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')]} 08:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:10 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')]} 08:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:10 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:10 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 08:59:10 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 08:59:10 INFO - Using env: {'DISPLAY': ':0', 08:59:10 INFO - 'HOME': '/home/cltbld', 08:59:10 INFO - 'LANG': 'en_US.UTF-8', 08:59:10 INFO - 'LANGUAGE': 'en_US:en', 08:59:10 INFO - 'LOGNAME': 'cltbld', 08:59:10 INFO - 'MAIL': '/var/mail/cltbld', 08:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:10 INFO - 'MOZ_NO_REMOTE': '1', 08:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:10 INFO - 'NO_EM_RESTART': '1', 08:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:10 INFO - 'PWD': '/builds/slave/test', 08:59:10 INFO - 'SHELL': '/bin/bash', 08:59:10 INFO - 'SHLVL': '1', 08:59:10 INFO - 'TERM': 'linux', 08:59:10 INFO - 'TMOUT': '86400', 08:59:10 INFO - 'USER': 'cltbld', 08:59:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:10 INFO - '_': '/tools/buildbot/bin/python'} 08:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:12 INFO - Installing collected packages: mozsystemmonitor 08:59:12 INFO - Running setup.py install for mozsystemmonitor 08:59:12 INFO - Successfully installed mozsystemmonitor 08:59:12 INFO - Cleaning up... 08:59:12 INFO - Return code: 0 08:59:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59:12 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')]} 08:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:12 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')]} 08:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:12 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:12 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 08:59:12 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 08:59:12 INFO - Using env: {'DISPLAY': ':0', 08:59:12 INFO - 'HOME': '/home/cltbld', 08:59:12 INFO - 'LANG': 'en_US.UTF-8', 08:59:12 INFO - 'LANGUAGE': 'en_US:en', 08:59:12 INFO - 'LOGNAME': 'cltbld', 08:59:12 INFO - 'MAIL': '/var/mail/cltbld', 08:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:12 INFO - 'MOZ_NO_REMOTE': '1', 08:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:12 INFO - 'NO_EM_RESTART': '1', 08:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:12 INFO - 'PWD': '/builds/slave/test', 08:59:12 INFO - 'SHELL': '/bin/bash', 08:59:12 INFO - 'SHLVL': '1', 08:59:12 INFO - 'TERM': 'linux', 08:59:12 INFO - 'TMOUT': '86400', 08:59:12 INFO - 'USER': 'cltbld', 08:59:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:12 INFO - '_': '/tools/buildbot/bin/python'} 08:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59:14 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 08:59:14 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 08:59:14 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 08:59:14 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 08:59:14 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 08:59:14 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 08:59:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:15 INFO - warning: no files found matching '*.txt' 08:59:15 INFO - no previously-included directories found matching 'build' 08:59:15 INFO - no previously-included directories found matching 'dist' 08:59:15 INFO - no previously-included directories found matching '.git*' 08:59:15 INFO - Installing collected packages: jsonschema, functools32 08:59:15 INFO - Running setup.py install for functools32 08:59:15 INFO - warning: no files found matching '*.txt' 08:59:15 INFO - no previously-included directories found matching 'build' 08:59:15 INFO - no previously-included directories found matching 'dist' 08:59:15 INFO - no previously-included directories found matching '.git*' 08:59:15 INFO - Successfully installed jsonschema functools32 08:59:15 INFO - Cleaning up... 08:59:15 INFO - Return code: 0 08:59:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:15 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:15 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 08:59:15 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 08:59:15 INFO - Using env: {'DISPLAY': ':0', 08:59:15 INFO - 'HOME': '/home/cltbld', 08:59:15 INFO - 'LANG': 'en_US.UTF-8', 08:59:15 INFO - 'LANGUAGE': 'en_US:en', 08:59:15 INFO - 'LOGNAME': 'cltbld', 08:59:15 INFO - 'MAIL': '/var/mail/cltbld', 08:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:15 INFO - 'MOZ_NO_REMOTE': '1', 08:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:15 INFO - 'NO_EM_RESTART': '1', 08:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:15 INFO - 'PWD': '/builds/slave/test', 08:59:15 INFO - 'SHELL': '/bin/bash', 08:59:15 INFO - 'SHLVL': '1', 08:59:15 INFO - 'TERM': 'linux', 08:59:15 INFO - 'TMOUT': '86400', 08:59:15 INFO - 'USER': 'cltbld', 08:59:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:15 INFO - '_': '/tools/buildbot/bin/python'} 08:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:15 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 08:59:15 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 08:59:15 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 08:59:15 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 08:59:15 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 08:59:15 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 08:59:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:17 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 08:59:18 INFO - Downloading docopt-0.6.1.tar.gz 08:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:18 INFO - Running setup.py install for blobuploader 08:59:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:18 INFO - Running setup.py install for requests 08:59:18 INFO - Running setup.py install for docopt 08:59:18 INFO - Successfully installed blobuploader requests docopt 08:59:18 INFO - Cleaning up... 08:59:18 INFO - Return code: 0 08:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:18 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:18 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 08:59:18 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 08:59:18 INFO - Using env: {'DISPLAY': ':0', 08:59:18 INFO - 'HOME': '/home/cltbld', 08:59:18 INFO - 'LANG': 'en_US.UTF-8', 08:59:18 INFO - 'LANGUAGE': 'en_US:en', 08:59:18 INFO - 'LOGNAME': 'cltbld', 08:59:18 INFO - 'MAIL': '/var/mail/cltbld', 08:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:18 INFO - 'MOZ_NO_REMOTE': '1', 08:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:18 INFO - 'NO_EM_RESTART': '1', 08:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:18 INFO - 'PWD': '/builds/slave/test', 08:59:18 INFO - 'SHELL': '/bin/bash', 08:59:18 INFO - 'SHLVL': '1', 08:59:18 INFO - 'TERM': 'linux', 08:59:18 INFO - 'TMOUT': '86400', 08:59:18 INFO - 'USER': 'cltbld', 08:59:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:18 INFO - '_': '/tools/buildbot/bin/python'} 08:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:19 INFO - Running setup.py (path:/tmp/pip-KRIVu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:19 INFO - Running setup.py (path:/tmp/pip-7AOBPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:19 INFO - Running setup.py (path:/tmp/pip-YbVqhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:19 INFO - Running setup.py (path:/tmp/pip-gA4aN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:19 INFO - Running setup.py (path:/tmp/pip-3RbIkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:19 INFO - Running setup.py (path:/tmp/pip-x9a_7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:19 INFO - Running setup.py (path:/tmp/pip-L0Kd0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:19 INFO - Running setup.py (path:/tmp/pip-sJGNW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:19 INFO - Running setup.py (path:/tmp/pip-K1EosG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:19 INFO - Running setup.py (path:/tmp/pip-ajvLEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:19 INFO - Running setup.py (path:/tmp/pip-DGr92O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:19 INFO - Running setup.py (path:/tmp/pip-bifIwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:19 INFO - Running setup.py (path:/tmp/pip-S_tTPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:20 INFO - Running setup.py (path:/tmp/pip-TUNaWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:20 INFO - Running setup.py (path:/tmp/pip-PMKK2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:20 INFO - Running setup.py (path:/tmp/pip-YhL3Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:20 INFO - Running setup.py (path:/tmp/pip-rpUeMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:20 INFO - Running setup.py install for manifestparser 08:59:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:20 INFO - Running setup.py install for mozcrash 08:59:20 INFO - Running setup.py install for mozdebug 08:59:20 INFO - Running setup.py install for mozdevice 08:59:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:20 INFO - Running setup.py install for mozfile 08:59:20 INFO - Running setup.py install for mozhttpd 08:59:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:20 INFO - Running setup.py install for mozinfo 08:59:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for mozInstall 08:59:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for mozleak 08:59:21 INFO - Running setup.py install for mozlog 08:59:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for moznetwork 08:59:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for mozprocess 08:59:21 INFO - Running setup.py install for mozprofile 08:59:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for mozrunner 08:59:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Running setup.py install for mozscreenshot 08:59:21 INFO - Running setup.py install for moztest 08:59:21 INFO - Running setup.py install for mozversion 08:59:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:22 INFO - Cleaning up... 08:59:22 INFO - Return code: 0 08:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:22 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:22 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 08:59:22 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 08:59:22 INFO - Using env: {'DISPLAY': ':0', 08:59:22 INFO - 'HOME': '/home/cltbld', 08:59:22 INFO - 'LANG': 'en_US.UTF-8', 08:59:22 INFO - 'LANGUAGE': 'en_US:en', 08:59:22 INFO - 'LOGNAME': 'cltbld', 08:59:22 INFO - 'MAIL': '/var/mail/cltbld', 08:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:22 INFO - 'MOZ_NO_REMOTE': '1', 08:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:22 INFO - 'NO_EM_RESTART': '1', 08:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:22 INFO - 'PWD': '/builds/slave/test', 08:59:22 INFO - 'SHELL': '/bin/bash', 08:59:22 INFO - 'SHLVL': '1', 08:59:22 INFO - 'TERM': 'linux', 08:59:22 INFO - 'TMOUT': '86400', 08:59:22 INFO - 'USER': 'cltbld', 08:59:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:22 INFO - '_': '/tools/buildbot/bin/python'} 08:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:22 INFO - Running setup.py (path:/tmp/pip-UAtnq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:22 INFO - Running setup.py (path:/tmp/pip-c4DLmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:22 INFO - Running setup.py (path:/tmp/pip-r6xPHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:22 INFO - Running setup.py (path:/tmp/pip-xLYF_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:22 INFO - Running setup.py (path:/tmp/pip-UMzHjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:22 INFO - Running setup.py (path:/tmp/pip-ApPn4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:22 INFO - Running setup.py (path:/tmp/pip-NFaSPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:22 INFO - Running setup.py (path:/tmp/pip-1RGDlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:22 INFO - Running setup.py (path:/tmp/pip-FgTS32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:22 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)) 08:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:22 INFO - Running setup.py (path:/tmp/pip-UAJqHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:23 INFO - Running setup.py (path:/tmp/pip-DzPO_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:23 INFO - Running setup.py (path:/tmp/pip-mSgHJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:23 INFO - Running setup.py (path:/tmp/pip-HSeCxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:23 INFO - Running setup.py (path:/tmp/pip-GWn_Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:23 INFO - Running setup.py (path:/tmp/pip-4Z8SIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:23 INFO - Running setup.py (path:/tmp/pip-uDhMSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:23 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)) 08:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:23 INFO - Running setup.py (path:/tmp/pip-00rbEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:23 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)) 08:59:23 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)) 08:59:23 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)) 08:59:23 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)) 08:59:23 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)) 08:59:23 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)) 08:59:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:25 INFO - Downloading blessings-1.6.tar.gz 08:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:25 INFO - Installing collected packages: blessings 08:59:25 INFO - Running setup.py install for blessings 08:59:25 INFO - Successfully installed blessings 08:59:25 INFO - Cleaning up... 08:59:25 INFO - Return code: 0 08:59:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:25 INFO - Reading from file tmpfile_stdout 08:59:25 INFO - Current package versions: 08:59:25 INFO - argparse == 1.2.1 08:59:25 INFO - blessings == 1.6 08:59:25 INFO - blobuploader == 1.2.4 08:59:25 INFO - docopt == 0.6.1 08:59:25 INFO - functools32 == 3.2.3-2 08:59:25 INFO - jsonschema == 2.5.1 08:59:25 INFO - manifestparser == 1.1 08:59:25 INFO - mozInstall == 1.12 08:59:25 INFO - mozcrash == 0.17 08:59:25 INFO - mozdebug == 0.1 08:59:25 INFO - mozdevice == 0.48 08:59:25 INFO - mozfile == 1.2 08:59:25 INFO - mozhttpd == 0.7 08:59:25 INFO - mozinfo == 0.9 08:59:25 INFO - mozleak == 0.1 08:59:25 INFO - mozlog == 3.2 08:59:25 INFO - moznetwork == 0.27 08:59:25 INFO - mozprocess == 0.22 08:59:25 INFO - mozprofile == 0.28 08:59:25 INFO - mozrunner == 6.11 08:59:25 INFO - mozscreenshot == 0.1 08:59:25 INFO - mozsystemmonitor == 0.3 08:59:25 INFO - moztest == 0.7 08:59:25 INFO - mozversion == 1.4 08:59:25 INFO - psutil == 3.1.1 08:59:25 INFO - requests == 1.2.3 08:59:25 INFO - wsgiref == 0.1.2 08:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:25 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 08:59:25 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 08:59:25 INFO - Using env: {'DISPLAY': ':0', 08:59:25 INFO - 'HOME': '/home/cltbld', 08:59:25 INFO - 'LANG': 'en_US.UTF-8', 08:59:25 INFO - 'LANGUAGE': 'en_US:en', 08:59:25 INFO - 'LOGNAME': 'cltbld', 08:59:25 INFO - 'MAIL': '/var/mail/cltbld', 08:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:25 INFO - 'MOZ_NO_REMOTE': '1', 08:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:25 INFO - 'NO_EM_RESTART': '1', 08:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:25 INFO - 'PWD': '/builds/slave/test', 08:59:25 INFO - 'SHELL': '/bin/bash', 08:59:25 INFO - 'SHLVL': '1', 08:59:25 INFO - 'TERM': 'linux', 08:59:25 INFO - 'TMOUT': '86400', 08:59:25 INFO - 'USER': 'cltbld', 08:59:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:25 INFO - '_': '/tools/buildbot/bin/python'} 08:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 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)) 08:59:26 INFO - Cleaning up... 08:59:26 INFO - Return code: 0 08:59:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:26 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')]} 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 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')]} 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:26 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 08:59:26 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 08:59:26 INFO - Using env: {'DISPLAY': ':0', 08:59:26 INFO - 'HOME': '/home/cltbld', 08:59:26 INFO - 'LANG': 'en_US.UTF-8', 08:59:26 INFO - 'LANGUAGE': 'en_US:en', 08:59:26 INFO - 'LOGNAME': 'cltbld', 08:59:26 INFO - 'MAIL': '/var/mail/cltbld', 08:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:26 INFO - 'MOZ_NO_REMOTE': '1', 08:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:26 INFO - 'NO_EM_RESTART': '1', 08:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:26 INFO - 'PWD': '/builds/slave/test', 08:59:26 INFO - 'SHELL': '/bin/bash', 08:59:26 INFO - 'SHLVL': '1', 08:59:26 INFO - 'TERM': 'linux', 08:59:26 INFO - 'TMOUT': '86400', 08:59:26 INFO - 'USER': 'cltbld', 08:59:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:26 INFO - '_': '/tools/buildbot/bin/python'} 08:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:59:26 INFO - Cleaning up... 08:59:26 INFO - Return code: 0 08:59:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:59:26 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')]} 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 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')]} 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 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 0x7f0a16f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', '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 08:59:26 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 08:59:26 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 08:59:26 INFO - Using env: {'DISPLAY': ':0', 08:59:26 INFO - 'HOME': '/home/cltbld', 08:59:26 INFO - 'LANG': 'en_US.UTF-8', 08:59:26 INFO - 'LANGUAGE': 'en_US:en', 08:59:26 INFO - 'LOGNAME': 'cltbld', 08:59:26 INFO - 'MAIL': '/var/mail/cltbld', 08:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:26 INFO - 'MOZ_NO_REMOTE': '1', 08:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:26 INFO - 'NO_EM_RESTART': '1', 08:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:26 INFO - 'PWD': '/builds/slave/test', 08:59:26 INFO - 'SHELL': '/bin/bash', 08:59:26 INFO - 'SHLVL': '1', 08:59:26 INFO - 'TERM': 'linux', 08:59:26 INFO - 'TMOUT': '86400', 08:59:26 INFO - 'USER': 'cltbld', 08:59:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:26 INFO - '_': '/tools/buildbot/bin/python'} 08:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:26 INFO - Downloading/unpacking flake8 08:59:26 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 08:59:26 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 08:59:26 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 08:59:26 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 08:59:26 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 08:59:26 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 08:59:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:59:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:59:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:59:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:29 INFO - no previously-included directories found matching 'docs/_build' 08:59:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:59:29 INFO - Running setup.py install for pep8 08:59:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:29 INFO - no previously-included directories found matching 'docs/_build' 08:59:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:59:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:59:29 INFO - Cleaning up... 08:59:29 INFO - Return code: 0 08:59:29 INFO - Running post-action listener: _resource_record_post_action 08:59:29 INFO - Running post-action listener: _start_resource_monitoring 08:59:29 INFO - Starting resource monitoring. 08:59:29 INFO - ##### 08:59:29 INFO - ##### Finished create-virtualenv step (success) 08:59:29 INFO - ##### 08:59:29 INFO - ##### 08:59:29 INFO - ##### Running install step. 08:59:29 INFO - ##### 08:59:29 INFO - Running pre-action listener: _resource_record_pre_action 08:59:29 INFO - Running main action method: install 08:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:29 INFO - Reading from file tmpfile_stdout 08:59:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:29 INFO - Reading from file tmpfile_stdout 08:59:29 INFO - Output received: 08:59:29 INFO - Usage: mozinstall [options] installer 08:59:29 INFO - Options: 08:59:29 INFO - -h, --help show this help message and exit 08:59:29 INFO - -d DEST, --destination=DEST 08:59:29 INFO - Directory to install application into. [default: 08:59:29 INFO - "/builds/slave/test"] 08:59:29 INFO - --app=APP Application being installed. [default: firefox] 08:59:29 INFO - mkdir: /builds/slave/test/build/application 08:59:29 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'] 08:59:29 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 08:59:46 INFO - Reading from file tmpfile_stdout 08:59:46 INFO - Output received: 08:59:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:59:46 INFO - Running post-action listener: _resource_record_post_action 08:59:46 INFO - ##### 08:59:46 INFO - ##### Finished install step (success) 08:59:46 INFO - ##### 08:59:46 INFO - ##### 08:59:46 INFO - ##### Running run-tests step. 08:59:46 INFO - ##### 08:59:46 INFO - Running pre-action listener: _resource_record_pre_action 08:59:46 INFO - Running main action method: run_tests 08:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:46 INFO - Python 2.7.3 08:59:46 INFO - Return code: 0 08:59:46 INFO - grabbing minidump binary from tooltool 08:59:46 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')]} 08:59:46 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 0x23f92e0>, '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 0x2365140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23655d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:46 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 08:59:46 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 08:59:46 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 08:59:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:46 INFO - Return code: 0 08:59:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:59:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:59:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:59:47 INFO - Return code: 0 08:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:59:47 INFO - Using env: {'DISPLAY': ':0', 08:59:47 INFO - 'HOME': '/home/cltbld', 08:59:47 INFO - 'LANG': 'en_US.UTF-8', 08:59:47 INFO - 'LANGUAGE': 'en_US:en', 08:59:47 INFO - 'LOGNAME': 'cltbld', 08:59:47 INFO - 'MAIL': '/var/mail/cltbld', 08:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:47 INFO - 'MOZ_NO_REMOTE': '1', 08:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:47 INFO - 'NO_EM_RESTART': '1', 08:59:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:47 INFO - 'PWD': '/builds/slave/test', 08:59:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:47 INFO - 'SHELL': '/bin/bash', 08:59:47 INFO - 'SHLVL': '1', 08:59:47 INFO - 'TERM': 'linux', 08:59:47 INFO - 'TMOUT': '86400', 08:59:47 INFO - 'USER': 'cltbld', 08:59:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086', 08:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:47 INFO - '_': '/tools/buildbot/bin/python'} 08:59:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:59:47 INFO - mozversion application_buildid: 20160617061051 08:59:47 INFO - mozversion application_changeset: 53826630a9c19513d78819a64b25496464a2f0c6 08:59:47 INFO - mozversion application_display_name: Nightly 08:59:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:47 INFO - mozversion application_name: Firefox 08:59:47 INFO - mozversion application_remotingname: firefox 08:59:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:59:47 INFO - mozversion application_vendor: Mozilla 08:59:47 INFO - mozversion application_version: 50.0a1 08:59:47 INFO - mozversion platform_buildid: 20160617061051 08:59:47 INFO - mozversion platform_changeset: 53826630a9c19513d78819a64b25496464a2f0c6 08:59:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:59:47 INFO - mozversion platform_version: 50.0a1 08:59:47 INFO - using testdate: 1466179187 08:59:47 INFO - actual date: 1466179187 08:59:47 INFO - starting webserver on 'localhost:48438' 08:59:47 INFO - SUITE-START | Running 2 tests 08:59:47 INFO - TEST-START | dromaeo_css 08:59:47 INFO - operating with platform_type : linux_ 08:59:47 INFO - Initialising browser for dromaeo_css test... 08:59:47 INFO - TEST-INFO | started process 9762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkPUIrL/profile http://localhost:48438/getInfo.html) 08:59:52 INFO - PROCESS | 9762 | __metrics Screen width/height:1600/1200 08:59:52 INFO - PROCESS | 9762 | colorDepth:24 08:59:52 INFO - PROCESS | 9762 | Browser inner width/height: 1024/697 08:59:52 INFO - PROCESS | 9762 | __metrics 08:59:52 ERROR - PROCESS | 9762 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:59:53 INFO - TEST-INFO | 9762: exit 0 08:59:53 INFO - Browser initialized. 08:59:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:53 INFO - TEST-INFO | started process 9880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkPUIrL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:05 INFO - PROCESS | 9880 | RSS: Main: 185126912 09:00:05 INFO - PROCESS | 9880 | 09:00:55 INFO - PROCESS | 9880 | 1466179255443 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] 09:03:03 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48438/tests/dromaeo/cssquery-ext.html) 09:03:04 INFO - PROCESS | 9880 | RSS: Main: 189046784 09:03:04 INFO - PROCESS | 9880 | 09:06:06 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-ext.html (next: http://localhost:48438/tests/dromaeo/cssquery-jquery.html) 09:06:06 INFO - PROCESS | 9880 | RSS: Main: 188186624 09:06:06 INFO - PROCESS | 9880 | 09:09:08 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48438/tests/dromaeo/cssquery-mootools.html) 09:09:09 INFO - PROCESS | 9880 | RSS: Main: 189247488 09:09:09 INFO - PROCESS | 9880 | 09:12:11 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48438/tests/dromaeo/cssquery-prototype.html) 09:12:11 INFO - PROCESS | 9880 | RSS: Main: 187711488 09:12:11 INFO - PROCESS | 9880 | 09:15:14 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48438/tests/dromaeo/cssquery-yui.html) 09:15:14 INFO - PROCESS | 9880 | RSS: Main: 189030400 09:15:14 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | Cycle 1(1): loaded http://localhost:48438/tests/dromaeo/cssquery-yui.html (next: http://localhost:48438/tests/dromaeo/cssquery-dojo.html) 09:18:17 INFO - PROCESS | 9880 | RSS: Main: 190304256 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | __start_tp_report 09:18:17 INFO - PROCESS | 9880 | _x_x_mozilla_page_load 09:18:17 INFO - PROCESS | 9880 | _x_x_mozilla_page_load_details 09:18:17 INFO - PROCESS | 9880 | |i|pagename|runs| 09:18:17 INFO - PROCESS | 9880 | |0;dojo.html;3136.749060075194;3163.7310828579584;3167.6357218919825;3181.2206009527667;3189.856456459459;5383.757730902109;5424.755885985131;5428.1586354115125;5490.56075513959;5571.220029195906;5381.327334083239;5399;5435.592330575203;5442.591805614575;5460.972695136528;4877.341558889549;4913.729744864031;5038.269450929613;5078.13671675816;5125.436202017775;672.916248537016;4844.006978569385;4849.636277279218;4943.505649435046;5036.874078148039;4884.023195360925;4908.361912951329;4912.950870491303;4915.16442204826;4929.2359684248995;4912.410510738699;4914.066327397783;4919.950800491985;4928.457869634373;4934.629902757308;4863.756812159413;4898.926516102261;4910.116179087763;4941.258811178316;4963.875903102451;5366.892662146735;5461.617686761928;5481.369642491125;5484.2596249506205;5514.145307477347;5657.1514272858985;5682.289713785777;5777.682227477487;5826.300843898717;5835.328937172195;5784.68184249866;5813.854653633693;5818.301803783531;5856.00447923854;5903.763849446017;5441.347038355383;5447.101228297326;5447.509724124809;5451.318585176853;5460.180972854064;5859.1797148399255;5874.941250587525;5938.881222375615;5940.31686356066;5941.22764040672;5727.627704199213;5770.42295770428;5772.855678608068;5775.364709881909;5828.825135245865;5804.535637149018;5828.388019257917;5829.154772557956;5842.59101862874;5852.619579727304;5663.207150998864;5748.712564371848;5796.130580412888;5828.6211396259105;5874.794382196688;5852.122181672783;5855.443732845458;5897.174395584621;5911.704414779244;5921.230240068763;4434.179676759745;4448.421705178306;4458.286674132123;4468.240399132155;4483.686141970096;3897.3179693553516;3897.824597893102;3933.252681990413;3951.980240098781;3954.8220330085214;5368.677879327175;5448.346198456211;5478.58910581708;5550.084236101079;5628.887422251532;5903.734331955073;5912.733926973297;5912.99479088556;5917.349091599921;5917.408259174048;5495.065838807413;5519.365272993577;5610.7194640268635;5616.859578510488;5623.915641265385;5013.824516141917;5044.192929131322;5046.26829109777;5046.419661738873;5089.185730283137;5983.341832398432;6029.758809647653;6042.818715438544;6048.032314829607;6049.485793707496;5697.658140511582;5781;5790.392008839011;5795.855103622274;5862.677552734555;6005.399460054135;6007.8197654070445;6017.037274036134;6028.758849645965;6049.425304596057;5750.424957504216;5754.6547207167705;5756.453136951983;5756.798512052058;5761.971190144022;5721.399253078367;5838.153467747068;5865.120231965239;5890.204822348928;5925.555583331181;5660.349059858169;5745.482906538432;5752.68360240174;5753.597248192586;5758.971205143947;5631.352394474688;5755.53955683536;5762.078067509178;5764.855878602901;5772.797952071825;5517.944820551743;5558.388577256579;5584.301962254718;5588.050031494737;5611.298587676541;5654.3497497788285;5715;5716.628419152742;5719.399463056319;5723.6851973141875;5464;5567.276254086943;5594.1608758686525;5616.66300022;5621.156826476062 09:18:17 INFO - PROCESS | 9880 | |1;ext.html;573.5726883471814;620.7144713431821;625.8153844615838;627.7426255235351;640.7020735358058;42462.787686061565;44195.558044419544;44289.778551107236;44416.55583444165;49126.75436622812;45812;46571;46621.30068048974;46647;46739.29891051637;9092.136247056536;9097.044810294923;9134.817303653923;9161.221296189799;9166.633334666605;8910.287177025855;9040;9074.63701451941;9096.408733432305;9107.499087550183;9087.182153606174;9104.36269461138;9143.177114059734;9167.220786233145;9173.95413022934;9011.053839346872;9087.31845111616;9097.40866843653;9097.454152750855;9117.863232051524;8964.775880602972;8985.820283594292;9001.504917229615;9026.368154229207;9050.094990500964;43193.78403107996;43293.35059974071;43674.12651746979;43774;43881.78059109716;3618.945715814265;3654.9817250913843;3702.8518859245596;3747.7220505506684;3777.773333599993;33550.664493355;33651.663483365344;33860.492092618384;34003;35212.64787352119;4463.288108539498;4540.069285796404;4545.068261006486;4579.267317229227;4608.28571571407;370781;372536;375168.99999999726;375561;375626;33299.66700333014;34717.13207169841;53052;53625.19562206492;53640.195397069074;36791.63208367935;37140.81429592835;37170.62829371672;37256.62743372586;37323.62676373201;14744.115353078849;14777.926110369379;14847.2576371181;14855.2572371381;15015.324310406058;13185.802212966813;13236.07347485686;13267.137636053625;13283.402246898913;13306;8382.958085209657;8410.579471026424;8490.575471226413;8556.529390883437;8577.699780507652;3255.3814775192636;3264.771465997357;3276.918077048093;3279.0326853578254;3294.374068926896;1030.1964467715195;1045.6653870761284;1056.8414737789394;1178.4991378664033;1181.3679681370425;32987.3402531948;33386.332273354885;33464.49803252953;33584.49623255653;33661;1109.3732041396586;1142.7714457108611;1154.7979103656994;1157.5774842182543;1179.351356753782;17359.652806944043;17517.124143793015;17528;17695.73456398155;17708.734368984475;159738;161891;569051;574354;576706;59621.701891490266;60726.39273607296;60767;60781.69609152014;61116.38883611196;1355.9932200338935;1360.4014233737123;1376.9242691652055;1377.8553251908606;1391.8886489080646;30515.847420762755;32860.67139328672;32927;33240.83379583087;33482.83258583691;52007.73996129995;52022;52075;52267.73866130645;52301.7384913073;457629;459269;460197;462075;463974;28684.569731454463;28932.42135157327;29000.564991524723;29009;29047.273818154714;48891;49556.75221623869;49678.503214968834;51151.23273150831;51286.23070654018;42089.57910420857;42418;42648.5735142657;43177;44196.337054944845;41933.79033104937;42118;42193.78903105465;43298.567014330714;43382.78308608437;41571.7921410391;41674;42246.366304506075;42862.57137428586;42966;35949;37089.814550927076;37597.436038458894;39701;41262.38106428466;27989;28476.145715628565;28638.57042144411;28730.569041464812;28815.135545933656 09:18:17 INFO - PROCESS | 9880 | |2;jquery.html;375.7181023757479;385.0950266872849;389.8499077855026;394.422171518725;405.26849037487324;17116.91441542792;18669.533261668465;18918.90540547299;18980.62038759224;19144.808551914477;17109;17467.912660436712;17712.20295086721;17732.46802595921;17854.910725446356;5345.705986170749;5501.614886957915;5561.360443548983;5602;5602.719864006804;5393.514583687467;5409.594280428964;5432.293801805759;5540.86147846303;5541.501264886159;5360.410354860962;5410.134378499441;5425.077736784756;5469.15228139639;5480.945190548084;5347.331583552056;5445.782168713246;5448.318960129984;5481.917771233395;5493.23094766733;4874.268859671042;4899.926501102486;4903.387076615423;4924.261360795909;4928.162212423861;22292.777072229394;22380.552388952292;22694.319170424915;22741.658875116886;22771.08915643389;2421.116292553223;2784.9443011139865;3088.722015018659;3110.848985875218;3121.59419275495;14303.642408939755;14501;14586.781198282035;14666.779998300033;14689.559313220621;1849.5468610190455;1918.2614693343023;1943.834774044208;1982.2269314967175;2017.7376940997724;71134.64432677804;73186;74796.25203747947;75050.24949750488;75341.62329188373;10031.347962382422;10145.442000690033;10581.259311848251;10600.098991585648;10783.6225732099;14307.57077287683;14355.066920650124;14390.992630515973;14454.277286135652;14472.710545789025;8195.221453961864;8402.663893444194;8418.368622353348;8498.575071246412;8562.571871406404;8243.546604936786;8324.167583241628;8435.957820210982;8468.364872634576;8482.321414286966;6496.967515162489;6534.117894084333;6684.231313399021;6707.1616047994;6747.527673062937;1872.1949561688605;1907.3515004898402;1908.7900330963582;1916.9233230670895;1941.5437372217518;886.5744442667556;1018.2007124407453;1068.524506594558;1109.4009235013164;1148.9195756297147;19268.614627707368;19516.512087197934;19992.60014799696;20066.89966550158;20103.19587216524;1007.7279134633608;1008.5663164839043;1036.212478516333;1041.146260066738;1047.8847326794046;10607.893921060844;11260.016304455881;11268.211225214156;11368.090552755759;11432.256903301259;457829;459987;477916;501609;503938;77047.61476192583;79689.20310796934;81192;81598.28932318768;81614;1018.1142406106586;1025.1491262252312;1035.8394448860438;1047.6804574604666;1050.1283934334483;17220.225089870735;17225.708071894907;17334.73997890058;17537.210825512626;17569.209385577935;37079.25841483209;38110;38514;39527.80236098801;39980.40029399503;49604.75197623989;51597.7420112897;51704;52052.21921671102;52104.73947630238;8622.913770862462;8626.698065567674;8675.175858293453;8841.646334146562;8890.022097569134;12187.51249949992;13686.931565342109;13711.725765484834;13811.930940345233;13928.721425571635;12015;12099.455524501594;12149.635510934686;12173.513059477522;12199.634010979686;12057.638270851889;12184.390780461119;12324.630261092181;12335.629931102081;12429.627111186679;10940.39827809478;12328.876711232773;12366.319852408204;12496.250224986166;12558.246505209716;7442.479026468095;7757.3794096473275;7827.569483678452;8366.581670916552;8557.887474628258;8649.178328058824;11535.307881527135;11660.242084264495;11827.231229970368;11860.881391185978 09:18:17 INFO - PROCESS | 9880 | |3;mootools.html;1477.446740588884;1487.286102670718;1590.0459724165503;1743.3810997096039;1760.2255007796578;7988.520688758664;8656.826863462727;8750.91249087509;9313.860292095616;9326.067393260679;8738.213560779528;8974.730758077252;9015.954920225406;9025.503597302146;9083.364164508486;2223.8888055597236;2253.6056190166737;2255.3684968208845;2256.311824893407;2256.593813113639;2232.464208589935;2237.776222377757;2263.3436303472054;2273.9090436382526;2277.7152855893014;2219.755826859044;2224.22152246714;2235.61994460942;2243.383069655841;2253.4141123307895;2156.5255643758346;2170.066871245364;2179.3897708641607;2185.366243789307;2193.890305484719;2180.4221881201493;2189.715337006179;2191.2878314547834;2192.48476607997;2195.802377786007;9096.862892138482;9122.179003889682;9146.817063658757;9157.313201509913;9204.493752843591;4888.804447822083;5041.117804384218;5049.166887463564;5053.216751403538;5054.039732450822;3108.751299896003;3181.443247431713;3272.672732726732;3293.1602441377536;3301.8018918864946;1027.8509616105623;1045.409343720803;1049.8425236214553;1053.8419237114417;1055.9472026398726;12696.80954785679;12700.237985720887;12703.428345724464;12712.809307860389;12743.936280318632;4299.570042995675;4501.527339629357;4510.481294651157;4540.477845047796;4541.159885421208;10633.096186824207;10700.732481688021;10742.89257107419;10762.78474430507;10772.407517586607;4846.95153048465;5078.7206703631655;5101.311322971352;5130.897382052338;5131.435542090367;4017.5580686124504;4411.2941929291155;4417.823287068545;4648.953510464852;4665.5101214372;3706.499622550975;3725.9627403725617;3811.4282857571034;3824.2542704172974;3848.5766565677754;1129.491728722062;1136.9658910232706;1139.811931031387;1149.5861489863642;1152.688774031007;801.7514570483169;817.7751118442357;884.9380743108296;938.6057855700623;1002.8896821349646;5893.11603259506;6068.423499767515;6095.420935011255;6136.864680034208;6376.681165941684;896.4128495835238;939;961.2694352292308;965.0831709875646;970.6942313171328;4033.495813023372;4124.649404800625;4165.16696660663;4201.684873634428;4240.1519696060295;11103.83344249837;11434.599789007345;11461.71345716347;11541.826872596917;11560.479778409823;10967.890321096846;11249.10007199422;11251.662450126509;11313.886861131448;11382.601608943647;8362.623681934327;8372.832543348977;8459;8481.363897707697;8508.61711222984;5903.881922361443;6010.368911264254;6085.939140608714;6195.473384762346;6221.844453888508;10317.587296508056;10560.841587376042;10662.306950048222;10737.731556711145;10748.032677059102;10700.090492308242;10720.088792452729;10731.731706707395;10739.785204296026;10870.891291087304;7569.810754731176;7638.274363935418;7967.4024448167775;8057.0734365548715;8161.3062889652665;8699.08659590759;8781.604827782892;8790.956045219733;8792.296616270554;8807.207351338411;7598.316151546387;7833.295003449717;7848.725294614661;7869.881951770613;7957.045154581488;7838.568878711498;7845.529268243924;7894.21057894206;7894.486858354188;8040.798980025312;6741.662916854236;6854.383105520527;6922.619255940972;6941.444684425132;7004.824879377852;5179.249008893765;5213.687178769286;5324.307839980777;5354.196870469461;5535.003699334158;5329.280547126088;5402.216678581663;5544.75048622821;5564.4713752193475;5639.943600563942 09:18:17 INFO - PROCESS | 9880 | |4;prototype.html;319.9712025917667;321.97585181111424;327.2603915151757;328.853660121246;334.7857371282378;5602.943970560294;5650.491455768985;5668;5728.914066288999;5752.15930902111;5506.614536982413;5518.91721624176;5541.418151094137;5559.138333558305;5586.273784408031;4074.5925407459313;4162.625363717265;4327.567243275663;4331.242032644291;4334.84828031019;4310.52584215736;4319.078010285424;4335.56644335567;4338.587834155766;4354.608085272325;4302.97848510757;4323.632491238249;4326.572231163725;4330.610245077943;4331.7400955942585;4046.9190616187657;4266.466691663542;4271.67962402821;4279.850205242801;4328.523862375137;3705.184859330943;3718.995871114811;3728.664420202195;3732.234891847192;3739.6260373962386;5438.456154384569;5443.591730620219;5452.655358195974;5458.890822183574;5512.641678290898;4849.393825771778;4912.852614421573;4916.387627554821;4945.950540494585;4950.455449900508;5703.287089113861;5814.127880817869;5819.6508209507565;5898.941010589925;5910.408959104056;4058.3303754880408;4092.058826469899;4106.753594784323;4109.383592461125;4112.753234805891;5846.7953621623465;6012.96993515034;6025.9096113558335;6037.939620603782;6040.607360521596;4144.150449157915;4160.583941605876;4164.666826653921;4172.561881002512;4177.289860723684;4195.244855925902;4202.558731333227;4236.576342365739;4240.597143271384;4251.4260574822;4692.671512994058;4817.301491283744;4839;4852.1508735971065;4925.532074452921;5775.94224057754;5831.679257640871;5851.239338886003;5870.530357571384;5888.499477544457;1453.5203382883835;1468.5153899213235;1472.3227315434806;1479.9408023679148;1480.0083943757709;903.3495882964255;939.3236869453982;947.6067432015636;964.1419136968104;1007.6271779441654;5569.275994120739;5591.41290164535;5595.776168953278;5602.831915042555;5655.604107712421;5928.584999050025;5962.910556341659;5971.4924231439945;5985.521158307325;6013.338532761392;5397.649152805134;5569.387367389665;5668.894565559759;5709.685967271756;5769.913451298234;3178.221335772704;3191.7817117103855;3245.659205783406;3269.9182520436702;3292;6071.241094863142;6137.115555688819;6185.319614842364;6229.844253893689;6284.497240220771;6155;6205.968970155121;6209.285932117774;6275.497960163176;6291.9685401573615;6138.1713468681155;6310.905336419957;6324.146240257598;6329.841753956096;6332.620042797447;6103.359147289649;6115.8776824462375;6130.846728831815;6146.200993870768;6154.415330543591;5897.64614123154;6035.155078288955;6039.728212230372;6054.152418661303;6056.727447264796;6056.939430605637;6202.627842329474;6300.369963003663;6313.179286692701;6326.936730632635;4182.330827067654;4193.538710741877;4198.643115335109;4223.72545784523;4260.339647354665;5907.291125064848;6030.5778595497895;6108.328083910855;6125.509959203164;6138.785142520169;5849.473547380756;5853.239078919713;5855.385184555731;5867.20792692998;5891.440313170242;5840.328362238397;5840.386759390203;5841.591088623755;5894.557908156991;5925.614835035709;5207.843764687065;5713.94292055971;5759.12043978011;5777.3933736957015;5801.796937107181;5822.912656310244;5871.2073870027;5888.205092312483;5914.349421563538;5976.760929562943;5468.28912241406;5704.657720536781;5706.942930570641;5803.912941305968;5842.3281322646735 09:18:17 INFO - PROCESS | 9880 | |5;yui.html;711.5766119159105;730.5762657658559;758.3326672528175;812.2162113560415;876.2858270509536;15184.164870932094;16048.43830465934;16055.919720401382;16304.59238519036;16870.746938795928;14697.191654459028;14781.334839932202;14878.181700006522;14905.925470372633;14947.177905215209;666.3037126203129;777.9533228006338;787.0869791042392;790.1663744749287;796.4424902568196;760.6158889760691;764.1594246329049;767.110152223421;768.6694721269852;769.8845173224005;784.0826233307016;790.2532107158737;795.2246559604397;796.024869534821;801.1707882341777;789.2423273657296;791.4380789639363;793.9841203175962;794.1105961323326;797.9985118676083;588.0414923674426;590.5688847141568;593.2317648645015;593.717983957621;595.0063394131811;15279.388824447009;15328.616784580474;15380.077195368314;15391.307391167424;15416.306266218047;15471.458498952483;15812.525624231292;15843.683126337408;15915.20423978808;16122.193890305438;11866.58466953661;11986.760264794655;12114.757704845853;12311.69220769479;12481.75036499274;3936.7637941723588;3988.222296652154;4009.8195581198916;4017.5982401759884;4073.674106071507;78137;79154.20845791526;79648;79651.60174199092;80064.59967700124;11267.436628168558;11705.765884682258;11736.178467507192;11780.17538772295;11849.407529623657;22981.885090574775;23069.653955190686;23190.7680923192;23194.072237110326;23212;8788.692395766118;8883.600237989305;8986.68546600866;9044.321675874337;9109.544522773835;5005.649604527721;5015.598752099823;5049.6465247432325;5064.392272927273;5179.300794392784;3701.685356744707;3820.331441997639;3829.3872980323013;3833.5399752029375;3852.788096654711;627.6359711367396;633.9746410143634;641.8170821315996;642.1106767127469;647.3946859686208;574.7614739882986;690.268315585481;704.5807744392181;769.8344855856018;777.7394572818056;10167.644132455329;10192.388456692623;10242.59029638821;10291.176705863512;10476.738081548023;599.5233789137646;626.8996960486392;655.9639219842859;656.6585375604659;682.7030241844814;4973.52751488608;4989.650724449326;5104.387473503203;5161.096808058574;5197.194434862602;112637.80492072851;115740;116103.77533011035;118059;118375;61031.69484152551;103570;103900;104065;104888.47555762173;54749;85820.57089714636;88739;90091;90885;9417.434953902788;9421.62313507452;9589.089036541518;9604.08761167688;9640.373375730836;51755.22367164571;52418.475815241356;52739;53806.73096634492;53980.460195399115;68625.65687171533;68759.65620171867;75441.62279188569;77538.6123069381;77934.61032694801;12444.253344799341;12504.124711270488;12541.49834006666;12913;13001.089923705249;13830.170189788645;13916.282599903114;13950.79073813914;14093.506727264497;14213.502527411905;11906.40467976615;11946.163768536118;11996.64010079699;12997.220166790023;13241.801372979606;12359.69100772488;12732.618021459371;13394.263315517741;14468.85531144675;14973.326200320795;14390.928045359706;14789.92605037011;15039.097654140787;15428.84571154319;15777.447789327318;12052.939735301268;12282.938585307016;12351.69120771988;12510.374481276081;12789.872101278868;12215.511379544718;12237.59982818812;12429.75140497203;12520.373981300716;12633.873661263637 09:18:17 INFO - PROCESS | 9880 | __end_tp_report 09:18:17 INFO - PROCESS | 9880 | __start_cc_report 09:18:17 INFO - PROCESS | 9880 | _x_x_mozilla_cycle_collect,371 09:18:17 INFO - PROCESS | 9880 | __end_cc_report 09:18:17 INFO - PROCESS | 9880 | __startTimestamp1466180297357__endTimestamp 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | ------- Summary: start ------- 09:18:17 INFO - PROCESS | 9880 | Number of tests: 6 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#0] dojo.html Cycles:165 Average:5386.15 Median:5623.92 stddev:719.44 (12.8%) stddev-sans-first:699.67 09:18:17 INFO - PROCESS | 9880 | Values: 3136.7 3163.7 3167.6 3181.2 3189.9 5383.8 5424.8 5428.2 5490.6 5571.2 5381.3 5399.0 5435.6 5442.6 5461.0 4877.3 4913.7 5038.3 5078.1 5125.4 672.9 4844.0 4849.6 4943.5 5036.9 4884.0 4908.4 4913.0 4915.2 4929.2 4912.4 4914.1 4920.0 4928.5 4934.6 4863.8 4898.9 4910.1 4941.3 4963.9 5366.9 5461.6 5481.4 5484.3 5514.1 5657.2 5682.3 5777.7 5826.3 5835.3 5784.7 5813.9 5818.3 5856.0 5903.8 5441.3 5447.1 5447.5 5451.3 5460.2 5859.2 5874.9 5938.9 5940.3 5941.2 5727.6 5770.4 5772.9 5775.4 5828.8 5804.5 5828.4 5829.2 5842.6 5852.6 5663.2 5748.7 5796.1 5828.6 5874.8 5852.1 5855.4 5897.2 5911.7 5921.2 4434.2 4448.4 4458.3 4468.2 4483.7 3897.3 3897.8 3933.3 3952.0 3954.8 5368.7 5448.3 5478.6 5550.1 5628.9 5903.7 5912.7 5913.0 5917.3 5917.4 5495.1 5519.4 5610.7 5616.9 5623.9 5013.8 5044.2 5046.3 5046.4 5089.2 5983.3 6029.8 6042.8 6048.0 6049.5 5697.7 5781.0 5790.4 5795.9 5862.7 6005.4 6007.8 6017.0 6028.8 6049.4 5750.4 5754.7 5756.5 5756.8 5762.0 5721.4 5838.2 5865.1 5890.2 5925.6 5660.3 5745.5 5752.7 5753.6 5759.0 5631.4 5755.5 5762.1 5764.9 5772.8 5517.9 5558.4 5584.3 5588.1 5611.3 5654.3 5715.0 5716.6 5719.4 5723.7 5464.0 5567.3 5594.2 5616.7 5621.2 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#1] ext.html Cycles:180 Average:57289.74 Median:42332.18 stddev:114962.30 (271.6%) stddev-sans-first:115205.93 09:18:17 INFO - PROCESS | 9880 | Values: 573.6 620.7 625.8 627.7 640.7 42462.8 44195.6 44289.8 44416.6 49126.8 45812.0 46571.0 46621.3 46647.0 46739.3 9092.1 9097.0 9134.8 9161.2 9166.6 8910.3 9040.0 9074.6 9096.4 9107.5 9087.2 9104.4 9143.2 9167.2 9174.0 9011.1 9087.3 9097.4 9097.5 9117.9 8964.8 8985.8 9001.5 9026.4 9050.1 43193.8 43293.4 43674.1 43774.0 43881.8 3618.9 3655.0 3702.9 3747.7 3777.8 33550.7 33651.7 33860.5 34003.0 35212.6 4463.3 4540.1 4545.1 4579.3 4608.3 370781.0 372536.0 375169.0 375561.0 375626.0 33299.7 34717.1 53052.0 53625.2 53640.2 36791.6 37140.8 37170.6 37256.6 37323.6 14744.1 14777.9 14847.3 14855.3 15015.3 13185.8 13236.1 13267.1 13283.4 13306.0 8383.0 8410.6 8490.6 8556.5 8577.7 3255.4 3264.8 3276.9 3279.0 3294.4 1030.2 1045.7 1056.8 1178.5 1181.4 32987.3 33386.3 33464.5 33584.5 33661.0 1109.4 1142.8 1154.8 1157.6 1179.4 17359.7 17517.1 17528.0 17695.7 17708.7 159738.0 161891.0 569051.0 574354.0 576706.0 59621.7 60726.4 60767.0 60781.7 61116.4 1356.0 1360.4 1376.9 1377.9 1391.9 30515.8 32860.7 32927.0 33240.8 33482.8 52007.7 52022.0 52075.0 52267.7 52301.7 457629.0 459269.0 460197.0 462075.0 463974.0 28684.6 28932.4 29000.6 29009.0 29047.3 48891.0 49556.8 49678.5 51151.2 51286.2 42089.6 42418.0 42648.6 43177.0 44196.3 41933.8 42118.0 42193.8 43298.6 43382.8 41571.8 41674.0 42246.4 42862.6 42966.0 35949.0 37089.8 37597.4 39701.0 41262.4 27989.0 28476.1 28638.6 28730.6 28815.1 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#2] jquery.html Cycles:180 Average:28032.62 Median:22717.99 stddev:78842.17 (347.0%) stddev-sans-first:79036.00 09:18:17 INFO - PROCESS | 9880 | Values: 375.7 385.1 389.8 394.4 405.3 17116.9 18669.5 18918.9 18980.6 19144.8 17109.0 17467.9 17712.2 17732.5 17854.9 5345.7 5501.6 5561.4 5602.0 5602.7 5393.5 5409.6 5432.3 5540.9 5541.5 5360.4 5410.1 5425.1 5469.2 5480.9 5347.3 5445.8 5448.3 5481.9 5493.2 4874.3 4899.9 4903.4 4924.3 4928.2 22292.8 22380.6 22694.3 22741.7 22771.1 2421.1 2784.9 3088.7 3110.8 3121.6 14303.6 14501.0 14586.8 14666.8 14689.6 1849.5 1918.3 1943.8 1982.2 2017.7 71134.6 73186.0 74796.3 75050.2 75341.6 10031.3 10145.4 10581.3 10600.1 10783.6 14307.6 14355.1 14391.0 14454.3 14472.7 8195.2 8402.7 8418.4 8498.6 8562.6 8243.5 8324.2 8436.0 8468.4 8482.3 6497.0 6534.1 6684.2 6707.2 6747.5 1872.2 1907.4 1908.8 1916.9 1941.5 886.6 1018.2 1068.5 1109.4 1148.9 19268.6 19516.5 19992.6 20066.9 20103.2 1007.7 1008.6 1036.2 1041.1 1047.9 10607.9 11260.0 11268.2 11368.1 11432.3 457829.0 459987.0 477916.0 501609.0 503938.0 77047.6 79689.2 81192.0 81598.3 81614.0 1018.1 1025.1 1035.8 1047.7 1050.1 17220.2 17225.7 17334.7 17537.2 17569.2 37079.3 38110.0 38514.0 39527.8 39980.4 49604.8 51597.7 51704.0 52052.2 52104.7 8622.9 8626.7 8675.2 8841.6 8890.0 12187.5 13686.9 13711.7 13811.9 13928.7 12015.0 12099.5 12149.6 12173.5 12199.6 12057.6 12184.4 12324.6 12335.6 12429.6 10940.4 12328.9 12366.3 12496.3 12558.2 7442.5 7757.4 7827.6 8366.6 8557.9 8649.2 11535.3 11660.2 11827.2 11860.9 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#3] mootools.html Cycles:180 Average:5888.49 Median:4506.00 stddev:3479.13 (77.2%) stddev-sans-first:3473.10 09:18:17 INFO - PROCESS | 9880 | Values: 1477.4 1487.3 1590.0 1743.4 1760.2 7988.5 8656.8 8750.9 9313.9 9326.1 8738.2 8974.7 9016.0 9025.5 9083.4 2223.9 2253.6 2255.4 2256.3 2256.6 2232.5 2237.8 2263.3 2273.9 2277.7 2219.8 2224.2 2235.6 2243.4 2253.4 2156.5 2170.1 2179.4 2185.4 2193.9 2180.4 2189.7 2191.3 2192.5 2195.8 9096.9 9122.2 9146.8 9157.3 9204.5 4888.8 5041.1 5049.2 5053.2 5054.0 3108.8 3181.4 3272.7 3293.2 3301.8 1027.9 1045.4 1049.8 1053.8 1055.9 12696.8 12700.2 12703.4 12712.8 12743.9 4299.6 4501.5 4510.5 4540.5 4541.2 10633.1 10700.7 10742.9 10762.8 10772.4 4847.0 5078.7 5101.3 5130.9 5131.4 4017.6 4411.3 4417.8 4649.0 4665.5 3706.5 3726.0 3811.4 3824.3 3848.6 1129.5 1137.0 1139.8 1149.6 1152.7 801.8 817.8 884.9 938.6 1002.9 5893.1 6068.4 6095.4 6136.9 6376.7 896.4 939.0 961.3 965.1 970.7 4033.5 4124.6 4165.2 4201.7 4240.2 11103.8 11434.6 11461.7 11541.8 11560.5 10967.9 11249.1 11251.7 11313.9 11382.6 8362.6 8372.8 8459.0 8481.4 8508.6 5903.9 6010.4 6085.9 6195.5 6221.8 10317.6 10560.8 10662.3 10737.7 10748.0 10700.1 10720.1 10731.7 10739.8 10870.9 7569.8 7638.3 7967.4 8057.1 8161.3 8699.1 8781.6 8791.0 8792.3 8807.2 7598.3 7833.3 7848.7 7869.9 7957.0 7838.6 7845.5 7894.2 7894.5 8040.8 6741.7 6854.4 6922.6 6941.4 7004.8 5179.2 5213.7 5324.3 5354.2 5535.0 5329.3 5402.2 5544.8 5564.5 5639.9 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#4] prototype.html Cycles:180 Average:4915.68 Median:5653.05 stddev:1475.85 (26.1%) stddev-sans-first:1439.12 09:18:17 INFO - PROCESS | 9880 | Values: 320.0 322.0 327.3 328.9 334.8 5602.9 5650.5 5668.0 5728.9 5752.2 5506.6 5518.9 5541.4 5559.1 5586.3 4074.6 4162.6 4327.6 4331.2 4334.8 4310.5 4319.1 4335.6 4338.6 4354.6 4303.0 4323.6 4326.6 4330.6 4331.7 4046.9 4266.5 4271.7 4279.9 4328.5 3705.2 3719.0 3728.7 3732.2 3739.6 5438.5 5443.6 5452.7 5458.9 5512.6 4849.4 4912.9 4916.4 4946.0 4950.5 5703.3 5814.1 5819.7 5898.9 5910.4 4058.3 4092.1 4106.8 4109.4 4112.8 5846.8 6013.0 6025.9 6037.9 6040.6 4144.2 4160.6 4164.7 4172.6 4177.3 4195.2 4202.6 4236.6 4240.6 4251.4 4692.7 4817.3 4839.0 4852.2 4925.5 5775.9 5831.7 5851.2 5870.5 5888.5 1453.5 1468.5 1472.3 1479.9 1480.0 903.3 939.3 947.6 964.1 1007.6 5569.3 5591.4 5595.8 5602.8 5655.6 5928.6 5962.9 5971.5 5985.5 6013.3 5397.6 5569.4 5668.9 5709.7 5769.9 3178.2 3191.8 3245.7 3269.9 3292.0 6071.2 6137.1 6185.3 6229.8 6284.5 6155.0 6206.0 6209.3 6275.5 6292.0 6138.2 6310.9 6324.1 6329.8 6332.6 6103.4 6115.9 6130.8 6146.2 6154.4 5897.6 6035.2 6039.7 6054.2 6056.7 6056.9 6202.6 6300.4 6313.2 6326.9 4182.3 4193.5 4198.6 4223.7 4260.3 5907.3 6030.6 6108.3 6125.5 6138.8 5849.5 5853.2 5855.4 5867.2 5891.4 5840.3 5840.4 5841.6 5894.6 5925.6 5207.8 5713.9 5759.1 5777.4 5801.8 5822.9 5871.2 5888.2 5914.3 5976.8 5468.3 5704.7 5706.9 5803.9 5842.3 09:18:17 INFO - PROCESS | 9880 | 09:18:17 INFO - PROCESS | 9880 | [#5] yui.html Cycles:180 Average:20958.86 Median:3999.02 stddev:29873.39 (747.0%) stddev-sans-first:29918.50 09:18:17 INFO - PROCESS | 9880 | Values: 711.6 730.6 758.3 812.2 876.3 15184.2 16048.4 16055.9 16304.6 16870.7 14697.2 14781.3 14878.2 14905.9 14947.2 666.3 778.0 787.1 790.2 796.4 760.6 764.2 767.1 768.7 769.9 784.1 790.3 795.2 796.0 801.2 789.2 791.4 794.0 794.1 798.0 588.0 590.6 593.2 593.7 595.0 15279.4 15328.6 15380.1 15391.3 15416.3 15471.5 15812.5 15843.7 15915.2 16122.2 11866.6 11986.8 12114.8 12311.7 12481.8 3936.8 3988.2 4009.8 4017.6 4073.7 78137.0 79154.2 79648.0 79651.6 80064.6 11267.4 11705.8 11736.2 11780.2 11849.4 22981.9 23069.7 23190.8 23194.1 23212.0 8788.7 8883.6 8986.7 9044.3 9109.5 5005.6 5015.6 5049.6 5064.4 5179.3 3701.7 3820.3 3829.4 3833.5 3852.8 627.6 634.0 641.8 642.1 647.4 574.8 690.3 704.6 769.8 777.7 10167.6 10192.4 10242.6 10291.2 10476.7 599.5 626.9 656.0 656.7 682.7 4973.5 4989.7 5104.4 5161.1 5197.2 112637.8 115740.0 116103.8 118059.0 118375.0 61031.7 103570.0 103900.0 104065.0 104888.5 54749.0 85820.6 88739.0 90091.0 90885.0 9417.4 9421.6 9589.1 9604.1 9640.4 51755.2 52418.5 52739.0 53806.7 53980.5 68625.7 68759.7 75441.6 77538.6 77934.6 12444.3 12504.1 12541.5 12913.0 13001.1 13830.2 13916.3 13950.8 14093.5 14213.5 11906.4 11946.2 11996.6 12997.2 13241.8 12359.7 12732.6 13394.3 14468.9 14973.3 14390.9 14789.9 15039.1 15428.8 15777.4 12052.9 12282.9 12351.7 12510.4 12789.9 12215.5 12237.6 12429.8 12520.4 12633.9 09:18:17 INFO - PROCESS | 9880 | -------- Summary: end -------- 09:18:17 INFO - PROCESS | 9880 | 09:18:18 INFO - TEST-INFO | 9880: exit 0 09:18:18 INFO - TEST-OK | dromaeo_css | took 1110335ms 09:18:18 INFO - TEST-START | kraken 09:18:18 INFO - operating with platform_type : linux_ 09:18:18 INFO - Initialising browser for kraken test... 09:18:18 INFO - TEST-INFO | started process 10115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV9hS7/profile http://localhost:48438/getInfo.html) 09:18:22 INFO - PROCESS | 10115 | __metrics Screen width/height:1600/1200 09:18:22 INFO - PROCESS | 10115 | colorDepth:24 09:18:22 INFO - PROCESS | 10115 | Browser inner width/height: 1024/697 09:18:22 INFO - PROCESS | 10115 | __metrics 09:18:23 ERROR - PROCESS | 10115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:18:24 INFO - TEST-INFO | 10115: exit 0 09:18:24 INFO - Browser initialized. 09:18:24 INFO - Running cycle 1/1 for kraken test... 09:18:24 INFO - TEST-INFO | started process 10234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV9hS7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:35 INFO - PROCESS | 10234 | RSS: Main: 185528320 09:18:35 INFO - PROCESS | 10234 | 09:18:38 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48438/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:39 INFO - PROCESS | 10234 | RSS: Main: 191549440 09:18:39 INFO - PROCESS | 10234 | 09:18:42 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48438/tests/kraken/driver.html?testName=audio-dft) 09:18:42 INFO - PROCESS | 10234 | RSS: Main: 190373888 09:18:42 INFO - PROCESS | 10234 | 09:18:45 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48438/tests/kraken/driver.html?testName=audio-fft) 09:18:46 INFO - PROCESS | 10234 | RSS: Main: 185262080 09:18:46 INFO - PROCESS | 10234 | 09:18:48 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48438/tests/kraken/driver.html?testName=audio-oscillator) 09:18:49 INFO - PROCESS | 10234 | RSS: Main: 186249216 09:18:49 INFO - PROCESS | 10234 | 09:18:51 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:51 INFO - PROCESS | 10234 | RSS: Main: 186691584 09:18:51 INFO - PROCESS | 10234 | 09:18:54 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48438/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:55 INFO - PROCESS | 10234 | RSS: Main: 186638336 09:18:55 INFO - PROCESS | 10234 | 09:18:59 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48438/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:59 INFO - PROCESS | 10234 | RSS: Main: 184242176 09:18:59 INFO - PROCESS | 10234 | 09:19:02 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48438/tests/kraken/driver.html?testName=json-parse-financial) 09:19:03 INFO - PROCESS | 10234 | RSS: Main: 185696256 09:19:03 INFO - PROCESS | 10234 | 09:19:04 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:05 INFO - PROCESS | 10234 | RSS: Main: 186265600 09:19:05 INFO - PROCESS | 10234 | 09:19:07 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:07 INFO - PROCESS | 10234 | RSS: Main: 186576896 09:19:07 INFO - PROCESS | 10234 | 09:19:09 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:10 INFO - PROCESS | 10234 | RSS: Main: 186904576 09:19:10 INFO - PROCESS | 10234 | 09:19:13 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:13 INFO - PROCESS | 10234 | RSS: Main: 186826752 09:19:13 INFO - PROCESS | 10234 | 09:19:16 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:17 INFO - PROCESS | 10234 | RSS: Main: 186396672 09:19:17 INFO - PROCESS | 10234 | 09:19:18 INFO - PROCESS | 10234 | Cycle 1(1): loaded http://localhost:48438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48438/tests/kraken/driver.html?testName=ai-astar) 09:19:19 INFO - PROCESS | 10234 | RSS: Main: 187904000 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | __start_tp_report 09:19:19 INFO - PROCESS | 10234 | _x_x_mozilla_page_load 09:19:19 INFO - PROCESS | 10234 | _x_x_mozilla_page_load_details 09:19:19 INFO - PROCESS | 10234 | |i|pagename|runs| 09:19:19 INFO - PROCESS | 10234 | |0;ai-astar;113;107;115;112;113;114;115;113;113;115 09:19:19 INFO - PROCESS | 10234 | |1;audio-beat-detection;156;128;157;186;139;151;161;130;195;142 09:19:19 INFO - PROCESS | 10234 | |2;audio-dft;162;162;163;164;165;178;163;163;162;164 09:19:19 INFO - PROCESS | 10234 | |3;audio-fft;76;74;74;161;77;76;74;77;166;78 09:19:19 INFO - PROCESS | 10234 | |4;audio-oscillator;86;85;140;87;85;84;135;85;85;162 09:19:19 INFO - PROCESS | 10234 | |5;imaging-gaussian-blur;116;117;118;118;119;118;118;119;119;118 09:19:19 INFO - PROCESS | 10234 | |6;imaging-darkroom;147;147;147;149;149;147;146;147;146;147 09:19:19 INFO - PROCESS | 10234 | |7;imaging-desaturate;97;97;95;95;96;96;96;97;96;97 09:19:19 INFO - PROCESS | 10234 | |8;json-parse-financial;54;53;55;56;56;56;54;56;55;56 09:19:19 INFO - PROCESS | 10234 | |9;json-stringify-tinderbox;63;62;63;63;62;61;62;62;62;68 09:19:19 INFO - PROCESS | 10234 | |10;stanford-crypto-aes;82;80;79;85;86;82;82;81;107;82 09:19:19 INFO - PROCESS | 10234 | |11;stanford-crypto-ccm;134;126;125;138;127;132;141;125;135;124 09:19:19 INFO - PROCESS | 10234 | |12;stanford-crypto-pbkdf2;164;164;161;169;168;166;168;162;161;167 09:19:19 INFO - PROCESS | 10234 | |13;stanford-crypto-sha256-iterative;69;64;67;65;65;64;66;64;65;63 09:19:19 INFO - PROCESS | 10234 | __end_tp_report 09:19:19 INFO - PROCESS | 10234 | __start_cc_report 09:19:19 INFO - PROCESS | 10234 | _x_x_mozilla_cycle_collect,917 09:19:19 INFO - PROCESS | 10234 | __end_cc_report 09:19:19 INFO - PROCESS | 10234 | __startTimestamp1466180359120__endTimestamp 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | ------- Summary: start ------- 09:19:19 INFO - PROCESS | 10234 | Number of tests: 14 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:2.36 (2.1%) stddev-sans-first:2.50 09:19:19 INFO - PROCESS | 10234 | Values: 113.0 107.0 115.0 112.0 113.0 114.0 115.0 113.0 113.0 115.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:156.50 stddev:22.10 (14.1%) stddev-sans-first:23.43 09:19:19 INFO - PROCESS | 10234 | Values: 156.0 128.0 157.0 186.0 139.0 151.0 161.0 130.0 195.0 142.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:4.81 (2.9%) stddev-sans-first:5.01 09:19:19 INFO - PROCESS | 10234 | Values: 162.0 162.0 163.0 164.0 165.0 178.0 163.0 163.0 162.0 164.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:37.04 (48.7%) stddev-sans-first:38.76 09:19:19 INFO - PROCESS | 10234 | Values: 76.0 74.0 74.0 161.0 77.0 76.0 74.0 77.0 166.0 78.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.95 (35.2%) stddev-sans-first:31.10 09:19:19 INFO - PROCESS | 10234 | Values: 86.0 85.0 140.0 87.0 85.0 84.0 135.0 85.0 85.0 162.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 09:19:19 INFO - PROCESS | 10234 | Values: 116.0 117.0 118.0 118.0 119.0 118.0 118.0 119.0 119.0 118.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 09:19:19 INFO - PROCESS | 10234 | Values: 147.0 147.0 147.0 149.0 149.0 147.0 146.0 147.0 146.0 147.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 09:19:19 INFO - PROCESS | 10234 | Values: 97.0 97.0 95.0 95.0 96.0 96.0 96.0 97.0 96.0 97.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.10 (2.0%) stddev-sans-first:1.09 09:19:19 INFO - PROCESS | 10234 | Values: 54.0 53.0 55.0 56.0 56.0 56.0 54.0 56.0 55.0 56.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.50 stddev:1.93 (3.1%) stddev-sans-first:2.05 09:19:19 INFO - PROCESS | 10234 | Values: 63.0 62.0 63.0 63.0 62.0 61.0 62.0 62.0 62.0 68.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:8.14 (9.9%) stddev-sans-first:8.58 09:19:19 INFO - PROCESS | 10234 | Values: 82.0 80.0 79.0 85.0 86.0 82.0 82.0 81.0 107.0 82.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:133.00 stddev:6.11 (4.6%) stddev-sans-first:6.36 09:19:19 INFO - PROCESS | 10234 | Values: 134.0 126.0 125.0 138.0 127.0 132.0 141.0 125.0 135.0 124.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.50 stddev:3.02 (1.8%) stddev-sans-first:3.18 09:19:19 INFO - PROCESS | 10234 | Values: 164.0 164.0 161.0 169.0 168.0 166.0 168.0 162.0 161.0 167.0 09:19:19 INFO - PROCESS | 10234 | 09:19:19 INFO - PROCESS | 10234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.20 09:19:19 INFO - PROCESS | 10234 | Values: 69.0 64.0 67.0 65.0 65.0 64.0 66.0 64.0 65.0 63.0 09:19:19 INFO - PROCESS | 10234 | -------- Summary: end -------- 09:19:19 INFO - PROCESS | 10234 | 09:19:20 INFO - TEST-INFO | 10234: exit 0 09:19:20 INFO - TEST-OK | kraken | took 61951ms 09:19:20 INFO - SUITE-END | took 1172s 09:19:20 INFO - Completed test suite (00:19:32) 09:19:20 INFO - javascript benchmark 09:19:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.654881952008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.749060075194, 3163.7310828579584, 3167.6357218919825, 3181.2206009527667, 3189.856456459459, 5383.757730902109, 5424.755885985131, 5428.1586354115125, 5490.56075513959, 5571.220029195906, 5381.327334083239, 5399.0, 5435.592330575203, 5442.591805614575, 5460.972695136528, 4877.341558889549, 4913.729744864031, 5038.269450929613, 5078.13671675816, 5125.436202017775, 672.916248537016, 4844.006978569385, 4849.636277279218, 4943.505649435046, 5036.874078148039, 4884.023195360925, 4908.361912951329, 4912.950870491303, 4915.16442204826, 4929.2359684248995, 4912.410510738699, 4914.066327397783, 4919.950800491985, 4928.457869634373, 4934.629902757308, 4863.756812159413, 4898.926516102261, 4910.116179087763, 4941.258811178316, 4963.875903102451, 5366.892662146735, 5461.617686761928, 5481.369642491125, 5484.2596249506205, 5514.145307477347, 5657.1514272858985, 5682.289713785777, 5777.682227477487, 5826.300843898717, 5835.328937172195, 5784.68184249866, 5813.854653633693, 5818.301803783531, 5856.00447923854, 5903.763849446017, 5441.347038355383, 5447.101228297326, 5447.509724124809, 5451.318585176853, 5460.180972854064, 5859.1797148399255, 5874.941250587525, 5938.881222375615, 5940.31686356066, 5941.22764040672, 5727.627704199213, 5770.42295770428, 5772.855678608068, 5775.364709881909, 5828.825135245865, 5804.535637149018, 5828.388019257917, 5829.154772557956, 5842.59101862874, 5852.619579727304, 5663.207150998864, 5748.712564371848, 5796.130580412888, 5828.6211396259105, 5874.794382196688, 5852.122181672783, 5855.443732845458, 5897.174395584621, 5911.704414779244, 5921.230240068763, 4434.179676759745, 4448.421705178306, 4458.286674132123, 4468.240399132155, 4483.686141970096, 3897.3179693553516, 3897.824597893102, 3933.252681990413, 3951.980240098781, 3954.8220330085214, 5368.677879327175, 5448.346198456211, 5478.58910581708, 5550.084236101079, 5628.887422251532, 5903.734331955073, 5912.733926973297, 5912.99479088556, 5917.349091599921, 5917.408259174048, 5495.065838807413, 5519.365272993577, 5610.7194640268635, 5616.859578510488, 5623.915641265385, 5013.824516141917, 5044.192929131322, 5046.26829109777, 5046.419661738873, 5089.185730283137, 5983.341832398432, 6029.758809647653, 6042.818715438544, 6048.032314829607, 6049.485793707496, 5697.658140511582, 5781.0, 5790.392008839011, 5795.855103622274, 5862.677552734555, 6005.399460054135, 6007.8197654070445, 6017.037274036134, 6028.758849645965, 6049.425304596057, 5750.424957504216, 5754.6547207167705, 5756.453136951983, 5756.798512052058, 5761.971190144022, 5721.399253078367, 5838.153467747068, 5865.120231965239, 5890.204822348928, 5925.555583331181, 5660.349059858169, 5745.482906538432, 5752.68360240174, 5753.597248192586, 5758.971205143947, 5631.352394474688, 5755.53955683536, 5762.078067509178, 5764.855878602901, 5772.797952071825, 5517.944820551743, 5558.388577256579, 5584.301962254718, 5588.050031494737, 5611.298587676541, 5654.3497497788285, 5715.0, 5716.628419152742, 5719.399463056319, 5723.6851973141875, 5464.0, 5567.276254086943, 5594.1608758686525, 5616.66300022, 5621.156826476062], "value": 5339.072306676702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5726883471814, 620.7144713431821, 625.8153844615838, 627.7426255235351, 640.7020735358058, 42462.787686061565, 44195.558044419544, 44289.778551107236, 44416.55583444165, 49126.75436622812, 45812.0, 46571.0, 46621.30068048974, 46647.0, 46739.29891051637, 9092.136247056536, 9097.044810294923, 9134.817303653923, 9161.221296189799, 9166.633334666605, 8910.287177025855, 9040.0, 9074.63701451941, 9096.408733432305, 9107.499087550183, 9087.182153606174, 9104.36269461138, 9143.177114059734, 9167.220786233145, 9173.95413022934, 9011.053839346872, 9087.31845111616, 9097.40866843653, 9097.454152750855, 9117.863232051524, 8964.775880602972, 8985.820283594292, 9001.504917229615, 9026.368154229207, 9050.094990500964, 43193.78403107996, 43293.35059974071, 43674.12651746979, 43774.0, 43881.78059109716, 3618.945715814265, 3654.9817250913843, 3702.8518859245596, 3747.7220505506684, 3777.773333599993, 33550.664493355, 33651.663483365344, 33860.492092618384, 34003.0, 35212.64787352119, 4463.288108539498, 4540.069285796404, 4545.068261006486, 4579.267317229227, 4608.28571571407, 370781.0, 372536.0, 375168.99999999726, 375561.0, 375626.0, 33299.66700333014, 34717.13207169841, 53052.0, 53625.19562206492, 53640.195397069074, 36791.63208367935, 37140.81429592835, 37170.62829371672, 37256.62743372586, 37323.62676373201, 14744.115353078849, 14777.926110369379, 14847.2576371181, 14855.2572371381, 15015.324310406058, 13185.802212966813, 13236.07347485686, 13267.137636053625, 13283.402246898913, 13306.0, 8382.958085209657, 8410.579471026424, 8490.575471226413, 8556.529390883437, 8577.699780507652, 3255.3814775192636, 3264.771465997357, 3276.918077048093, 3279.0326853578254, 3294.374068926896, 1030.1964467715195, 1045.6653870761284, 1056.8414737789394, 1178.4991378664033, 1181.3679681370425, 32987.3402531948, 33386.332273354885, 33464.49803252953, 33584.49623255653, 33661.0, 1109.3732041396586, 1142.7714457108611, 1154.7979103656994, 1157.5774842182543, 1179.351356753782, 17359.652806944043, 17517.124143793015, 17528.0, 17695.73456398155, 17708.734368984475, 159738.0, 161891.0, 569051.0, 574354.0, 576706.0, 59621.701891490266, 60726.39273607296, 60767.0, 60781.69609152014, 61116.38883611196, 1355.9932200338935, 1360.4014233737123, 1376.9242691652055, 1377.8553251908606, 1391.8886489080646, 30515.847420762755, 32860.67139328672, 32927.0, 33240.83379583087, 33482.83258583691, 52007.73996129995, 52022.0, 52075.0, 52267.73866130645, 52301.7384913073, 457629.0, 459269.0, 460197.0, 462075.0, 463974.0, 28684.569731454463, 28932.42135157327, 29000.564991524723, 29009.0, 29047.273818154714, 48891.0, 49556.75221623869, 49678.503214968834, 51151.23273150831, 51286.23070654018, 42089.57910420857, 42418.0, 42648.5735142657, 43177.0, 44196.337054944845, 41933.79033104937, 42118.0, 42193.78903105465, 43298.567014330714, 43382.78308608437, 41571.7921410391, 41674.0, 42246.366304506075, 42862.57137428586, 42966.0, 35949.0, 37089.814550927076, 37597.436038458894, 39701.0, 41262.38106428466, 27989.0, 28476.145715628565, 28638.57042144411, 28730.569041464812, 28815.135545933656], "value": 19228.486953746105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7181023757479, 385.0950266872849, 389.8499077855026, 394.422171518725, 405.26849037487324, 17116.91441542792, 18669.533261668465, 18918.90540547299, 18980.62038759224, 19144.808551914477, 17109.0, 17467.912660436712, 17712.20295086721, 17732.46802595921, 17854.910725446356, 5345.705986170749, 5501.614886957915, 5561.360443548983, 5602.0, 5602.719864006804, 5393.514583687467, 5409.594280428964, 5432.293801805759, 5540.86147846303, 5541.501264886159, 5360.410354860962, 5410.134378499441, 5425.077736784756, 5469.15228139639, 5480.945190548084, 5347.331583552056, 5445.782168713246, 5448.318960129984, 5481.917771233395, 5493.23094766733, 4874.268859671042, 4899.926501102486, 4903.387076615423, 4924.261360795909, 4928.162212423861, 22292.777072229394, 22380.552388952292, 22694.319170424915, 22741.658875116886, 22771.08915643389, 2421.116292553223, 2784.9443011139865, 3088.722015018659, 3110.848985875218, 3121.59419275495, 14303.642408939755, 14501.0, 14586.781198282035, 14666.779998300033, 14689.559313220621, 1849.5468610190455, 1918.2614693343023, 1943.834774044208, 1982.2269314967175, 2017.7376940997724, 71134.64432677804, 73186.0, 74796.25203747947, 75050.24949750488, 75341.62329188373, 10031.347962382422, 10145.442000690033, 10581.259311848251, 10600.098991585648, 10783.6225732099, 14307.57077287683, 14355.066920650124, 14390.992630515973, 14454.277286135652, 14472.710545789025, 8195.221453961864, 8402.663893444194, 8418.368622353348, 8498.575071246412, 8562.571871406404, 8243.546604936786, 8324.167583241628, 8435.957820210982, 8468.364872634576, 8482.321414286966, 6496.967515162489, 6534.117894084333, 6684.231313399021, 6707.1616047994, 6747.527673062937, 1872.1949561688605, 1907.3515004898402, 1908.7900330963582, 1916.9233230670895, 1941.5437372217518, 886.5744442667556, 1018.2007124407453, 1068.524506594558, 1109.4009235013164, 1148.9195756297147, 19268.614627707368, 19516.512087197934, 19992.60014799696, 20066.89966550158, 20103.19587216524, 1007.7279134633608, 1008.5663164839043, 1036.212478516333, 1041.146260066738, 1047.8847326794046, 10607.893921060844, 11260.016304455881, 11268.211225214156, 11368.090552755759, 11432.256903301259, 457829.0, 459987.0, 477916.0, 501609.0, 503938.0, 77047.61476192583, 79689.20310796934, 81192.0, 81598.28932318768, 81614.0, 1018.1142406106586, 1025.1491262252312, 1035.8394448860438, 1047.6804574604666, 1050.1283934334483, 17220.225089870735, 17225.708071894907, 17334.73997890058, 17537.210825512626, 17569.209385577935, 37079.25841483209, 38110.0, 38514.0, 39527.80236098801, 39980.40029399503, 49604.75197623989, 51597.7420112897, 51704.0, 52052.21921671102, 52104.73947630238, 8622.913770862462, 8626.698065567674, 8675.175858293453, 8841.646334146562, 8890.022097569134, 12187.51249949992, 13686.931565342109, 13711.725765484834, 13811.930940345233, 13928.721425571635, 12015.0, 12099.455524501594, 12149.635510934686, 12173.513059477522, 12199.634010979686, 12057.638270851889, 12184.390780461119, 12324.630261092181, 12335.629931102081, 12429.627111186679, 10940.39827809478, 12328.876711232773, 12366.319852408204, 12496.250224986166, 12558.246505209716, 7442.479026468095, 7757.3794096473275, 7827.569483678452, 8366.581670916552, 8557.887474628258, 8649.178328058824, 11535.307881527135, 11660.242084264495, 11827.231229970368, 11860.881391185978], "value": 9263.489209687403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.446740588884, 1487.286102670718, 1590.0459724165503, 1743.3810997096039, 1760.2255007796578, 7988.520688758664, 8656.826863462727, 8750.91249087509, 9313.860292095616, 9326.067393260679, 8738.213560779528, 8974.730758077252, 9015.954920225406, 9025.503597302146, 9083.364164508486, 2223.8888055597236, 2253.6056190166737, 2255.3684968208845, 2256.311824893407, 2256.593813113639, 2232.464208589935, 2237.776222377757, 2263.3436303472054, 2273.9090436382526, 2277.7152855893014, 2219.755826859044, 2224.22152246714, 2235.61994460942, 2243.383069655841, 2253.4141123307895, 2156.5255643758346, 2170.066871245364, 2179.3897708641607, 2185.366243789307, 2193.890305484719, 2180.4221881201493, 2189.715337006179, 2191.2878314547834, 2192.48476607997, 2195.802377786007, 9096.862892138482, 9122.179003889682, 9146.817063658757, 9157.313201509913, 9204.493752843591, 4888.804447822083, 5041.117804384218, 5049.166887463564, 5053.216751403538, 5054.039732450822, 3108.751299896003, 3181.443247431713, 3272.672732726732, 3293.1602441377536, 3301.8018918864946, 1027.8509616105623, 1045.409343720803, 1049.8425236214553, 1053.8419237114417, 1055.9472026398726, 12696.80954785679, 12700.237985720887, 12703.428345724464, 12712.809307860389, 12743.936280318632, 4299.570042995675, 4501.527339629357, 4510.481294651157, 4540.477845047796, 4541.159885421208, 10633.096186824207, 10700.732481688021, 10742.89257107419, 10762.78474430507, 10772.407517586607, 4846.95153048465, 5078.7206703631655, 5101.311322971352, 5130.897382052338, 5131.435542090367, 4017.5580686124504, 4411.2941929291155, 4417.823287068545, 4648.953510464852, 4665.5101214372, 3706.499622550975, 3725.9627403725617, 3811.4282857571034, 3824.2542704172974, 3848.5766565677754, 1129.491728722062, 1136.9658910232706, 1139.811931031387, 1149.5861489863642, 1152.688774031007, 801.7514570483169, 817.7751118442357, 884.9380743108296, 938.6057855700623, 1002.8896821349646, 5893.11603259506, 6068.423499767515, 6095.420935011255, 6136.864680034208, 6376.681165941684, 896.4128495835238, 939.0, 961.2694352292308, 965.0831709875646, 970.6942313171328, 4033.495813023372, 4124.649404800625, 4165.16696660663, 4201.684873634428, 4240.1519696060295, 11103.83344249837, 11434.599789007345, 11461.71345716347, 11541.826872596917, 11560.479778409823, 10967.890321096846, 11249.10007199422, 11251.662450126509, 11313.886861131448, 11382.601608943647, 8362.623681934327, 8372.832543348977, 8459.0, 8481.363897707697, 8508.61711222984, 5903.881922361443, 6010.368911264254, 6085.939140608714, 6195.473384762346, 6221.844453888508, 10317.587296508056, 10560.841587376042, 10662.306950048222, 10737.731556711145, 10748.032677059102, 10700.090492308242, 10720.088792452729, 10731.731706707395, 10739.785204296026, 10870.891291087304, 7569.810754731176, 7638.274363935418, 7967.4024448167775, 8057.0734365548715, 8161.3062889652665, 8699.08659590759, 8781.604827782892, 8790.956045219733, 8792.296616270554, 8807.207351338411, 7598.316151546387, 7833.295003449717, 7848.725294614661, 7869.881951770613, 7957.045154581488, 7838.568878711498, 7845.529268243924, 7894.21057894206, 7894.486858354188, 8040.798980025312, 6741.662916854236, 6854.383105520527, 6922.619255940972, 6941.444684425132, 7004.824879377852, 5179.249008893765, 5213.687178769286, 5324.307839980777, 5354.196870469461, 5535.003699334158, 5329.280547126088, 5402.216678581663, 5544.75048622821, 5564.4713752193475, 5639.943600563942], "value": 4624.523177243752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.9712025917667, 321.97585181111424, 327.2603915151757, 328.853660121246, 334.7857371282378, 5602.943970560294, 5650.491455768985, 5668.0, 5728.914066288999, 5752.15930902111, 5506.614536982413, 5518.91721624176, 5541.418151094137, 5559.138333558305, 5586.273784408031, 4074.5925407459313, 4162.625363717265, 4327.567243275663, 4331.242032644291, 4334.84828031019, 4310.52584215736, 4319.078010285424, 4335.56644335567, 4338.587834155766, 4354.608085272325, 4302.97848510757, 4323.632491238249, 4326.572231163725, 4330.610245077943, 4331.7400955942585, 4046.9190616187657, 4266.466691663542, 4271.67962402821, 4279.850205242801, 4328.523862375137, 3705.184859330943, 3718.995871114811, 3728.664420202195, 3732.234891847192, 3739.6260373962386, 5438.456154384569, 5443.591730620219, 5452.655358195974, 5458.890822183574, 5512.641678290898, 4849.393825771778, 4912.852614421573, 4916.387627554821, 4945.950540494585, 4950.455449900508, 5703.287089113861, 5814.127880817869, 5819.6508209507565, 5898.941010589925, 5910.408959104056, 4058.3303754880408, 4092.058826469899, 4106.753594784323, 4109.383592461125, 4112.753234805891, 5846.7953621623465, 6012.96993515034, 6025.9096113558335, 6037.939620603782, 6040.607360521596, 4144.150449157915, 4160.583941605876, 4164.666826653921, 4172.561881002512, 4177.289860723684, 4195.244855925902, 4202.558731333227, 4236.576342365739, 4240.597143271384, 4251.4260574822, 4692.671512994058, 4817.301491283744, 4839.0, 4852.1508735971065, 4925.532074452921, 5775.94224057754, 5831.679257640871, 5851.239338886003, 5870.530357571384, 5888.499477544457, 1453.5203382883835, 1468.5153899213235, 1472.3227315434806, 1479.9408023679148, 1480.0083943757709, 903.3495882964255, 939.3236869453982, 947.6067432015636, 964.1419136968104, 1007.6271779441654, 5569.275994120739, 5591.41290164535, 5595.776168953278, 5602.831915042555, 5655.604107712421, 5928.584999050025, 5962.910556341659, 5971.4924231439945, 5985.521158307325, 6013.338532761392, 5397.649152805134, 5569.387367389665, 5668.894565559759, 5709.685967271756, 5769.913451298234, 3178.221335772704, 3191.7817117103855, 3245.659205783406, 3269.9182520436702, 3292.0, 6071.241094863142, 6137.115555688819, 6185.319614842364, 6229.844253893689, 6284.497240220771, 6155.0, 6205.968970155121, 6209.285932117774, 6275.497960163176, 6291.9685401573615, 6138.1713468681155, 6310.905336419957, 6324.146240257598, 6329.841753956096, 6332.620042797447, 6103.359147289649, 6115.8776824462375, 6130.846728831815, 6146.200993870768, 6154.415330543591, 5897.64614123154, 6035.155078288955, 6039.728212230372, 6054.152418661303, 6056.727447264796, 6056.939430605637, 6202.627842329474, 6300.369963003663, 6313.179286692701, 6326.936730632635, 4182.330827067654, 4193.538710741877, 4198.643115335109, 4223.72545784523, 4260.339647354665, 5907.291125064848, 6030.5778595497895, 6108.328083910855, 6125.509959203164, 6138.785142520169, 5849.473547380756, 5853.239078919713, 5855.385184555731, 5867.20792692998, 5891.440313170242, 5840.328362238397, 5840.386759390203, 5841.591088623755, 5894.557908156991, 5925.614835035709, 5207.843764687065, 5713.94292055971, 5759.12043978011, 5777.3933736957015, 5801.796937107181, 5822.912656310244, 5871.2073870027, 5888.205092312483, 5914.349421563538, 5976.760929562943, 5468.28912241406, 5704.657720536781, 5706.942930570641, 5803.912941305968, 5842.3281322646735], "value": 4435.985660514147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.5766119159105, 730.5762657658559, 758.3326672528175, 812.2162113560415, 876.2858270509536, 15184.164870932094, 16048.43830465934, 16055.919720401382, 16304.59238519036, 16870.746938795928, 14697.191654459028, 14781.334839932202, 14878.181700006522, 14905.925470372633, 14947.177905215209, 666.3037126203129, 777.9533228006338, 787.0869791042392, 790.1663744749287, 796.4424902568196, 760.6158889760691, 764.1594246329049, 767.110152223421, 768.6694721269852, 769.8845173224005, 784.0826233307016, 790.2532107158737, 795.2246559604397, 796.024869534821, 801.1707882341777, 789.2423273657296, 791.4380789639363, 793.9841203175962, 794.1105961323326, 797.9985118676083, 588.0414923674426, 590.5688847141568, 593.2317648645015, 593.717983957621, 595.0063394131811, 15279.388824447009, 15328.616784580474, 15380.077195368314, 15391.307391167424, 15416.306266218047, 15471.458498952483, 15812.525624231292, 15843.683126337408, 15915.20423978808, 16122.193890305438, 11866.58466953661, 11986.760264794655, 12114.757704845853, 12311.69220769479, 12481.75036499274, 3936.7637941723588, 3988.222296652154, 4009.8195581198916, 4017.5982401759884, 4073.674106071507, 78137.0, 79154.20845791526, 79648.0, 79651.60174199092, 80064.59967700124, 11267.436628168558, 11705.765884682258, 11736.178467507192, 11780.17538772295, 11849.407529623657, 22981.885090574775, 23069.653955190686, 23190.7680923192, 23194.072237110326, 23212.0, 8788.692395766118, 8883.600237989305, 8986.68546600866, 9044.321675874337, 9109.544522773835, 5005.649604527721, 5015.598752099823, 5049.6465247432325, 5064.392272927273, 5179.300794392784, 3701.685356744707, 3820.331441997639, 3829.3872980323013, 3833.5399752029375, 3852.788096654711, 627.6359711367396, 633.9746410143634, 641.8170821315996, 642.1106767127469, 647.3946859686208, 574.7614739882986, 690.268315585481, 704.5807744392181, 769.8344855856018, 777.7394572818056, 10167.644132455329, 10192.388456692623, 10242.59029638821, 10291.176705863512, 10476.738081548023, 599.5233789137646, 626.8996960486392, 655.9639219842859, 656.6585375604659, 682.7030241844814, 4973.52751488608, 4989.650724449326, 5104.387473503203, 5161.096808058574, 5197.194434862602, 112637.80492072851, 115740.0, 116103.77533011035, 118059.0, 118375.0, 61031.69484152551, 103570.0, 103900.0, 104065.0, 104888.47555762173, 54749.0, 85820.57089714636, 88739.0, 90091.0, 90885.0, 9417.434953902788, 9421.62313507452, 9589.089036541518, 9604.08761167688, 9640.373375730836, 51755.22367164571, 52418.475815241356, 52739.0, 53806.73096634492, 53980.460195399115, 68625.65687171533, 68759.65620171867, 75441.62279188569, 77538.6123069381, 77934.61032694801, 12444.253344799341, 12504.124711270488, 12541.49834006666, 12913.0, 13001.089923705249, 13830.170189788645, 13916.282599903114, 13950.79073813914, 14093.506727264497, 14213.502527411905, 11906.40467976615, 11946.163768536118, 11996.64010079699, 12997.220166790023, 13241.801372979606, 12359.69100772488, 12732.618021459371, 13394.263315517741, 14468.85531144675, 14973.326200320795, 14390.928045359706, 14789.92605037011, 15039.097654140787, 15428.84571154319, 15777.447789327318, 12052.939735301268, 12282.938585307016, 12351.69120771988, 12510.374481276081, 12789.872101278868, 12215.511379544718, 12237.59982818812, 12429.75140497203, 12520.373981300716, 12633.873661263637], "value": 7646.349810864656, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 115.0, 112.0, 113.0, 114.0, 115.0, 113.0, 113.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 157.0, 186.0, 139.0, 151.0, 161.0, 130.0, 195.0, 142.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 165.0, 178.0, 163.0, 163.0, 162.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 161.0, 77.0, 76.0, 74.0, 77.0, 166.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 140.0, 87.0, 85.0, 84.0, 135.0, 85.0, 85.0, 162.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 149.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 56.0, 56.0, 56.0, 54.0, 56.0, 55.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 68.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 85.0, 86.0, 82.0, 82.0, 81.0, 107.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 125.0, 138.0, 127.0, 132.0, 141.0, 125.0, 135.0, 124.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 169.0, 168.0, 166.0, 168.0, 162.0, 161.0, 167.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 67.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 63.0], "value": 65.2, "unit": "score"}]}]} 09:19:20 INFO - Return code: 0 09:19:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:19:20 ERROR - # TBPL SUCCESS # 09:19:20 INFO - Running post-action listener: _resource_record_post_action 09:19:20 INFO - ##### 09:19:20 INFO - ##### Finished run-tests step (success) 09:19:20 INFO - ##### 09:19:20 INFO - Running post-run listener: _resource_record_post_run 09:19:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 550334464; Read time: 0; Write time: 505048 09:19:20 INFO - TinderboxPrint: CPU usage
13.4% 09:19:20 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:19:20 INFO - TinderboxPrint: I/O write bytes / time
550,334,464 / 505,048 09:19:20 INFO - TinderboxPrint: CPU idle
8,217.2 (86.6%) 09:19:20 INFO - TinderboxPrint: CPU user
1,217.5 (12.8%) 09:19:20 INFO - TinderboxPrint: Swap in / out
0 / 0 09:19:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255508480; Read time: 0; Write time: 260532 09:19:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294825984; Read time: 0; Write time: 244516 09:19:21 INFO - Running post-run listener: _upload_blobber_files 09:19:21 INFO - Blob upload gear active. 09:19:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:21 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 09:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:19:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:22 INFO - (blobuploader) - INFO - Done attempting. 09:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:23 INFO - (blobuploader) - INFO - Done attempting. 09:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:27 INFO - (blobuploader) - INFO - Done attempting. 09:19:27 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:27 INFO - Return code: 0 09:19:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d92b20dc8efc5ea25e40cae012ec140bcd34381b3c0edc70d0db84a606f8f8dc906a41312c49436d64c080e256f579a4e8edd79f41fddb0e961ceed053c30a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/970df51168b4ab0644d216d80f0a736ac2553e0a80af71fc16643368cb4bfa6286b0936e13bf3d166079e1743ae1783c74a69c60954a900f2b83d40b0d9c2dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83f5d86de19f6df20f795bacb1342961aba0d7f406261244c631c9b97f5cc2d3fc6e65ca445486efcf500ce96804de59f4fc4151bef7975a0d7cf6ae6d74b4bf"} 09:19:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:27 INFO - Contents: 09:19:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d92b20dc8efc5ea25e40cae012ec140bcd34381b3c0edc70d0db84a606f8f8dc906a41312c49436d64c080e256f579a4e8edd79f41fddb0e961ceed053c30a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/970df51168b4ab0644d216d80f0a736ac2553e0a80af71fc16643368cb4bfa6286b0936e13bf3d166079e1743ae1783c74a69c60954a900f2b83d40b0d9c2dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83f5d86de19f6df20f795bacb1342961aba0d7f406261244c631c9b97f5cc2d3fc6e65ca445486efcf500ce96804de59f4fc4151bef7975a0d7cf6ae6d74b4bf"} 09:19:27 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:27 INFO - Copying logs to upload dir... 09:19:27 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.044535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-17 09:19:27.260322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:19:27.264191) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d92b20dc8efc5ea25e40cae012ec140bcd34381b3c0edc70d0db84a606f8f8dc906a41312c49436d64c080e256f579a4e8edd79f41fddb0e961ceed053c30a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/970df51168b4ab0644d216d80f0a736ac2553e0a80af71fc16643368cb4bfa6286b0936e13bf3d166079e1743ae1783c74a69c60954a900f2b83d40b0d9c2dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83f5d86de19f6df20f795bacb1342961aba0d7f406261244c631c9b97f5cc2d3fc6e65ca445486efcf500ce96804de59f4fc4151bef7975a0d7cf6ae6d74b4bf"} build_url:https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/Ab6q7HsCTmOX3FTpH1fZgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d92b20dc8efc5ea25e40cae012ec140bcd34381b3c0edc70d0db84a606f8f8dc906a41312c49436d64c080e256f579a4e8edd79f41fddb0e961ceed053c30a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/970df51168b4ab0644d216d80f0a736ac2553e0a80af71fc16643368cb4bfa6286b0936e13bf3d166079e1743ae1783c74a69c60954a900f2b83d40b0d9c2dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83f5d86de19f6df20f795bacb1342961aba0d7f406261244c631c9b97f5cc2d3fc6e65ca445486efcf500ce96804de59f4fc4151bef7975a0d7cf6ae6d74b4bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:19:27.294498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:19:27.294872) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466176828.27604-1418274086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:19:27.377423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:19:27.377747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:19:27.378036) ========= ========= Total master_lag: 0.18 =========