builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1465124412.09 results: success (0) buildid: 20160605013013 builduid: c01353401bba4020b7bed5b2414784b2 revision: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.093386) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.093788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.094055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.116103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.116444) ========= 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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 04:00:13-- 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.1M=0s 2016-06-05 04:00:14 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.244307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.244624) ========= 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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014158 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.294057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 04:00:12.294384) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 --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 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 --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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 04:00:14,202 truncating revision to first 12 chars 2016-06-05 04:00:14,202 Setting DEBUG logging. 2016-06-05 04:00:14,202 attempt 1/10 2016-06-05 04:00:14,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a08f1841ee0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 04:00:15,083 unpacking tar archive at: mozilla-inbound-4a08f1841ee0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234063 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 04:00:13.541562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.541903) ========= script_repo_revision: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.542311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.542599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.553552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-05 04:00:13.553939) ========= /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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:15 INFO - MultiFileLogger online at 20160605 04:00:15 in /builds/slave/test 04:00:15 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 04:00:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:15 INFO - {'append_to_log': False, 04:00:15 INFO - 'base_work_dir': '/builds/slave/test', 04:00:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:00:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:15 INFO - 'branch': 'Mozilla-Inbound', 04:00:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:15 INFO - 'config_files': ('talos/linux_config.py',), 04:00:15 INFO - 'default_actions': ('clobber', 04:00:15 INFO - 'read-buildbot-config', 04:00:15 INFO - 'download-and-extract', 04:00:15 INFO - 'populate-webroot', 04:00:15 INFO - 'create-virtualenv', 04:00:15 INFO - 'install', 04:00:15 INFO - 'run-tests'), 04:00:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:15 INFO - 'download_minidump_stackwalk': True, 04:00:15 INFO - 'download_symbols': 'ondemand', 04:00:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:15 INFO - 'installer_path': 'installer.exe', 04:00:15 INFO - 'log_level': 'info', 04:00:15 INFO - 'log_name': 'talos', 04:00:15 INFO - 'log_to_console': True, 04:00:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:15 INFO - 'opt_config_files': (), 04:00:15 INFO - 'pip_index': False, 04:00:15 INFO - 'sps_profile': False, 04:00:15 INFO - 'sps_profile_interval': 0, 04:00:15 INFO - 'suite': 'dromaeojs-e10s', 04:00:15 INFO - 'system_bits': '32', 04:00:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:15 INFO - 'title': 'talos-linux64-ix-025', 04:00:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:15 INFO - 'use_talos_json': True, 04:00:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:15 INFO - 'work_dir': 'build'} 04:00:15 INFO - ##### 04:00:15 INFO - ##### Running clobber step. 04:00:15 INFO - ##### 04:00:15 INFO - Running pre-action listener: _resource_record_pre_action 04:00:15 INFO - Running main action method: clobber 04:00:15 INFO - rmtree: /builds/slave/test/build 04:00:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:16 INFO - Running post-action listener: _resource_record_post_action 04:00:16 INFO - ##### 04:00:16 INFO - ##### Finished clobber step (success) 04:00:16 INFO - ##### 04:00:16 INFO - ##### 04:00:16 INFO - ##### Running read-buildbot-config step. 04:00:16 INFO - ##### 04:00:16 INFO - Running pre-action listener: _resource_record_pre_action 04:00:16 INFO - Running main action method: read_buildbot_config 04:00:16 INFO - Using buildbot properties: 04:00:16 INFO - { 04:00:16 INFO - "project": "", 04:00:16 INFO - "product": "firefox", 04:00:16 INFO - "script_repo_revision": "production", 04:00:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:00:16 INFO - "repository": "", 04:00:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:00:16 INFO - "buildid": "20160605013013", 04:00:16 INFO - "pgo_build": "True", 04:00:16 INFO - "basedir": "/builds/slave/test", 04:00:16 INFO - "buildnumber": 661, 04:00:16 INFO - "slavename": "talos-linux64-ix-025", 04:00:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:00:16 INFO - "platform": "ubuntu64_hw", 04:00:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:00:16 INFO - "branch": "mozilla-inbound", 04:00:16 INFO - "repo_path": "integration/mozilla-inbound", 04:00:16 INFO - "revision": "4a08f1841ee0422cd2b4f4a0eb2de16f93576757", 04:00:16 INFO - "stage_platform": "linux64-pgo", 04:00:16 INFO - "builduid": "c01353401bba4020b7bed5b2414784b2", 04:00:16 INFO - "slavebuilddir": "test" 04:00:16 INFO - } 04:00:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:00:16 INFO - Running post-action listener: _resource_record_post_action 04:00:16 INFO - ##### 04:00:16 INFO - ##### Finished read-buildbot-config step (success) 04:00:16 INFO - ##### 04:00:16 INFO - ##### 04:00:16 INFO - ##### Running download-and-extract step. 04:00:16 INFO - ##### 04:00:16 INFO - Running pre-action listener: _resource_record_pre_action 04:00:16 INFO - Running main action method: download_and_extract 04:00:16 INFO - mkdir: /builds/slave/test/build/tests 04:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:16 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:00:20 INFO - Downloaded 1361 bytes. 04:00:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:20 INFO - Using the following test package requirements: 04:00:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:00:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:00:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'jsshell-linux-x86_64.zip'], 04:00:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:00:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:00:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:00:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:00:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:00:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:20 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:21 INFO - Downloaded 24442327 bytes. 04:00:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:22 INFO - Return code: 0 04:00:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:00: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')]} 04:00:22 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:29 INFO - Downloaded 24442327 bytes. 04:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:31 INFO - Return code: 0 04:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:31 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:00:33 INFO - Downloaded 10833369 bytes. 04:00:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:00:33 INFO - Return code: 0 04:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:33 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:00:35 INFO - Downloaded 59151950 bytes. 04:00:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:35 INFO - mkdir: /builds/slave/test/properties 04:00:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:35 INFO - Contents: 04:00:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:35 INFO - Running post-action listener: _resource_record_post_action 04:00:35 INFO - Running post-action listener: set_extra_try_arguments 04:00:35 INFO - ##### 04:00:35 INFO - ##### Finished download-and-extract step (success) 04:00:35 INFO - ##### 04:00:35 INFO - ##### 04:00:35 INFO - ##### Running populate-webroot step. 04:00:35 INFO - ##### 04:00:35 INFO - Running pre-action listener: _resource_record_pre_action 04:00:35 INFO - Running main action method: populate_webroot 04:00:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:35 INFO - '--tppagecycles', 04:00:35 INFO - '7'], 04:00:35 INFO - 'tests': ['tsvgm']}}, 04:00:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['damp', 'tps']}, 04:00:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'tests': ['damp', 'tps']}, 04:00:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['dromaeo_dom']}, 04:00:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['a11yr', 04:00:35 INFO - 'ts_paint', 04:00:35 INFO - 'tpaint', 04:00:35 INFO - 'sessionrestore', 04:00:35 INFO - 'sessionrestore_no_auto_restore', 04:00:35 INFO - 'tabpaint']}, 04:00:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['tsvgx', 04:00:35 INFO - 'tsvgr_opacity', 04:00:35 INFO - 'tart', 04:00:35 INFO - 'tscrollx', 04:00:35 INFO - 'cart']}, 04:00:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:35 INFO - 'tsvgr_opacity', 04:00:35 INFO - 'tart', 04:00:35 INFO - 'tscrollx', 04:00:35 INFO - 'cart']}, 04:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'talos_options': ['--disable-e10s'], 04:00:35 INFO - 'tests': ['tp5o']}, 04:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'tests': ['tp5o']}, 04:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'talos_options': ['--disable-e10s', 04:00:35 INFO - '--xperf_path', 04:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:35 INFO - 'tests': ['tp5n']}, 04:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:35 INFO - 'talos_options': ['--xperf_path', 04:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:35 INFO - 'tests': ['tp5n']}}, 04:00:35 INFO - 'talos.zip': {'path': '', 04:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:35 INFO - Running post-action listener: _resource_record_post_action 04:00:35 INFO - ##### 04:00:35 INFO - ##### Finished populate-webroot step (success) 04:00:35 INFO - ##### 04:00:35 INFO - ##### 04:00:35 INFO - ##### Running create-virtualenv step. 04:00:35 INFO - ##### 04:00:35 INFO - Running pre-action listener: _resource_record_pre_action 04:00:35 INFO - Running main action method: create_virtualenv 04:00:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:36 INFO - Using real prefix '/usr' 04:00:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:38 INFO - Installing pip.................done. 04:00:38 INFO - Return code: 0 04:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:00:38 INFO - Using env: {'DISPLAY': ':0', 04:00:38 INFO - 'HOME': '/home/cltbld', 04:00:38 INFO - 'LANG': 'en_US.UTF-8', 04:00:38 INFO - 'LANGUAGE': 'en_US:en', 04:00:38 INFO - 'LOGNAME': 'cltbld', 04:00:38 INFO - 'MAIL': '/var/mail/cltbld', 04:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:38 INFO - 'MOZ_NO_REMOTE': '1', 04:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:38 INFO - 'NO_EM_RESTART': '1', 04:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:38 INFO - 'PWD': '/builds/slave/test', 04:00:38 INFO - 'SHELL': '/bin/bash', 04:00:38 INFO - 'SHLVL': '1', 04:00:38 INFO - 'TERM': 'linux', 04:00:38 INFO - 'TMOUT': '86400', 04:00:38 INFO - 'USER': 'cltbld', 04:00:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:38 INFO - '_': '/tools/buildbot/bin/python'} 04:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:00:38 INFO - Cleaning up... 04:00:38 INFO - Return code: 0 04:00:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:00:38 INFO - Using env: {'DISPLAY': ':0', 04:00:38 INFO - 'HOME': '/home/cltbld', 04:00:38 INFO - 'LANG': 'en_US.UTF-8', 04:00:38 INFO - 'LANGUAGE': 'en_US:en', 04:00:38 INFO - 'LOGNAME': 'cltbld', 04:00:38 INFO - 'MAIL': '/var/mail/cltbld', 04:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:38 INFO - 'MOZ_NO_REMOTE': '1', 04:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:38 INFO - 'NO_EM_RESTART': '1', 04:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:38 INFO - 'PWD': '/builds/slave/test', 04:00:38 INFO - 'SHELL': '/bin/bash', 04:00:38 INFO - 'SHLVL': '1', 04:00:38 INFO - 'TERM': 'linux', 04:00:38 INFO - 'TMOUT': '86400', 04:00:38 INFO - 'USER': 'cltbld', 04:00:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:38 INFO - '_': '/tools/buildbot/bin/python'} 04:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:38 INFO - Downloading/unpacking psutil>=3.1.1 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:41 INFO - Installing collected packages: psutil 04:00:41 INFO - Running setup.py install for psutil 04:00:41 INFO - building 'psutil._psutil_linux' extension 04:00:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:00:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:00:41 INFO - building 'psutil._psutil_posix' extension 04:00:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:00:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:41 INFO - Successfully installed psutil 04:00:41 INFO - Cleaning up... 04:00:41 INFO - Return code: 0 04:00:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:41 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:00:41 INFO - Using env: {'DISPLAY': ':0', 04:00:41 INFO - 'HOME': '/home/cltbld', 04:00:41 INFO - 'LANG': 'en_US.UTF-8', 04:00:41 INFO - 'LANGUAGE': 'en_US:en', 04:00:41 INFO - 'LOGNAME': 'cltbld', 04:00:41 INFO - 'MAIL': '/var/mail/cltbld', 04:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:41 INFO - 'MOZ_NO_REMOTE': '1', 04:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:41 INFO - 'NO_EM_RESTART': '1', 04:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:41 INFO - 'PWD': '/builds/slave/test', 04:00:41 INFO - 'SHELL': '/bin/bash', 04:00:41 INFO - 'SHLVL': '1', 04:00:41 INFO - 'TERM': 'linux', 04:00:41 INFO - 'TMOUT': '86400', 04:00:41 INFO - 'USER': 'cltbld', 04:00:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:41 INFO - '_': '/tools/buildbot/bin/python'} 04:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:43 INFO - Installing collected packages: mozsystemmonitor 04:00:43 INFO - Running setup.py install for mozsystemmonitor 04:00:43 INFO - Successfully installed mozsystemmonitor 04:00:43 INFO - Cleaning up... 04:00:43 INFO - Return code: 0 04:00:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:00:43 INFO - Using env: {'DISPLAY': ':0', 04:00:43 INFO - 'HOME': '/home/cltbld', 04:00:43 INFO - 'LANG': 'en_US.UTF-8', 04:00:43 INFO - 'LANGUAGE': 'en_US:en', 04:00:43 INFO - 'LOGNAME': 'cltbld', 04:00:43 INFO - 'MAIL': '/var/mail/cltbld', 04:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:43 INFO - 'MOZ_NO_REMOTE': '1', 04:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:43 INFO - 'NO_EM_RESTART': '1', 04:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:43 INFO - 'PWD': '/builds/slave/test', 04:00:43 INFO - 'SHELL': '/bin/bash', 04:00:43 INFO - 'SHLVL': '1', 04:00:43 INFO - 'TERM': 'linux', 04:00:43 INFO - 'TMOUT': '86400', 04:00:43 INFO - 'USER': 'cltbld', 04:00:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:43 INFO - '_': '/tools/buildbot/bin/python'} 04:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:46 INFO - warning: no files found matching '*.txt' 04:00:46 INFO - no previously-included directories found matching 'build' 04:00:46 INFO - no previously-included directories found matching 'dist' 04:00:46 INFO - no previously-included directories found matching '.git*' 04:00:46 INFO - Installing collected packages: jsonschema, functools32 04:00:46 INFO - Running setup.py install for functools32 04:00:46 INFO - warning: no files found matching '*.txt' 04:00:46 INFO - no previously-included directories found matching 'build' 04:00:46 INFO - no previously-included directories found matching 'dist' 04:00:46 INFO - no previously-included directories found matching '.git*' 04:00:46 INFO - Successfully installed jsonschema functools32 04:00:46 INFO - Cleaning up... 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:46 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:49 INFO - Downloading docopt-0.6.1.tar.gz 04:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:49 INFO - Running setup.py install for blobuploader 04:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:49 INFO - Running setup.py install for requests 04:00:49 INFO - Running setup.py install for docopt 04:00:49 INFO - Successfully installed blobuploader requests docopt 04:00:49 INFO - Cleaning up... 04:00:49 INFO - Return code: 0 04:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:49 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:49 INFO - Using env: {'DISPLAY': ':0', 04:00:49 INFO - 'HOME': '/home/cltbld', 04:00:49 INFO - 'LANG': 'en_US.UTF-8', 04:00:49 INFO - 'LANGUAGE': 'en_US:en', 04:00:49 INFO - 'LOGNAME': 'cltbld', 04:00:49 INFO - 'MAIL': '/var/mail/cltbld', 04:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:49 INFO - 'MOZ_NO_REMOTE': '1', 04:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:49 INFO - 'NO_EM_RESTART': '1', 04:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:49 INFO - 'PWD': '/builds/slave/test', 04:00:49 INFO - 'SHELL': '/bin/bash', 04:00:49 INFO - 'SHLVL': '1', 04:00:49 INFO - 'TERM': 'linux', 04:00:49 INFO - 'TMOUT': '86400', 04:00:49 INFO - 'USER': 'cltbld', 04:00:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:49 INFO - '_': '/tools/buildbot/bin/python'} 04:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:50 INFO - Running setup.py (path:/tmp/pip-5DsMuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:50 INFO - Running setup.py (path:/tmp/pip-L0Mt5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:50 INFO - Running setup.py (path:/tmp/pip-zoqiFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:50 INFO - Running setup.py (path:/tmp/pip-zqCvpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:50 INFO - Running setup.py (path:/tmp/pip-zNCc8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:50 INFO - Running setup.py (path:/tmp/pip-f184_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:50 INFO - Running setup.py (path:/tmp/pip-SN0Awj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:50 INFO - Running setup.py (path:/tmp/pip-YNR_l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:50 INFO - Running setup.py (path:/tmp/pip-EDt95G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:50 INFO - Running setup.py (path:/tmp/pip-rt_s10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:50 INFO - Running setup.py (path:/tmp/pip-IsucOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:50 INFO - Running setup.py (path:/tmp/pip-Vr2jNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:50 INFO - Running setup.py (path:/tmp/pip-OEz6gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:51 INFO - Running setup.py (path:/tmp/pip-vUFEP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:51 INFO - Running setup.py (path:/tmp/pip-Hadh9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:51 INFO - Running setup.py (path:/tmp/pip-aj1jC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:51 INFO - Running setup.py (path:/tmp/pip-89suSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:51 INFO - Running setup.py install for manifestparser 04:00:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozcrash 04:00:51 INFO - Running setup.py install for mozdebug 04:00:51 INFO - Running setup.py install for mozdevice 04:00:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozfile 04:00:51 INFO - Running setup.py install for mozhttpd 04:00:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozinfo 04:00:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:51 INFO - Running setup.py install for mozInstall 04:00:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozleak 04:00:52 INFO - Running setup.py install for mozlog 04:00:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for moznetwork 04:00:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozprocess 04:00:52 INFO - Running setup.py install for mozprofile 04:00:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozrunner 04:00:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:52 INFO - Running setup.py install for mozscreenshot 04:00:52 INFO - Running setup.py install for moztest 04:00:52 INFO - Running setup.py install for mozversion 04:00:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:53 INFO - Cleaning up... 04:00:53 INFO - Return code: 0 04:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:53 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:53 INFO - Using env: {'DISPLAY': ':0', 04:00:53 INFO - 'HOME': '/home/cltbld', 04:00:53 INFO - 'LANG': 'en_US.UTF-8', 04:00:53 INFO - 'LANGUAGE': 'en_US:en', 04:00:53 INFO - 'LOGNAME': 'cltbld', 04:00:53 INFO - 'MAIL': '/var/mail/cltbld', 04:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:53 INFO - 'MOZ_NO_REMOTE': '1', 04:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:53 INFO - 'NO_EM_RESTART': '1', 04:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:53 INFO - 'PWD': '/builds/slave/test', 04:00:53 INFO - 'SHELL': '/bin/bash', 04:00:53 INFO - 'SHLVL': '1', 04:00:53 INFO - 'TERM': 'linux', 04:00:53 INFO - 'TMOUT': '86400', 04:00:53 INFO - 'USER': 'cltbld', 04:00:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:53 INFO - '_': '/tools/buildbot/bin/python'} 04:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:53 INFO - Running setup.py (path:/tmp/pip-aBgf2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:53 INFO - Running setup.py (path:/tmp/pip-XJTuIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:53 INFO - Running setup.py (path:/tmp/pip-NbmlZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:53 INFO - Running setup.py (path:/tmp/pip-EQaB8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:53 INFO - Running setup.py (path:/tmp/pip-xHI2Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:53 INFO - Running setup.py (path:/tmp/pip-vchYHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:53 INFO - Running setup.py (path:/tmp/pip-Ht1Elc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:53 INFO - Running setup.py (path:/tmp/pip-cpXAyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:53 INFO - Running setup.py (path:/tmp/pip-x8PcRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:53 INFO - Running setup.py (path:/tmp/pip-BkNeNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:54 INFO - Running setup.py (path:/tmp/pip-o14MIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:54 INFO - Running setup.py (path:/tmp/pip-TXf98q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:54 INFO - Running setup.py (path:/tmp/pip-UhgbsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:54 INFO - Running setup.py (path:/tmp/pip-r1pycK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:54 INFO - Running setup.py (path:/tmp/pip-V7YbUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:54 INFO - Running setup.py (path:/tmp/pip-3iHUG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:54 INFO - Running setup.py (path:/tmp/pip-9G17O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:56 INFO - Downloading blessings-1.6.tar.gz 04:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:56 INFO - Installing collected packages: blessings 04:00:56 INFO - Running setup.py install for blessings 04:00:56 INFO - Successfully installed blessings 04:00:56 INFO - Cleaning up... 04:00:56 INFO - Return code: 0 04:00:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:56 INFO - Reading from file tmpfile_stdout 04:00:56 INFO - Current package versions: 04:00:56 INFO - argparse == 1.2.1 04:00:56 INFO - blessings == 1.6 04:00:56 INFO - blobuploader == 1.2.4 04:00:56 INFO - docopt == 0.6.1 04:00:56 INFO - functools32 == 3.2.3-2 04:00:56 INFO - jsonschema == 2.5.1 04:00:56 INFO - manifestparser == 1.1 04:00:56 INFO - mozInstall == 1.12 04:00:56 INFO - mozcrash == 0.17 04:00:56 INFO - mozdebug == 0.1 04:00:56 INFO - mozdevice == 0.48 04:00:56 INFO - mozfile == 1.2 04:00:56 INFO - mozhttpd == 0.7 04:00:56 INFO - mozinfo == 0.9 04:00:56 INFO - mozleak == 0.1 04:00:56 INFO - mozlog == 3.2 04:00:56 INFO - moznetwork == 0.27 04:00:56 INFO - mozprocess == 0.22 04:00:56 INFO - mozprofile == 0.28 04:00:56 INFO - mozrunner == 6.11 04:00:56 INFO - mozscreenshot == 0.1 04:00:56 INFO - mozsystemmonitor == 0.3 04:00:56 INFO - moztest == 0.7 04:00:56 INFO - mozversion == 1.4 04:00:56 INFO - psutil == 3.1.1 04:00:56 INFO - requests == 1.2.3 04:00:56 INFO - wsgiref == 0.1.2 04:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:56 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:56 INFO - Using env: {'DISPLAY': ':0', 04:00:56 INFO - 'HOME': '/home/cltbld', 04:00:56 INFO - 'LANG': 'en_US.UTF-8', 04:00:56 INFO - 'LANGUAGE': 'en_US:en', 04:00:56 INFO - 'LOGNAME': 'cltbld', 04:00:56 INFO - 'MAIL': '/var/mail/cltbld', 04:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:56 INFO - 'MOZ_NO_REMOTE': '1', 04:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:56 INFO - 'NO_EM_RESTART': '1', 04:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:56 INFO - 'PWD': '/builds/slave/test', 04:00:56 INFO - 'SHELL': '/bin/bash', 04:00:56 INFO - 'SHLVL': '1', 04:00:56 INFO - 'TERM': 'linux', 04:00:56 INFO - 'TMOUT': '86400', 04:00:56 INFO - 'USER': 'cltbld', 04:00:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:56 INFO - '_': '/tools/buildbot/bin/python'} 04:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:00:57 INFO - Cleaning up... 04:00:57 INFO - Return code: 0 04:00:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:57 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:00:57 INFO - Using env: {'DISPLAY': ':0', 04:00:57 INFO - 'HOME': '/home/cltbld', 04:00:57 INFO - 'LANG': 'en_US.UTF-8', 04:00:57 INFO - 'LANGUAGE': 'en_US:en', 04:00:57 INFO - 'LOGNAME': 'cltbld', 04:00:57 INFO - 'MAIL': '/var/mail/cltbld', 04:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:57 INFO - 'MOZ_NO_REMOTE': '1', 04:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:57 INFO - 'NO_EM_RESTART': '1', 04:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:57 INFO - 'PWD': '/builds/slave/test', 04:00:57 INFO - 'SHELL': '/bin/bash', 04:00:57 INFO - 'SHLVL': '1', 04:00:57 INFO - 'TERM': 'linux', 04:00:57 INFO - 'TMOUT': '86400', 04:00:57 INFO - 'USER': 'cltbld', 04:00:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:57 INFO - '_': '/tools/buildbot/bin/python'} 04:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:57 INFO - Cleaning up... 04:00:57 INFO - Return code: 0 04:00:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:57 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 0x7fb1630dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, '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': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:00:57 INFO - Using env: {'DISPLAY': ':0', 04:00:57 INFO - 'HOME': '/home/cltbld', 04:00:57 INFO - 'LANG': 'en_US.UTF-8', 04:00:57 INFO - 'LANGUAGE': 'en_US:en', 04:00:57 INFO - 'LOGNAME': 'cltbld', 04:00:57 INFO - 'MAIL': '/var/mail/cltbld', 04:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:57 INFO - 'MOZ_NO_REMOTE': '1', 04:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:57 INFO - 'NO_EM_RESTART': '1', 04:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:57 INFO - 'PWD': '/builds/slave/test', 04:00:57 INFO - 'SHELL': '/bin/bash', 04:00:57 INFO - 'SHLVL': '1', 04:00:57 INFO - 'TERM': 'linux', 04:00:57 INFO - 'TMOUT': '86400', 04:00:57 INFO - 'USER': 'cltbld', 04:00:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:57 INFO - '_': '/tools/buildbot/bin/python'} 04:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:57 INFO - Downloading/unpacking flake8 04:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:00 INFO - no previously-included directories found matching 'docs/_build' 04:01:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:00 INFO - Running setup.py install for pep8 04:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:00 INFO - no previously-included directories found matching 'docs/_build' 04:01:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:00 INFO - Cleaning up... 04:01:00 INFO - Return code: 0 04:01:00 INFO - Running post-action listener: _resource_record_post_action 04:01:00 INFO - Running post-action listener: _start_resource_monitoring 04:01:00 INFO - Starting resource monitoring. 04:01:00 INFO - ##### 04:01:00 INFO - ##### Finished create-virtualenv step (success) 04:01:00 INFO - ##### 04:01:00 INFO - ##### 04:01:00 INFO - ##### Running install step. 04:01:00 INFO - ##### 04:01:00 INFO - Running pre-action listener: _resource_record_pre_action 04:01:00 INFO - Running main action method: install 04:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:00 INFO - Reading from file tmpfile_stdout 04:01:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:00 INFO - Reading from file tmpfile_stdout 04:01:00 INFO - Output received: 04:01:00 INFO - Usage: mozinstall [options] installer 04:01:00 INFO - Options: 04:01:00 INFO - -h, --help show this help message and exit 04:01:00 INFO - -d DEST, --destination=DEST 04:01:00 INFO - Directory to install application into. [default: 04:01:00 INFO - "/builds/slave/test"] 04:01:00 INFO - --app=APP Application being installed. [default: firefox] 04:01:00 INFO - mkdir: /builds/slave/test/build/application 04:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:01:17 INFO - Reading from file tmpfile_stdout 04:01:17 INFO - Output received: 04:01:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:17 INFO - Running post-action listener: _resource_record_post_action 04:01:17 INFO - ##### 04:01:17 INFO - ##### Finished install step (success) 04:01:17 INFO - ##### 04:01:17 INFO - ##### 04:01:17 INFO - ##### Running run-tests step. 04:01:17 INFO - ##### 04:01:17 INFO - Running pre-action listener: _resource_record_pre_action 04:01:17 INFO - Running main action method: run_tests 04:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:17 INFO - Python 2.7.3 04:01:17 INFO - Return code: 0 04:01:17 INFO - grabbing minidump binary from tooltool 04:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:17 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 0x2aa62e0>, '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 0x2a12140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:01:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:01:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:01:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:17 INFO - Return code: 0 04:01:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:01:18 INFO - Return code: 0 04:01:18 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:01:18 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 04:01:18 INFO - Using env: {'DISPLAY': ':0', 04:01:18 INFO - 'HOME': '/home/cltbld', 04:01:18 INFO - 'LANG': 'en_US.UTF-8', 04:01:18 INFO - 'LANGUAGE': 'en_US:en', 04:01:18 INFO - 'LOGNAME': 'cltbld', 04:01:18 INFO - 'MAIL': '/var/mail/cltbld', 04:01:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:18 INFO - 'MOZ_NO_REMOTE': '1', 04:01:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:18 INFO - 'NO_EM_RESTART': '1', 04:01:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:18 INFO - 'PWD': '/builds/slave/test', 04:01:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:18 INFO - 'SHELL': '/bin/bash', 04:01:18 INFO - 'SHLVL': '1', 04:01:18 INFO - 'TERM': 'linux', 04:01:18 INFO - 'TMOUT': '86400', 04:01:18 INFO - 'USER': 'cltbld', 04:01:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465123083.715265-884554080', 04:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:18 INFO - '_': '/tools/buildbot/bin/python'} 04:01:18 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:01:18 INFO - mozversion application_buildid: 20160605013013 04:01:18 INFO - mozversion application_changeset: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 04:01:18 INFO - mozversion application_display_name: Nightly 04:01:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:18 INFO - mozversion application_name: Firefox 04:01:18 INFO - mozversion application_remotingname: firefox 04:01:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:18 INFO - mozversion application_vendor: Mozilla 04:01:18 INFO - mozversion application_version: 49.0a1 04:01:18 INFO - mozversion platform_buildid: 20160605013013 04:01:18 INFO - mozversion platform_changeset: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 04:01:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:18 INFO - mozversion platform_version: 49.0a1 04:01:18 INFO - using testdate: 1465124478 04:01:18 INFO - actual date: 1465124478 04:01:18 INFO - starting webserver on 'localhost:44934' 04:01:18 INFO - SUITE-START | Running 2 tests 04:01:18 INFO - TEST-START | dromaeo_css 04:01:18 INFO - operating with platform_type : linux_ 04:01:18 INFO - Initialising browser for dromaeo_css test... 04:01:18 INFO - TEST-INFO | started process 29811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Ft0nd/profile http://localhost:44934/getInfo.html) 04:01:23 INFO - PROCESS | 29811 | __metrics Screen width/height:1600/1200 04:01:23 INFO - PROCESS | 29811 | colorDepth:24 04:01:23 INFO - PROCESS | 29811 | Browser inner width/height: 1024/697 04:01:23 INFO - PROCESS | 29811 | __metrics 04:01:24 ERROR - PROCESS | 29811 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:01:24 INFO - TEST-INFO | 29811: exit 0 04:01:24 INFO - Browser initialized. 04:01:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:24 INFO - TEST-INFO | started process 29929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Ft0nd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:36 INFO - PROCESS | 29929 | RSS: Main: 167051264 04:01:36 INFO - PROCESS | 29929 | 04:02:26 INFO - PROCESS | 29929 | 1465124546424 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:04:34 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44934/tests/dromaeo/cssquery-ext.html) 04:04:35 INFO - PROCESS | 29929 | RSS: Main: 170598400 04:04:35 INFO - PROCESS | 29929 | 04:07:37 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-ext.html (next: http://localhost:44934/tests/dromaeo/cssquery-jquery.html) 04:07:38 INFO - PROCESS | 29929 | RSS: Main: 169766912 04:07:38 INFO - PROCESS | 29929 | 04:10:39 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44934/tests/dromaeo/cssquery-mootools.html) 04:10:40 INFO - PROCESS | 29929 | RSS: Main: 171302912 04:10:40 INFO - PROCESS | 29929 | 04:13:42 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44934/tests/dromaeo/cssquery-prototype.html) 04:13:43 INFO - PROCESS | 29929 | RSS: Main: 168726528 04:13:43 INFO - PROCESS | 29929 | 04:16:45 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44934/tests/dromaeo/cssquery-yui.html) 04:16:46 INFO - PROCESS | 29929 | RSS: Main: 170967040 04:16:46 INFO - PROCESS | 29929 | 04:19:48 INFO - PROCESS | 29929 | Cycle 1(1): loaded http://localhost:44934/tests/dromaeo/cssquery-yui.html (next: http://localhost:44934/tests/dromaeo/cssquery-dojo.html) 04:19:49 INFO - PROCESS | 29929 | RSS: Main: 171708416 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | __start_tp_report 04:19:49 INFO - PROCESS | 29929 | _x_x_mozilla_page_load 04:19:49 INFO - PROCESS | 29929 | _x_x_mozilla_page_load_details 04:19:49 INFO - PROCESS | 29929 | |i|pagename|runs| 04:19:49 INFO - PROCESS | 29929 | |0;dojo.html;3149.81101133932;3159.968400315996;3199.4241036613407;3209.2458272306003;3212.887548935788;5518.503334699876;5561.416051314609;5573.777048918044;5609.971950140243;5630.7184640768;5395;5533.059379905416;5534.225208470817;5544.805931792388;5673.205751194836;5000.849974500762;5024.648274620778;5067.594592432597;5152.896942061157;5153.3815942087;5051.090803655341;5211.817586384477;5237.612032811308;5250.6324557281005;5251.133562962106;4975.800967961313;4982.252662100677;4985.1774457214515;5008.924866127011;5095.541401273885;5032.4967503249745;5049.495050494921;5050.368703912011;5052.9242061369105;5088.0078384715;5015.448300686921;5027.949720502785;5032.798688052473;5051.747412629354;5073.39119305682;5400.162974738922;5418.891622167574;5479.369872464677;5497.422770609069;5499.3675727291475;6007.639541627516;6007.969960150215;6009.729562169713;6014.1580178775;6039.758409663608;6057.212562366864;6062.454379105901;6067.362926892657;6075.17985072014;6075.513958883279;5489;5494.066008778477;5501.477359650867;5512.586556008316;5523.502884740353;6071.726772295257;6073.362296958844;6078.300995385587;6079.939200608026;6090.299615544181;5691.715414229272;5793.478586927196;5809.419058094241;5811.099279611667;5841.532677385799;5886.970565147147;5890.263717035371;5922.200502932135;5986.610870293417;5999.850003749942;5728.770849165987;5835.79574714883;5883;5889.352171261158;5962.731677074542;5921.289445266596;5932.614380065282;5959.851003724942;5978.282606087298;5996.550258730613;4274.487061552633;4313.9137217255475;4357.43353364067;4380.583844534828;4383.473983121982;3908.3160446922243;3911.3350730375905;3922.2939870823525;3944.2505923874946;3951.130751234724;5533.22534845122;5692.658440493584;5696.686682232434;5705.686187259741;5721.113227449669;5952.464278214981;5972.611780234271;5982.0727787193055;6049.213602231682;6074.878502429927;5752.798652047159;5758.452946970031;5762.106873434541;5767.077267637158;5777.277840269966;4816.181249187646;4899.853004409873;5003.224500202475;5020.723860187724;5026.472220416877;6099.370313949917;6201.410865967726;6282.371762823681;6290.150829637941;6290.433860952537;5991.3409524953095;6000.819975400745;6006.129111278928;6045.375079465982;6098.451139397475;6035.909461358171;6134.2835184798605;6189.566730328834;6207.534434917309;6247.437730604267;5872.383399742966;5877.4122587740885;5887.587868849139;5903.793367232126;5935.940640593539;5930.258717660293;5942.10868369748;5957.702114894325;5982.940170598238;5983.252093488314;5748.425157484386;5766.048601980626;5804.100364443518;5825.271841019872;5832.358440571618;5724;5725.914111288251;5728.198052272602;5767.596268261182;5840.766369345349;5661.122526008476;5681.375048744718;5685.77256909719;5701.942980570141;5716.056850619601;5754.079347304411;5779.988502012216;5805.535557155333;5814.622049566765;5829.504492118217;5748.022836117953;5749.029857446445;5769.79805706815;5775.364709881994;5838.854028649148 04:19:49 INFO - PROCESS | 29929 | |1;ext.html;570.1049352516549;612.6293592376612;613.3314686991182;635.1045026512617;638.4190386748061;39294;43721.78139109308;43738.12523749527;43742;43803.12393752131;44278;44918.77540612292;44979.550204497944;45031;45072.54927450725;8723.520206388646;8916.420432671888;8923;8924.955375223115;8931.615599582043;8827.382083254175;8832.072632373605;8860.291176705849;8910.554472276393;8920.241779448723;8898.110188981114;8955.194032537103;8955.641774329019;8966.462012279284;8972.910270897273;8630.697925572606;8638.049814520398;8698.130186981283;8855.73432797017;8920.553972301359;8711.34664900135;8816.382853200279;8830.470171789713;8842.381033327669;8860;40072.39891401631;40853.18293634111;40995.1800963982;41017.58982410168;41066.79466602678;3348.665133486656;3433.124553238933;3482.355764183634;3589.3000864831106;4187.958120418818;32367.51448728271;32496.350072998408;32659.346813063843;33040;33557;4377.846775362879;4400.361947517624;4416.80124394403;4499.482559505634;4552.499225085238;364784;366265;367201;367215;367358.1632091849;34691;35950;59919;60181.39818601846;60342.39657603455;36665.633343666756;36877.446838297445;36888.81555592205;36907.26185476276;37091.25817483635;15333.31000104998;15335.30991105403;15359.692806143814;15435.459758908384;15491.690166196613;12475.812862807064;12519.436625351698;12587.055970802227;12614.684632884067;12631.368431578385;8291.129431409736;8369.539675317916;8393.580320983927;8425.11536288693;8438.113998030241;3226.2418331692033;3277.950830737541;3302.3725492156414;3313.8343082845763;3327.5507806446303;1042.801867645145;1057.4765491081964;1066.3974854207347;1132.881047490018;1223.7613665335175;32377;32447;32628.347433051207;33079.50380744291;33099.50350744741;1172.4899668644166;1172.9502095624368;1174.395186478964;1180.4923882730336;1348.5077946549438;16473.752893706605;16997.49007529776;17082.487525374258;17092.316307347566;17282.82717172812;582411;583384;584200;584440;585294;58129.4187058124;58437.41562584405;58560.41439585635;58822;58921.46471211741;1358.2054498118712;1385;1405.8242719660248;1415.801787749716;1418.4751641892565;29277;30072.54891176678;30351.593140905203;30499.2375190622;30846.38307233798;49447.7527612374;49492.257616135066;49975.500244997085;49988.50011499839;50000.74999624979;434494;435060;435219;435304;436057;27143.1857044289;27573.31440596286;27933.16200513988;27967.440651186454;28331;48162.759186203846;48287;48756;48866.51133488762;49510;40928.1814363717;41134.40443766927;41276.38085428781;41360.793196033825;42040.78979605205;39986;41089;41882.58117418909;41956;42053.15893682048;40050;41022.79488602538;41218.79390603028;41429.171416572106;41542.376864347665;34206.82896585601;36678.26643467169;36892.262154756216;37107;37111.628883710815;27891.860540697977;28053.579196311664;28220.294492637026;28538.85730571334;28568.142955711362 04:19:49 INFO - PROCESS | 29929 | |2;jquery.html;400.35542776130404;401.5342203044469;401.68467752814036;405.064301463619;423.4326003155771;13318.933405332984;17696.38062667807;18357.632847343044;19023.429297121074;19136.13887375068;18369;18511.90744046281;18883.811161888378;19589.706154407697;19601;5648.632838865481;5656.632318899268;5739.167820666001;5788.884222315552;5870.236869206997;5643.746031428575;5652.74562644682;5691.630044047144;5716.22830917827;5741.311042674884;5551.1118221084635;5561.249231353756;5638.238837756912;5695.259616249882;5706.7431965561445;5643.661380317153;5677.347105082927;5690.430956904318;5716.799912003081;5721.942780572203;4959.950400495985;5168.896622067575;5178.378594568639;5180.715060671661;5181.171012637998;22057.558848823093;22190.556188876293;23026;23366.299011029696;23441.41396465085;2374.952500949971;2483.714372847128;2614.9540183926392;2832.1928250448523;2914.140328603046;14067.226302553356;14147.717045659028;14303.570892873231;14730.779038314435;15039.624009399744;1918.7505624268895;1962.1954998450567;1968.5373937124764;2015.9596808063757;2029.350607805503;78508.60745696293;80890.19109808885;86198.56900715457;90776;91344;10454.268201225841;10987.340759554452;11265.94367028176;11400.631924168987;11452.255603385753;15848.366065357488;15873.365065397486;15891.682166356608;15979.840201598068;16028.11845348517;7975.60121993898;8202.917970820336;8233.34133269337;8350.79123021917;8386.371022173362;7656.349210317186;7757.9224207758325;7852.057753069668;7939.20607939213;7987.440879138405;4829.227323628203;4832.100739556308;4913;4917.852464426073;4959.156943319645;1976.6145601607836;2002.2491565662876;2007.8996050197431;2053.1068984991575;2094.225136699431;957.674390707163;968.8982656820932;980.2158273381267;1039.812833689943;1048.250500891866;19243;19425.22299108048;19543.706844397344;19680;19731.112099955535;981.9607215711292;1013.5844303835393;1014.6245889020962;1037.8910214427528;1051.6476980211714;10609.257351985441;11028;11034.062104721028;11043.558257669763;11089.112870970303;492094;496038;499153;508220;509146;91424.54287728519;96774;97257;97264;97418.51290743642;950.1591091883732;985.1822986920981;985.4038306824268;1002.8345323021765;1004.6483730694199;17364.131793410532;17494.912525437292;17526.123693815513;17631.823681763017;17636.64726705433;41757.164856703304;42439.5756042448;42864;43070.92322691833;43862.56137438585;57293.71353143208;58309;59907;60350.69824650849;60960.39039609547;7983.281504664608;8045.316148127475;8336.62485188156;8491.57542122879;8585.18440748128;9264.351495395258;12833.935830320788;13460.125091868997;13547.32263386807;13548.187108773505;11688.47401866935;12032.458539365925;12103.394830258629;12180.390980451119;12363.32001739913;11521.423928803693;11685.182037257311;11716.472758725708;11730.12024098213;11753;11991;12193.634190974284;12260.632181034583;12395.93802030984;12455.627948775484;8126.309263712651;8316.792080198044;8332.250097491255;8507.106753790762;8586.22723954847;8707.825843483222;11445.828312575484;11882.346470944181;12077.51689932393;12157.513699451923 04:19:49 INFO - PROCESS | 29929 | |3;mootools.html;1523.2155439948428;1539.1688488216364;1634.4606279927625;1769.3276554909141;1796;7727.1500134985245;8648.13518648135;8666.306695464364;9200.447973121618;9208.125228103328;8440.32477401808;8680.08859069798;8701.347398945072;8732.825343493127;8744.08187140349;2359.6224604063354;2390.151496218835;2401.255610760661;2404.158544509425;2407.4583218775724;2324.360800779782;2365.5387199496104;2369.597168481362;2383.2492764779126;2384.0106355862295;2288.599495088361;2308.884555772213;2314.67594536765;2322.883855807211;2339.649052642109;2270.5572413379396;2291.163725240292;2292.0487997481027;2318.431984163882;2326.639370897505;2333.125078095714;2372.039324073753;2395.568797616428;2402.7986006996503;2409.4578719787905;8806.075362086953;8862.689805856828;8971.237444817198;8971.461712297283;8972.641094356219;5363.329583802025;5460.153676180198;5464.398916119224;5474.507294343528;5506.366767821712;3342.715869151125;3436.7078798302173;3496.7901925884275;3498.4052711039185;3505.2113274513285;1124.162498938288;1140.3386036099043;1192.8807119288;1203.7111093337624;2184.170015394156;12066.758664826655;12613.684657883627;12681.492740290378;12686.61940141788;12718.618441446864;4526.298423744325;4616.561426664462;4629;4655.301704744248;4738.763061846894;10000.699979000641;10014.699559013241;10017.04838040385;10021.048000439947;10038;5280.207968804633;5284.445133261029;5308.628396012242;5315.388730296066;5328.547073498718;4461.442319710036;4854.441739200037;4940.827071052496;4989.226669866177;5011.57401620859;3837.270918525527;3871.9032024199055;3899.493065901415;3934.3311637021775;4001.679865610744;1134.920555561103;1152.7233463968587;1154.7690461907653;1161.4192903548226;1161.8257261410688;918.8621706744042;931.6552875436132;932.0958670090001;943.3208090175063;957.1911734584265;5746.7931734335425;5832.1834943108;6087.208662873798;6157.9384206158265;6181.196444462281;463.63372935381346;467.1777671298539;469.50936271595583;472.56287933661224;478.07969658407427;4004.5394779600138;4034.717569770147;4052.8176232069627;4054.108096218827;4079.286124928126;11232.157588180919;11488.506494155707;11596.188266821242;11619.53521859133;11631.941840290745;11370.20408571392;11485.942570287096;11497.137714671433;11501.482433290523;11522.36626985507;7927.326177274881;8261.17388261181;8406.579671016425;8523.659053637784;8541.530215838064;5835.591508594358;5873.2658417697785;5999.700014999145;6024.186734790747;6113.17472141273;9739.415635061636;10208.846867296848;10236.33463824849;10387.376757394279;10441.321314114559;10416.427096509764;10513.316634418738;10666.626668066581;10698.8930110701;10817.405042722727;7004.579725216503;7925.365970722213;8101.108878023295;8104.594770261581;8453.408261421642;8460.873086903825;8716.128387161232;8759.737207883774;8779.165979231962;8812.206901378906;7605.239476052572;7724.961375193088;7803.141654418123;7922.524648521107;7995.320397766022;7613.086429628259;7678.61606919663;7709.421793365632;7854.2145785421;7869.173736757787;6947.40947019509;6964.512484126062;6999.650017499206;7016.5088443808445;7040.155181378267;4918.48355922623;5177.689338639693;5231.581473482036;5248.422673505987;5290;5056.292119103402;5166.870828229325;5169.53474187325;5362.329708786402;5390.05674007055 04:19:49 INFO - PROCESS | 29929 | |4;prototype.html;331.80091944833106;339.18764558881475;344.74144391706204;344.85688439297695;347.6627671158975;5472.726363681815;5641.266635337411;5658.236138121352;5667.858303542408;5669.348024977129;5459.317585301837;5515.283013208277;5551.3893471718075;5558.805441809537;5566.359868615111;4015.8354077317545;4314.913701725979;4331.870043898688;4372.322290045032;4381.693281470299;4303.870883873473;4305.806238719265;4319.33050377192;4347.608765195138;4351.347297905308;4086.9386959195635;4271.829126834923;4299.806508707115;4301.311790113583;4314.697971142022;4187.20443115807;4296.591823776736;4308.655307575418;4312.1375724855;4323.1785960667685;3777.867774627875;3790.886273411802;3808.314503389389;3818.5990471000423;3827.6555110039953;5247.186686063628;5313.671582104474;5357.571394288487;5382.757775900094;5435.239066530688;4943.90112197754;4947.356843610343;4962.454130045692;4990.850274491771;4991.5258050485145;5726.656400615976;5842.415758424166;5862.853428664275;5879.265091863517;5898.380670029628;4031.8992025199314;4121.4848143982;4143;4170.457840480748;4174.62237461637;6031;6033.577649564532;6048.606840555394;6055.2430946131735;6058.606190597597;4253.149370125925;4258.127083947783;4276.743395396286;4276.893077673083;4288.614024737726;4231.87304380869;4305;4314.331278651751;4319.460067491564;4339.262325404688;4872.805087796449;4900.485449027872;4901;4917.360743103445;4981.028699403654;5788.913166302509;5821.476067153976;5821.592488525847;5828.825135245949;5874.531367158211;1458.2052781234254;1484.139199264424;1488.9404423822925;1502.2638906935742;1514.545636309103;938.8263171313329;944.5702205496483;958.1376760915093;962.3696478806393;964.9421034737938;4921.286413470027;5049.293098966147;5139.612304677716;5169.554183402271;5179.663321884065;5263.710495922761;5360.525855389721;5390.8921821563345;5409.594280428905;5433.239346491494;5149.6910185389;5445.727713614383;5624.859378515488;5689.573282003784;5711.7144142792695;3145.418097651942;3209.1335339458683;3213.7107660310685;3226.6450690424035;3237.43344914639;6057.8485537861025;6225.8132256032395;6244.843878903063;6253.6560489173535;6268.139289764085;6062.847319393979;6071.815995880761;6122.908156377658;6132.386761323832;6182.28903676083;5985.880282394328;6172.580306529434;6229.003359462555;6252.124702541648;6260.906086408708;6010.1585777991995;6046.788362407295;6060.666663333559;6066.575339726353;6089.60417572874;5964.671943043174;5971.790987315423;5995.61028533144;5998.820035398945;6009.338972712911;5948.73230704628;6166.506679465721;6203.2245969253845;6223.128761973237;6248.312685604489;4197.706160568731;4235.280002399538;4247.193033323659;4256.957430425656;4283.186194623012;5888.676122813115;6010.459058684739;6042.341369797276;6045.939540604538;6066.757329706762;5918.803845923326;5918.881622367442;5933.703314834154;5945.800053980055;5951.166836642787;5885.911711324248;5902.321233058254;5903.911441328298;5906.793262235801;5912.201852749996;5502.312210973629;5657.981563318477;5755.309362876482;5767.365589785204;5777.62445441045;5828.912566311424;5899.640143942457;5902.321233058082;5915.70421478933;5930.11048342752;5156.639035267495;5578.414266502121;5734.827955161351;5748.712564371681;5756.597038207286 04:19:49 INFO - PROCESS | 29929 | |5;yui.html;786.90557133144;789.6333276978312;791.70311133325;800.3997002248313;852.5907564369103;15124.773128403069;15870;16030.118343491104;16144.112073835964;16173.110478923669;13897.444102235924;14203.153590033282;14219.360128794204;14220.928895355535;14221.288935553206;685.759984005599;808.9231523005305;829.1873963515728;834.5243211369522;835.1106072033296;803.333233416263;827.5613924619931;829.655692887451;831.2934006094802;831.3017065664841;866.8743032260319;867.2195024477988;870.316801310971;872.9825403491926;881.039666763228;854.8888644476209;859.9656013759442;860.0066922704286;861.5519929636554;862.7670528957178;624.881272558217;625.4714766022704;625.5996162455987;625.6746491824226;626.4299487466429;15261.236938153159;15319.31063102163;15324.23378831054;15356.232188390648;15372.615684607863;15214.08715477064;15377.154256515887;15480.5355839325;15566.37734490619;15697.215139243106;11353.375564343958;11419.600313989054;11427.371494567795;11467.713307167303;11913.821292680617;3827.445020472016;3976.08550033491;3979.5622481527007;3995.582672483135;4120.835166593332;74784.25215747827;75423.24576754218;75479;75616.24383756147;78952.60523697345;11180.832287515694;11665.941670291595;11667.6499705009;11721.882781172078;11860.94069529664;23186.072557097526;23360.299191024296;23425.297241082793;23490.412739681302;23494.29517114489;8715;8721.127887211229;8796.692115775917;8907.331950103639;9032.36773425867;4845.491223421561;4846.709197448165;4874.366332376769;4942.555170034714;5037.19404895215;3524.8766293179615;3623.474596183539;3645.5078564394;3651.7808931464197;3654.835532401048;614.3672017821651;614.4040280927493;624.9125122482856;628.6165439082156;638.0301941049671;715.148972722469;722.9746958856415;749.0636704119851;749.8762704153862;763.6334559411514;10311.329763565343;10458.26792124544;10458.790824183474;10722.195835312383;10722.410267435365;607.3228350389284;750.8736894658012;767.2749251956959;805.5690205740018;821.5399376349144;4593.793279302439;4717.905641887143;4878.731669758126;4900.09348270564;4930.359053323045;67821.66089169522;101847;113227.43386283181;113783;114965.4251728736;93102.53448732848;97258.513707431;99066.5046674762;100092;101477;64682.67658661676;89733.55133224423;89915;91936.54031729799;92470.07529924749;9298.256139508958;9483;9488.470976266162;9517.09692309982;9596.952015240158;50127;51345;52218.738906305225;53332.400027999225;54678.17982730183;71733.28266717475;74881.62559187169;75350;76176.61911690405;78534.21465785497;12029.45867435985;12119.333436661069;12359.814602780785;12471.93764031174;12646.494140234288;13432.664183395493;13502.257375844423;13601.115927464683;14015.579532614038;14026.929865350608;13165.078444508792;13219.272939988008;13253.469861205444;13452.39464224132;13520.18878867271;12555.497780088694;12670.429830657828;12798.232106073665;12956.287404192482;13445.663858403617;11793.646190614296;12739.61781146567;12866.806997894852;12868.871311287141;12913.289769062792;10582.259241853304;10635.415052171895;10898.073663738354;10918.454077296263;11167.609133680282;10549.314294570828;10670.413127278074;11320.773584528428;11371.661474918763;11476.655700329004 04:19:49 INFO - PROCESS | 29929 | __end_tp_report 04:19:49 INFO - PROCESS | 29929 | __start_cc_report 04:19:49 INFO - PROCESS | 29929 | _x_x_mozilla_cycle_collect,343 04:19:49 INFO - PROCESS | 29929 | __end_cc_report 04:19:49 INFO - PROCESS | 29929 | __startTimestamp1465125589011__endTimestamp 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | ------- Summary: start ------- 04:19:49 INFO - PROCESS | 29929 | Number of tests: 6 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#0] dojo.html Cycles:165 Average:5518.53 Median:5749.03 stddev:660.74 (11.5%) stddev-sans-first:636.10 04:19:49 INFO - PROCESS | 29929 | Values: 3149.8 3160.0 3199.4 3209.2 3212.9 5518.5 5561.4 5573.8 5610.0 5630.7 5395.0 5533.1 5534.2 5544.8 5673.2 5000.8 5024.6 5067.6 5152.9 5153.4 5051.1 5211.8 5237.6 5250.6 5251.1 4975.8 4982.3 4985.2 5008.9 5095.5 5032.5 5049.5 5050.4 5052.9 5088.0 5015.4 5027.9 5032.8 5051.7 5073.4 5400.2 5418.9 5479.4 5497.4 5499.4 6007.6 6008.0 6009.7 6014.2 6039.8 6057.2 6062.5 6067.4 6075.2 6075.5 5489.0 5494.1 5501.5 5512.6 5523.5 6071.7 6073.4 6078.3 6079.9 6090.3 5691.7 5793.5 5809.4 5811.1 5841.5 5887.0 5890.3 5922.2 5986.6 5999.9 5728.8 5835.8 5883.0 5889.4 5962.7 5921.3 5932.6 5959.9 5978.3 5996.6 4274.5 4313.9 4357.4 4380.6 4383.5 3908.3 3911.3 3922.3 3944.3 3951.1 5533.2 5692.7 5696.7 5705.7 5721.1 5952.5 5972.6 5982.1 6049.2 6074.9 5752.8 5758.5 5762.1 5767.1 5777.3 4816.2 4899.9 5003.2 5020.7 5026.5 6099.4 6201.4 6282.4 6290.2 6290.4 5991.3 6000.8 6006.1 6045.4 6098.5 6035.9 6134.3 6189.6 6207.5 6247.4 5872.4 5877.4 5887.6 5903.8 5935.9 5930.3 5942.1 5957.7 5982.9 5983.3 5748.4 5766.0 5804.1 5825.3 5832.4 5724.0 5725.9 5728.2 5767.6 5840.8 5661.1 5681.4 5685.8 5701.9 5716.1 5754.1 5780.0 5805.5 5814.6 5829.5 5748.0 5749.0 5769.8 5775.4 5838.9 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#1] ext.html Cycles:180 Average:60658.01 Median:41077.90 stddev:125339.91 (305.1%) stddev-sans-first:125610.32 04:19:49 INFO - PROCESS | 29929 | Values: 570.1 612.6 613.3 635.1 638.4 39294.0 43721.8 43738.1 43742.0 43803.1 44278.0 44918.8 44979.6 45031.0 45072.5 8723.5 8916.4 8923.0 8925.0 8931.6 8827.4 8832.1 8860.3 8910.6 8920.2 8898.1 8955.2 8955.6 8966.5 8972.9 8630.7 8638.0 8698.1 8855.7 8920.6 8711.3 8816.4 8830.5 8842.4 8860.0 40072.4 40853.2 40995.2 41017.6 41066.8 3348.7 3433.1 3482.4 3589.3 4188.0 32367.5 32496.4 32659.3 33040.0 33557.0 4377.8 4400.4 4416.8 4499.5 4552.5 364784.0 366265.0 367201.0 367215.0 367358.2 34691.0 35950.0 59919.0 60181.4 60342.4 36665.6 36877.4 36888.8 36907.3 37091.3 15333.3 15335.3 15359.7 15435.5 15491.7 12475.8 12519.4 12587.1 12614.7 12631.4 8291.1 8369.5 8393.6 8425.1 8438.1 3226.2 3278.0 3302.4 3313.8 3327.6 1042.8 1057.5 1066.4 1132.9 1223.8 32377.0 32447.0 32628.3 33079.5 33099.5 1172.5 1173.0 1174.4 1180.5 1348.5 16473.8 16997.5 17082.5 17092.3 17282.8 582411.0 583384.0 584200.0 584440.0 585294.0 58129.4 58437.4 58560.4 58822.0 58921.5 1358.2 1385.0 1405.8 1415.8 1418.5 29277.0 30072.5 30351.6 30499.2 30846.4 49447.8 49492.3 49975.5 49988.5 50000.7 434494.0 435060.0 435219.0 435304.0 436057.0 27143.2 27573.3 27933.2 27967.4 28331.0 48162.8 48287.0 48756.0 48866.5 49510.0 40928.2 41134.4 41276.4 41360.8 42040.8 39986.0 41089.0 41882.6 41956.0 42053.2 40050.0 41022.8 41218.8 41429.2 41542.4 34206.8 36678.3 36892.3 37107.0 37111.6 27891.9 28053.6 28220.3 28538.9 28568.1 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#2] jquery.html Cycles:180 Average:29690.37 Median:1657.25 stddev:82716.69 (4991.2%) stddev-sans-first:82919.50 04:19:49 INFO - PROCESS | 29929 | Values: 400.4 401.5 401.7 405.1 423.4 13318.9 17696.4 18357.6 19023.4 19136.1 18369.0 18511.9 18883.8 19589.7 19601.0 5648.6 5656.6 5739.2 5788.9 5870.2 5643.7 5652.7 5691.6 5716.2 5741.3 5551.1 5561.2 5638.2 5695.3 5706.7 5643.7 5677.3 5690.4 5716.8 5721.9 4960.0 5168.9 5178.4 5180.7 5181.2 22057.6 22190.6 23026.0 23366.3 23441.4 2375.0 2483.7 2615.0 2832.2 2914.1 14067.2 14147.7 14303.6 14730.8 15039.6 1918.8 1962.2 1968.5 2016.0 2029.4 78508.6 80890.2 86198.6 90776.0 91344.0 10454.3 10987.3 11265.9 11400.6 11452.3 15848.4 15873.4 15891.7 15979.8 16028.1 7975.6 8202.9 8233.3 8350.8 8386.4 7656.3 7757.9 7852.1 7939.2 7987.4 4829.2 4832.1 4913.0 4917.9 4959.2 1976.6 2002.2 2007.9 2053.1 2094.2 957.7 968.9 980.2 1039.8 1048.3 19243.0 19425.2 19543.7 19680.0 19731.1 982.0 1013.6 1014.6 1037.9 1051.6 10609.3 11028.0 11034.1 11043.6 11089.1 492094.0 496038.0 499153.0 508220.0 509146.0 91424.5 96774.0 97257.0 97264.0 97418.5 950.2 985.2 985.4 1002.8 1004.6 17364.1 17494.9 17526.1 17631.8 17636.6 41757.2 42439.6 42864.0 43070.9 43862.6 57293.7 58309.0 59907.0 60350.7 60960.4 7983.3 8045.3 8336.6 8491.6 8585.2 9264.4 12833.9 13460.1 13547.3 13548.2 11688.5 12032.5 12103.4 12180.4 12363.3 11521.4 11685.2 11716.5 11730.1 11753.0 11991.0 12193.6 12260.6 12395.9 12455.6 8126.3 8316.8 8332.3 8507.1 8586.2 8707.8 11445.8 11882.3 12077.5 12157.5 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#3] mootools.html Cycles:180 Average:5875.50 Median:468.34 stddev:3393.18 (724.5%) stddev-sans-first:3386.94 04:19:49 INFO - PROCESS | 29929 | Values: 1523.2 1539.2 1634.5 1769.3 1796.0 7727.2 8648.1 8666.3 9200.4 9208.1 8440.3 8680.1 8701.3 8732.8 8744.1 2359.6 2390.2 2401.3 2404.2 2407.5 2324.4 2365.5 2369.6 2383.2 2384.0 2288.6 2308.9 2314.7 2322.9 2339.6 2270.6 2291.2 2292.0 2318.4 2326.6 2333.1 2372.0 2395.6 2402.8 2409.5 8806.1 8862.7 8971.2 8971.5 8972.6 5363.3 5460.2 5464.4 5474.5 5506.4 3342.7 3436.7 3496.8 3498.4 3505.2 1124.2 1140.3 1192.9 1203.7 2184.2 12066.8 12613.7 12681.5 12686.6 12718.6 4526.3 4616.6 4629.0 4655.3 4738.8 10000.7 10014.7 10017.0 10021.0 10038.0 5280.2 5284.4 5308.6 5315.4 5328.5 4461.4 4854.4 4940.8 4989.2 5011.6 3837.3 3871.9 3899.5 3934.3 4001.7 1134.9 1152.7 1154.8 1161.4 1161.8 918.9 931.7 932.1 943.3 957.2 5746.8 5832.2 6087.2 6157.9 6181.2 463.6 467.2 469.5 472.6 478.1 4004.5 4034.7 4052.8 4054.1 4079.3 11232.2 11488.5 11596.2 11619.5 11631.9 11370.2 11485.9 11497.1 11501.5 11522.4 7927.3 8261.2 8406.6 8523.7 8541.5 5835.6 5873.3 5999.7 6024.2 6113.2 9739.4 10208.8 10236.3 10387.4 10441.3 10416.4 10513.3 10666.6 10698.9 10817.4 7004.6 7925.4 8101.1 8104.6 8453.4 8460.9 8716.1 8759.7 8779.2 8812.2 7605.2 7725.0 7803.1 7922.5 7995.3 7613.1 7678.6 7709.4 7854.2 7869.2 6947.4 6964.5 6999.7 7016.5 7040.2 4918.5 5177.7 5231.6 5248.4 5290.0 5056.3 5166.9 5169.5 5362.3 5390.1 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#4] prototype.html Cycles:180 Average:4880.79 Median:5508.80 stddev:1444.48 (26.2%) stddev-sans-first:1407.60 04:19:49 INFO - PROCESS | 29929 | Values: 331.8 339.2 344.7 344.9 347.7 5472.7 5641.3 5658.2 5667.9 5669.3 5459.3 5515.3 5551.4 5558.8 5566.4 4015.8 4314.9 4331.9 4372.3 4381.7 4303.9 4305.8 4319.3 4347.6 4351.3 4086.9 4271.8 4299.8 4301.3 4314.7 4187.2 4296.6 4308.7 4312.1 4323.2 3777.9 3790.9 3808.3 3818.6 3827.7 5247.2 5313.7 5357.6 5382.8 5435.2 4943.9 4947.4 4962.5 4990.9 4991.5 5726.7 5842.4 5862.9 5879.3 5898.4 4031.9 4121.5 4143.0 4170.5 4174.6 6031.0 6033.6 6048.6 6055.2 6058.6 4253.1 4258.1 4276.7 4276.9 4288.6 4231.9 4305.0 4314.3 4319.5 4339.3 4872.8 4900.5 4901.0 4917.4 4981.0 5788.9 5821.5 5821.6 5828.8 5874.5 1458.2 1484.1 1488.9 1502.3 1514.5 938.8 944.6 958.1 962.4 964.9 4921.3 5049.3 5139.6 5169.6 5179.7 5263.7 5360.5 5390.9 5409.6 5433.2 5149.7 5445.7 5624.9 5689.6 5711.7 3145.4 3209.1 3213.7 3226.6 3237.4 6057.8 6225.8 6244.8 6253.7 6268.1 6062.8 6071.8 6122.9 6132.4 6182.3 5985.9 6172.6 6229.0 6252.1 6260.9 6010.2 6046.8 6060.7 6066.6 6089.6 5964.7 5971.8 5995.6 5998.8 6009.3 5948.7 6166.5 6203.2 6223.1 6248.3 4197.7 4235.3 4247.2 4257.0 4283.2 5888.7 6010.5 6042.3 6045.9 6066.8 5918.8 5918.9 5933.7 5945.8 5951.2 5885.9 5902.3 5903.9 5906.8 5912.2 5502.3 5658.0 5755.3 5767.4 5777.6 5828.9 5899.6 5902.3 5915.7 5930.1 5156.6 5578.4 5734.8 5748.7 5756.6 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - PROCESS | 29929 | [#5] yui.html Cycles:180 Average:20477.94 Median:4357.31 stddev:29046.80 (666.6%) stddev-sans-first:29090.65 04:19:49 INFO - PROCESS | 29929 | Values: 786.9 789.6 791.7 800.4 852.6 15124.8 15870.0 16030.1 16144.1 16173.1 13897.4 14203.2 14219.4 14220.9 14221.3 685.8 808.9 829.2 834.5 835.1 803.3 827.6 829.7 831.3 831.3 866.9 867.2 870.3 873.0 881.0 854.9 860.0 860.0 861.6 862.8 624.9 625.5 625.6 625.7 626.4 15261.2 15319.3 15324.2 15356.2 15372.6 15214.1 15377.2 15480.5 15566.4 15697.2 11353.4 11419.6 11427.4 11467.7 11913.8 3827.4 3976.1 3979.6 3995.6 4120.8 74784.3 75423.2 75479.0 75616.2 78952.6 11180.8 11665.9 11667.6 11721.9 11860.9 23186.1 23360.3 23425.3 23490.4 23494.3 8715.0 8721.1 8796.7 8907.3 9032.4 4845.5 4846.7 4874.4 4942.6 5037.2 3524.9 3623.5 3645.5 3651.8 3654.8 614.4 614.4 624.9 628.6 638.0 715.1 723.0 749.1 749.9 763.6 10311.3 10458.3 10458.8 10722.2 10722.4 607.3 750.9 767.3 805.6 821.5 4593.8 4717.9 4878.7 4900.1 4930.4 67821.7 101847.0 113227.4 113783.0 114965.4 93102.5 97258.5 99066.5 100092.0 101477.0 64682.7 89733.6 89915.0 91936.5 92470.1 9298.3 9483.0 9488.5 9517.1 9597.0 50127.0 51345.0 52218.7 53332.4 54678.2 71733.3 74881.6 75350.0 76176.6 78534.2 12029.5 12119.3 12359.8 12471.9 12646.5 13432.7 13502.3 13601.1 14015.6 14026.9 13165.1 13219.3 13253.5 13452.4 13520.2 12555.5 12670.4 12798.2 12956.3 13445.7 11793.6 12739.6 12866.8 12868.9 12913.3 10582.3 10635.4 10898.1 10918.5 11167.6 10549.3 10670.4 11320.8 11371.7 11476.7 04:19:49 INFO - PROCESS | 29929 | -------- Summary: end -------- 04:19:49 INFO - PROCESS | 29929 | 04:19:49 INFO - TEST-INFO | 29929: exit 0 04:19:49 INFO - TEST-OK | dromaeo_css | took 1110865ms 04:19:49 INFO - TEST-START | kraken 04:19:49 INFO - operating with platform_type : linux_ 04:19:49 INFO - Initialising browser for kraken test... 04:19:49 INFO - TEST-INFO | started process 30165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOj1YD/profile http://localhost:44934/getInfo.html) 04:19:54 INFO - PROCESS | 30165 | __metrics Screen width/height:1600/1200 04:19:54 INFO - PROCESS | 30165 | colorDepth:24 04:19:54 INFO - PROCESS | 30165 | Browser inner width/height: 1024/697 04:19:54 INFO - PROCESS | 30165 | __metrics 04:19:55 ERROR - PROCESS | 30165 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:19:55 INFO - TEST-INFO | 30165: exit 0 04:19:55 INFO - Browser initialized. 04:19:55 INFO - Running cycle 1/1 for kraken test... 04:19:55 INFO - TEST-INFO | started process 30284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOj1YD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:07 INFO - PROCESS | 30284 | RSS: Main: 167165952 04:20:07 INFO - PROCESS | 30284 | 04:20:10 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44934/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:11 INFO - PROCESS | 30284 | RSS: Main: 172130304 04:20:11 INFO - PROCESS | 30284 | 04:20:13 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44934/tests/kraken/driver.html?testName=audio-dft) 04:20:14 INFO - PROCESS | 30284 | RSS: Main: 171327488 04:20:14 INFO - PROCESS | 30284 | 04:20:17 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44934/tests/kraken/driver.html?testName=audio-fft) 04:20:17 INFO - PROCESS | 30284 | RSS: Main: 166625280 04:20:17 INFO - PROCESS | 30284 | 04:20:19 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44934/tests/kraken/driver.html?testName=audio-oscillator) 04:20:20 INFO - PROCESS | 30284 | RSS: Main: 167301120 04:20:20 INFO - PROCESS | 30284 | 04:20:22 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:23 INFO - PROCESS | 30284 | RSS: Main: 167415808 04:20:23 INFO - PROCESS | 30284 | 04:20:26 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44934/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:27 INFO - PROCESS | 30284 | RSS: Main: 167473152 04:20:27 INFO - PROCESS | 30284 | 04:20:30 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44934/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:31 INFO - PROCESS | 30284 | RSS: Main: 166121472 04:20:31 INFO - PROCESS | 30284 | 04:20:34 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44934/tests/kraken/driver.html?testName=json-parse-financial) 04:20:34 INFO - PROCESS | 30284 | RSS: Main: 167538688 04:20:34 INFO - PROCESS | 30284 | 04:20:36 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:36 INFO - PROCESS | 30284 | RSS: Main: 168132608 04:20:36 INFO - PROCESS | 30284 | 04:20:38 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:39 INFO - PROCESS | 30284 | RSS: Main: 167333888 04:20:39 INFO - PROCESS | 30284 | 04:20:41 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:42 INFO - PROCESS | 30284 | RSS: Main: 168091648 04:20:42 INFO - PROCESS | 30284 | 04:20:44 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:45 INFO - PROCESS | 30284 | RSS: Main: 168378368 04:20:45 INFO - PROCESS | 30284 | 04:20:47 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:48 INFO - PROCESS | 30284 | RSS: Main: 167989248 04:20:48 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | Cycle 1(1): loaded http://localhost:44934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44934/tests/kraken/driver.html?testName=ai-astar) 04:20:50 INFO - PROCESS | 30284 | RSS: Main: 168841216 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | __start_tp_report 04:20:50 INFO - PROCESS | 30284 | _x_x_mozilla_page_load 04:20:50 INFO - PROCESS | 30284 | _x_x_mozilla_page_load_details 04:20:50 INFO - PROCESS | 30284 | |i|pagename|runs| 04:20:50 INFO - PROCESS | 30284 | |0;ai-astar;111;106;112;114;110;111;110;111;109;111 04:20:50 INFO - PROCESS | 30284 | |1;audio-beat-detection;158;125;152;180;129;156;152;128;179;133 04:20:50 INFO - PROCESS | 30284 | |2;audio-dft;164;163;165;162;163;165;176;163;163;163 04:20:50 INFO - PROCESS | 30284 | |3;audio-fft;77;76;74;151;76;75;76;76;165;78 04:20:50 INFO - PROCESS | 30284 | |4;audio-oscillator;86;86;147;86;86;87;144;85;84;139 04:20:50 INFO - PROCESS | 30284 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;117;117 04:20:50 INFO - PROCESS | 30284 | |6;imaging-darkroom;147;147;146;148;149;148;147;147;148;147 04:20:50 INFO - PROCESS | 30284 | |7;imaging-desaturate;96;97;96;96;95;95;96;96;96;96 04:20:50 INFO - PROCESS | 30284 | |8;json-parse-financial;54;56;54;54;54;54;56;56;56;54 04:20:50 INFO - PROCESS | 30284 | |9;json-stringify-tinderbox;62;62;63;62;62;61;61;62;61;61 04:20:50 INFO - PROCESS | 30284 | |10;stanford-crypto-aes;79;79;79;81;79;85;83;81;108;78 04:20:50 INFO - PROCESS | 30284 | |11;stanford-crypto-ccm;125;125;126;133;130;125;141;126;133;122 04:20:50 INFO - PROCESS | 30284 | |12;stanford-crypto-pbkdf2;169;162;162;157;158;160;158;159;157;157 04:20:50 INFO - PROCESS | 30284 | |13;stanford-crypto-sha256-iterative;63;64;68;62;63;62;63;61;63;63 04:20:50 INFO - PROCESS | 30284 | __end_tp_report 04:20:50 INFO - PROCESS | 30284 | __start_cc_report 04:20:50 INFO - PROCESS | 30284 | _x_x_mozilla_cycle_collect,869 04:20:50 INFO - PROCESS | 30284 | __end_cc_report 04:20:50 INFO - PROCESS | 30284 | __startTimestamp1465125650466__endTimestamp 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | ------- Summary: start ------- 04:20:50 INFO - PROCESS | 30284 | Number of tests: 14 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.19 04:20:50 INFO - PROCESS | 30284 | Values: 111.0 106.0 112.0 114.0 110.0 111.0 110.0 111.0 109.0 111.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.00 stddev:20.23 (13.1%) stddev-sans-first:21.20 04:20:50 INFO - PROCESS | 30284 | Values: 158.0 125.0 152.0 180.0 129.0 156.0 152.0 128.0 179.0 133.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.08 (2.5%) stddev-sans-first:4.32 04:20:50 INFO - PROCESS | 30284 | Values: 164.0 163.0 165.0 162.0 163.0 165.0 176.0 163.0 163.0 163.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:34.75 (45.7%) stddev-sans-first:36.41 04:20:50 INFO - PROCESS | 30284 | Values: 77.0 76.0 74.0 151.0 76.0 75.0 76.0 76.0 165.0 78.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.00 stddev:27.91 (32.5%) stddev-sans-first:28.92 04:20:50 INFO - PROCESS | 30284 | Values: 86.0 86.0 147.0 86.0 86.0 87.0 144.0 85.0 84.0 139.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:20:50 INFO - PROCESS | 30284 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 04:20:50 INFO - PROCESS | 30284 | Values: 147.0 147.0 146.0 148.0 149.0 148.0 147.0 147.0 148.0 147.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:20:50 INFO - PROCESS | 30284 | Values: 96.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 04:20:50 INFO - PROCESS | 30284 | Values: 54.0 56.0 54.0 54.0 54.0 54.0 56.0 56.0 56.0 54.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:20:50 INFO - PROCESS | 30284 | Values: 62.0 62.0 63.0 62.0 62.0 61.0 61.0 62.0 61.0 61.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.00 stddev:8.98 (11.2%) stddev-sans-first:9.39 04:20:50 INFO - PROCESS | 30284 | Values: 79.0 79.0 79.0 81.0 79.0 85.0 83.0 81.0 108.0 78.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:5.68 (4.4%) stddev-sans-first:5.87 04:20:50 INFO - PROCESS | 30284 | Values: 125.0 125.0 126.0 133.0 130.0 125.0 141.0 126.0 133.0 122.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:159.50 stddev:3.73 (2.3%) stddev-sans-first:2.03 04:20:50 INFO - PROCESS | 30284 | Values: 169.0 162.0 162.0 157.0 158.0 160.0 158.0 159.0 157.0 157.0 04:20:50 INFO - PROCESS | 30284 | 04:20:50 INFO - PROCESS | 30284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.87 (3.0%) stddev-sans-first:1.99 04:20:50 INFO - PROCESS | 30284 | Values: 63.0 64.0 68.0 62.0 63.0 62.0 63.0 61.0 63.0 63.0 04:20:50 INFO - PROCESS | 30284 | -------- Summary: end -------- 04:20:50 INFO - PROCESS | 30284 | 04:20:51 INFO - TEST-INFO | 30284: exit 0 04:20:51 INFO - TEST-OK | kraken | took 61688ms 04:20:51 INFO - SUITE-END | took 1172s 04:20:51 INFO - Completed test suite (00:19:32) 04:20:51 INFO - javascript benchmark 04:20:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.945526903211, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.81101133932, 3159.968400315996, 3199.4241036613407, 3209.2458272306003, 3212.887548935788, 5518.503334699876, 5561.416051314609, 5573.777048918044, 5609.971950140243, 5630.7184640768, 5395.0, 5533.059379905416, 5534.225208470817, 5544.805931792388, 5673.205751194836, 5000.849974500762, 5024.648274620778, 5067.594592432597, 5152.896942061157, 5153.3815942087, 5051.090803655341, 5211.817586384477, 5237.612032811308, 5250.6324557281005, 5251.133562962106, 4975.800967961313, 4982.252662100677, 4985.1774457214515, 5008.924866127011, 5095.541401273885, 5032.4967503249745, 5049.495050494921, 5050.368703912011, 5052.9242061369105, 5088.0078384715, 5015.448300686921, 5027.949720502785, 5032.798688052473, 5051.747412629354, 5073.39119305682, 5400.162974738922, 5418.891622167574, 5479.369872464677, 5497.422770609069, 5499.3675727291475, 6007.639541627516, 6007.969960150215, 6009.729562169713, 6014.1580178775, 6039.758409663608, 6057.212562366864, 6062.454379105901, 6067.362926892657, 6075.17985072014, 6075.513958883279, 5489.0, 5494.066008778477, 5501.477359650867, 5512.586556008316, 5523.502884740353, 6071.726772295257, 6073.362296958844, 6078.300995385587, 6079.939200608026, 6090.299615544181, 5691.715414229272, 5793.478586927196, 5809.419058094241, 5811.099279611667, 5841.532677385799, 5886.970565147147, 5890.263717035371, 5922.200502932135, 5986.610870293417, 5999.850003749942, 5728.770849165987, 5835.79574714883, 5883.0, 5889.352171261158, 5962.731677074542, 5921.289445266596, 5932.614380065282, 5959.851003724942, 5978.282606087298, 5996.550258730613, 4274.487061552633, 4313.9137217255475, 4357.43353364067, 4380.583844534828, 4383.473983121982, 3908.3160446922243, 3911.3350730375905, 3922.2939870823525, 3944.2505923874946, 3951.130751234724, 5533.22534845122, 5692.658440493584, 5696.686682232434, 5705.686187259741, 5721.113227449669, 5952.464278214981, 5972.611780234271, 5982.0727787193055, 6049.213602231682, 6074.878502429927, 5752.798652047159, 5758.452946970031, 5762.106873434541, 5767.077267637158, 5777.277840269966, 4816.181249187646, 4899.853004409873, 5003.224500202475, 5020.723860187724, 5026.472220416877, 6099.370313949917, 6201.410865967726, 6282.371762823681, 6290.150829637941, 6290.433860952537, 5991.3409524953095, 6000.819975400745, 6006.129111278928, 6045.375079465982, 6098.451139397475, 6035.909461358171, 6134.2835184798605, 6189.566730328834, 6207.534434917309, 6247.437730604267, 5872.383399742966, 5877.4122587740885, 5887.587868849139, 5903.793367232126, 5935.940640593539, 5930.258717660293, 5942.10868369748, 5957.702114894325, 5982.940170598238, 5983.252093488314, 5748.425157484386, 5766.048601980626, 5804.100364443518, 5825.271841019872, 5832.358440571618, 5724.0, 5725.914111288251, 5728.198052272602, 5767.596268261182, 5840.766369345349, 5661.122526008476, 5681.375048744718, 5685.77256909719, 5701.942980570141, 5716.056850619601, 5754.079347304411, 5779.988502012216, 5805.535557155333, 5814.622049566765, 5829.504492118217, 5748.022836117953, 5749.029857446445, 5769.79805706815, 5775.364709881994, 5838.854028649148], "value": 5471.352102240018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1049352516549, 612.6293592376612, 613.3314686991182, 635.1045026512617, 638.4190386748061, 39294.0, 43721.78139109308, 43738.12523749527, 43742.0, 43803.12393752131, 44278.0, 44918.77540612292, 44979.550204497944, 45031.0, 45072.54927450725, 8723.520206388646, 8916.420432671888, 8923.0, 8924.955375223115, 8931.615599582043, 8827.382083254175, 8832.072632373605, 8860.291176705849, 8910.554472276393, 8920.241779448723, 8898.110188981114, 8955.194032537103, 8955.641774329019, 8966.462012279284, 8972.910270897273, 8630.697925572606, 8638.049814520398, 8698.130186981283, 8855.73432797017, 8920.553972301359, 8711.34664900135, 8816.382853200279, 8830.470171789713, 8842.381033327669, 8860.0, 40072.39891401631, 40853.18293634111, 40995.1800963982, 41017.58982410168, 41066.79466602678, 3348.665133486656, 3433.124553238933, 3482.355764183634, 3589.3000864831106, 4187.958120418818, 32367.51448728271, 32496.350072998408, 32659.346813063843, 33040.0, 33557.0, 4377.846775362879, 4400.361947517624, 4416.80124394403, 4499.482559505634, 4552.499225085238, 364784.0, 366265.0, 367201.0, 367215.0, 367358.1632091849, 34691.0, 35950.0, 59919.0, 60181.39818601846, 60342.39657603455, 36665.633343666756, 36877.446838297445, 36888.81555592205, 36907.26185476276, 37091.25817483635, 15333.31000104998, 15335.30991105403, 15359.692806143814, 15435.459758908384, 15491.690166196613, 12475.812862807064, 12519.436625351698, 12587.055970802227, 12614.684632884067, 12631.368431578385, 8291.129431409736, 8369.539675317916, 8393.580320983927, 8425.11536288693, 8438.113998030241, 3226.2418331692033, 3277.950830737541, 3302.3725492156414, 3313.8343082845763, 3327.5507806446303, 1042.801867645145, 1057.4765491081964, 1066.3974854207347, 1132.881047490018, 1223.7613665335175, 32377.0, 32447.0, 32628.347433051207, 33079.50380744291, 33099.50350744741, 1172.4899668644166, 1172.9502095624368, 1174.395186478964, 1180.4923882730336, 1348.5077946549438, 16473.752893706605, 16997.49007529776, 17082.487525374258, 17092.316307347566, 17282.82717172812, 582411.0, 583384.0, 584200.0, 584440.0, 585294.0, 58129.4187058124, 58437.41562584405, 58560.41439585635, 58822.0, 58921.46471211741, 1358.2054498118712, 1385.0, 1405.8242719660248, 1415.801787749716, 1418.4751641892565, 29277.0, 30072.54891176678, 30351.593140905203, 30499.2375190622, 30846.38307233798, 49447.7527612374, 49492.257616135066, 49975.500244997085, 49988.50011499839, 50000.74999624979, 434494.0, 435060.0, 435219.0, 435304.0, 436057.0, 27143.1857044289, 27573.31440596286, 27933.16200513988, 27967.440651186454, 28331.0, 48162.759186203846, 48287.0, 48756.0, 48866.51133488762, 49510.0, 40928.1814363717, 41134.40443766927, 41276.38085428781, 41360.793196033825, 42040.78979605205, 39986.0, 41089.0, 41882.58117418909, 41956.0, 42053.15893682048, 40050.0, 41022.79488602538, 41218.79390603028, 41429.171416572106, 41542.376864347665, 34206.82896585601, 36678.26643467169, 36892.262154756216, 37107.0, 37111.628883710815, 27891.860540697977, 28053.579196311664, 28220.294492637026, 28538.85730571334, 28568.142955711362], "value": 19026.640258610852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.35542776130404, 401.5342203044469, 401.68467752814036, 405.064301463619, 423.4326003155771, 13318.933405332984, 17696.38062667807, 18357.632847343044, 19023.429297121074, 19136.13887375068, 18369.0, 18511.90744046281, 18883.811161888378, 19589.706154407697, 19601.0, 5648.632838865481, 5656.632318899268, 5739.167820666001, 5788.884222315552, 5870.236869206997, 5643.746031428575, 5652.74562644682, 5691.630044047144, 5716.22830917827, 5741.311042674884, 5551.1118221084635, 5561.249231353756, 5638.238837756912, 5695.259616249882, 5706.7431965561445, 5643.661380317153, 5677.347105082927, 5690.430956904318, 5716.799912003081, 5721.942780572203, 4959.950400495985, 5168.896622067575, 5178.378594568639, 5180.715060671661, 5181.171012637998, 22057.558848823093, 22190.556188876293, 23026.0, 23366.299011029696, 23441.41396465085, 2374.952500949971, 2483.714372847128, 2614.9540183926392, 2832.1928250448523, 2914.140328603046, 14067.226302553356, 14147.717045659028, 14303.570892873231, 14730.779038314435, 15039.624009399744, 1918.7505624268895, 1962.1954998450567, 1968.5373937124764, 2015.9596808063757, 2029.350607805503, 78508.60745696293, 80890.19109808885, 86198.56900715457, 90776.0, 91344.0, 10454.268201225841, 10987.340759554452, 11265.94367028176, 11400.631924168987, 11452.255603385753, 15848.366065357488, 15873.365065397486, 15891.682166356608, 15979.840201598068, 16028.11845348517, 7975.60121993898, 8202.917970820336, 8233.34133269337, 8350.79123021917, 8386.371022173362, 7656.349210317186, 7757.9224207758325, 7852.057753069668, 7939.20607939213, 7987.440879138405, 4829.227323628203, 4832.100739556308, 4913.0, 4917.852464426073, 4959.156943319645, 1976.6145601607836, 2002.2491565662876, 2007.8996050197431, 2053.1068984991575, 2094.225136699431, 957.674390707163, 968.8982656820932, 980.2158273381267, 1039.812833689943, 1048.250500891866, 19243.0, 19425.22299108048, 19543.706844397344, 19680.0, 19731.112099955535, 981.9607215711292, 1013.5844303835393, 1014.6245889020962, 1037.8910214427528, 1051.6476980211714, 10609.257351985441, 11028.0, 11034.062104721028, 11043.558257669763, 11089.112870970303, 492094.0, 496038.0, 499153.0, 508220.0, 509146.0, 91424.54287728519, 96774.0, 97257.0, 97264.0, 97418.51290743642, 950.1591091883732, 985.1822986920981, 985.4038306824268, 1002.8345323021765, 1004.6483730694199, 17364.131793410532, 17494.912525437292, 17526.123693815513, 17631.823681763017, 17636.64726705433, 41757.164856703304, 42439.5756042448, 42864.0, 43070.92322691833, 43862.56137438585, 57293.71353143208, 58309.0, 59907.0, 60350.69824650849, 60960.39039609547, 7983.281504664608, 8045.316148127475, 8336.62485188156, 8491.57542122879, 8585.18440748128, 9264.351495395258, 12833.935830320788, 13460.125091868997, 13547.32263386807, 13548.187108773505, 11688.47401866935, 12032.458539365925, 12103.394830258629, 12180.390980451119, 12363.32001739913, 11521.423928803693, 11685.182037257311, 11716.472758725708, 11730.12024098213, 11753.0, 11991.0, 12193.634190974284, 12260.632181034583, 12395.93802030984, 12455.627948775484, 8126.309263712651, 8316.792080198044, 8332.250097491255, 8507.106753790762, 8586.22723954847, 8707.825843483222, 11445.828312575484, 11882.346470944181, 12077.51689932393, 12157.513699451923], "value": 9367.122944109911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.2155439948428, 1539.1688488216364, 1634.4606279927625, 1769.3276554909141, 1796.0, 7727.1500134985245, 8648.13518648135, 8666.306695464364, 9200.447973121618, 9208.125228103328, 8440.32477401808, 8680.08859069798, 8701.347398945072, 8732.825343493127, 8744.08187140349, 2359.6224604063354, 2390.151496218835, 2401.255610760661, 2404.158544509425, 2407.4583218775724, 2324.360800779782, 2365.5387199496104, 2369.597168481362, 2383.2492764779126, 2384.0106355862295, 2288.599495088361, 2308.884555772213, 2314.67594536765, 2322.883855807211, 2339.649052642109, 2270.5572413379396, 2291.163725240292, 2292.0487997481027, 2318.431984163882, 2326.639370897505, 2333.125078095714, 2372.039324073753, 2395.568797616428, 2402.7986006996503, 2409.4578719787905, 8806.075362086953, 8862.689805856828, 8971.237444817198, 8971.461712297283, 8972.641094356219, 5363.329583802025, 5460.153676180198, 5464.398916119224, 5474.507294343528, 5506.366767821712, 3342.715869151125, 3436.7078798302173, 3496.7901925884275, 3498.4052711039185, 3505.2113274513285, 1124.162498938288, 1140.3386036099043, 1192.8807119288, 1203.7111093337624, 2184.170015394156, 12066.758664826655, 12613.684657883627, 12681.492740290378, 12686.61940141788, 12718.618441446864, 4526.298423744325, 4616.561426664462, 4629.0, 4655.301704744248, 4738.763061846894, 10000.699979000641, 10014.699559013241, 10017.04838040385, 10021.048000439947, 10038.0, 5280.207968804633, 5284.445133261029, 5308.628396012242, 5315.388730296066, 5328.547073498718, 4461.442319710036, 4854.441739200037, 4940.827071052496, 4989.226669866177, 5011.57401620859, 3837.270918525527, 3871.9032024199055, 3899.493065901415, 3934.3311637021775, 4001.679865610744, 1134.920555561103, 1152.7233463968587, 1154.7690461907653, 1161.4192903548226, 1161.8257261410688, 918.8621706744042, 931.6552875436132, 932.0958670090001, 943.3208090175063, 957.1911734584265, 5746.7931734335425, 5832.1834943108, 6087.208662873798, 6157.9384206158265, 6181.196444462281, 463.63372935381346, 467.1777671298539, 469.50936271595583, 472.56287933661224, 478.07969658407427, 4004.5394779600138, 4034.717569770147, 4052.8176232069627, 4054.108096218827, 4079.286124928126, 11232.157588180919, 11488.506494155707, 11596.188266821242, 11619.53521859133, 11631.941840290745, 11370.20408571392, 11485.942570287096, 11497.137714671433, 11501.482433290523, 11522.36626985507, 7927.326177274881, 8261.17388261181, 8406.579671016425, 8523.659053637784, 8541.530215838064, 5835.591508594358, 5873.2658417697785, 5999.700014999145, 6024.186734790747, 6113.17472141273, 9739.415635061636, 10208.846867296848, 10236.33463824849, 10387.376757394279, 10441.321314114559, 10416.427096509764, 10513.316634418738, 10666.626668066581, 10698.8930110701, 10817.405042722727, 7004.579725216503, 7925.365970722213, 8101.108878023295, 8104.594770261581, 8453.408261421642, 8460.873086903825, 8716.128387161232, 8759.737207883774, 8779.165979231962, 8812.206901378906, 7605.239476052572, 7724.961375193088, 7803.141654418123, 7922.524648521107, 7995.320397766022, 7613.086429628259, 7678.61606919663, 7709.421793365632, 7854.2145785421, 7869.173736757787, 6947.40947019509, 6964.512484126062, 6999.650017499206, 7016.5088443808445, 7040.155181378267, 4918.48355922623, 5177.689338639693, 5231.581473482036, 5248.422673505987, 5290.0, 5056.292119103402, 5166.870828229325, 5169.53474187325, 5362.329708786402, 5390.05674007055], "value": 4618.649293853363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.80091944833106, 339.18764558881475, 344.74144391706204, 344.85688439297695, 347.6627671158975, 5472.726363681815, 5641.266635337411, 5658.236138121352, 5667.858303542408, 5669.348024977129, 5459.317585301837, 5515.283013208277, 5551.3893471718075, 5558.805441809537, 5566.359868615111, 4015.8354077317545, 4314.913701725979, 4331.870043898688, 4372.322290045032, 4381.693281470299, 4303.870883873473, 4305.806238719265, 4319.33050377192, 4347.608765195138, 4351.347297905308, 4086.9386959195635, 4271.829126834923, 4299.806508707115, 4301.311790113583, 4314.697971142022, 4187.20443115807, 4296.591823776736, 4308.655307575418, 4312.1375724855, 4323.1785960667685, 3777.867774627875, 3790.886273411802, 3808.314503389389, 3818.5990471000423, 3827.6555110039953, 5247.186686063628, 5313.671582104474, 5357.571394288487, 5382.757775900094, 5435.239066530688, 4943.90112197754, 4947.356843610343, 4962.454130045692, 4990.850274491771, 4991.5258050485145, 5726.656400615976, 5842.415758424166, 5862.853428664275, 5879.265091863517, 5898.380670029628, 4031.8992025199314, 4121.4848143982, 4143.0, 4170.457840480748, 4174.62237461637, 6031.0, 6033.577649564532, 6048.606840555394, 6055.2430946131735, 6058.606190597597, 4253.149370125925, 4258.127083947783, 4276.743395396286, 4276.893077673083, 4288.614024737726, 4231.87304380869, 4305.0, 4314.331278651751, 4319.460067491564, 4339.262325404688, 4872.805087796449, 4900.485449027872, 4901.0, 4917.360743103445, 4981.028699403654, 5788.913166302509, 5821.476067153976, 5821.592488525847, 5828.825135245949, 5874.531367158211, 1458.2052781234254, 1484.139199264424, 1488.9404423822925, 1502.2638906935742, 1514.545636309103, 938.8263171313329, 944.5702205496483, 958.1376760915093, 962.3696478806393, 964.9421034737938, 4921.286413470027, 5049.293098966147, 5139.612304677716, 5169.554183402271, 5179.663321884065, 5263.710495922761, 5360.525855389721, 5390.8921821563345, 5409.594280428905, 5433.239346491494, 5149.6910185389, 5445.727713614383, 5624.859378515488, 5689.573282003784, 5711.7144142792695, 3145.418097651942, 3209.1335339458683, 3213.7107660310685, 3226.6450690424035, 3237.43344914639, 6057.8485537861025, 6225.8132256032395, 6244.843878903063, 6253.6560489173535, 6268.139289764085, 6062.847319393979, 6071.815995880761, 6122.908156377658, 6132.386761323832, 6182.28903676083, 5985.880282394328, 6172.580306529434, 6229.003359462555, 6252.124702541648, 6260.906086408708, 6010.1585777991995, 6046.788362407295, 6060.666663333559, 6066.575339726353, 6089.60417572874, 5964.671943043174, 5971.790987315423, 5995.61028533144, 5998.820035398945, 6009.338972712911, 5948.73230704628, 6166.506679465721, 6203.2245969253845, 6223.128761973237, 6248.312685604489, 4197.706160568731, 4235.280002399538, 4247.193033323659, 4256.957430425656, 4283.186194623012, 5888.676122813115, 6010.459058684739, 6042.341369797276, 6045.939540604538, 6066.757329706762, 5918.803845923326, 5918.881622367442, 5933.703314834154, 5945.800053980055, 5951.166836642787, 5885.911711324248, 5902.321233058254, 5903.911441328298, 5906.793262235801, 5912.201852749996, 5502.312210973629, 5657.981563318477, 5755.309362876482, 5767.365589785204, 5777.62445441045, 5828.912566311424, 5899.640143942457, 5902.321233058082, 5915.70421478933, 5930.11048342752, 5156.639035267495, 5578.414266502121, 5734.827955161351, 5748.712564371681, 5756.597038207286], "value": 4417.782403550544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.90557133144, 789.6333276978312, 791.70311133325, 800.3997002248313, 852.5907564369103, 15124.773128403069, 15870.0, 16030.118343491104, 16144.112073835964, 16173.110478923669, 13897.444102235924, 14203.153590033282, 14219.360128794204, 14220.928895355535, 14221.288935553206, 685.759984005599, 808.9231523005305, 829.1873963515728, 834.5243211369522, 835.1106072033296, 803.333233416263, 827.5613924619931, 829.655692887451, 831.2934006094802, 831.3017065664841, 866.8743032260319, 867.2195024477988, 870.316801310971, 872.9825403491926, 881.039666763228, 854.8888644476209, 859.9656013759442, 860.0066922704286, 861.5519929636554, 862.7670528957178, 624.881272558217, 625.4714766022704, 625.5996162455987, 625.6746491824226, 626.4299487466429, 15261.236938153159, 15319.31063102163, 15324.23378831054, 15356.232188390648, 15372.615684607863, 15214.08715477064, 15377.154256515887, 15480.5355839325, 15566.37734490619, 15697.215139243106, 11353.375564343958, 11419.600313989054, 11427.371494567795, 11467.713307167303, 11913.821292680617, 3827.445020472016, 3976.08550033491, 3979.5622481527007, 3995.582672483135, 4120.835166593332, 74784.25215747827, 75423.24576754218, 75479.0, 75616.24383756147, 78952.60523697345, 11180.832287515694, 11665.941670291595, 11667.6499705009, 11721.882781172078, 11860.94069529664, 23186.072557097526, 23360.299191024296, 23425.297241082793, 23490.412739681302, 23494.29517114489, 8715.0, 8721.127887211229, 8796.692115775917, 8907.331950103639, 9032.36773425867, 4845.491223421561, 4846.709197448165, 4874.366332376769, 4942.555170034714, 5037.19404895215, 3524.8766293179615, 3623.474596183539, 3645.5078564394, 3651.7808931464197, 3654.835532401048, 614.3672017821651, 614.4040280927493, 624.9125122482856, 628.6165439082156, 638.0301941049671, 715.148972722469, 722.9746958856415, 749.0636704119851, 749.8762704153862, 763.6334559411514, 10311.329763565343, 10458.26792124544, 10458.790824183474, 10722.195835312383, 10722.410267435365, 607.3228350389284, 750.8736894658012, 767.2749251956959, 805.5690205740018, 821.5399376349144, 4593.793279302439, 4717.905641887143, 4878.731669758126, 4900.09348270564, 4930.359053323045, 67821.66089169522, 101847.0, 113227.43386283181, 113783.0, 114965.4251728736, 93102.53448732848, 97258.513707431, 99066.5046674762, 100092.0, 101477.0, 64682.67658661676, 89733.55133224423, 89915.0, 91936.54031729799, 92470.07529924749, 9298.256139508958, 9483.0, 9488.470976266162, 9517.09692309982, 9596.952015240158, 50127.0, 51345.0, 52218.738906305225, 53332.400027999225, 54678.17982730183, 71733.28266717475, 74881.62559187169, 75350.0, 76176.61911690405, 78534.21465785497, 12029.45867435985, 12119.333436661069, 12359.814602780785, 12471.93764031174, 12646.494140234288, 13432.664183395493, 13502.257375844423, 13601.115927464683, 14015.579532614038, 14026.929865350608, 13165.078444508792, 13219.272939988008, 13253.469861205444, 13452.39464224132, 13520.18878867271, 12555.497780088694, 12670.429830657828, 12798.232106073665, 12956.287404192482, 13445.663858403617, 11793.646190614296, 12739.61781146567, 12866.806997894852, 12868.871311287141, 12913.289769062792, 10582.259241853304, 10635.415052171895, 10898.073663738354, 10918.454077296263, 11167.609133680282, 10549.314294570828, 10670.413127278074, 11320.773584528428, 11371.661474918763, 11476.655700329004], "value": 7592.422511285043, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 114.0, 110.0, 111.0, 110.0, 111.0, 109.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 152.0, 180.0, 129.0, 156.0, 152.0, 128.0, 179.0, 133.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 162.0, 163.0, 165.0, 176.0, 163.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 151.0, 76.0, 75.0, 76.0, 76.0, 165.0, 78.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 147.0, 86.0, 86.0, 87.0, 144.0, 85.0, 84.0, 139.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 54.0, 54.0, 56.0, 56.0, 56.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 79.0, 85.0, 83.0, 81.0, 108.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 126.0, 133.0, 130.0, 125.0, 141.0, 126.0, 133.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 162.0, 157.0, 158.0, 160.0, 158.0, 159.0, 157.0, 157.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 62.0, 63.0, 62.0, 63.0, 61.0, 63.0, 63.0], "value": 63.2, "unit": "score"}]}]} 04:20:51 INFO - Return code: 0 04:20:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:51 ERROR - # TBPL SUCCESS # 04:20:51 INFO - Running post-action listener: _resource_record_post_action 04:20:51 INFO - ##### 04:20:51 INFO - ##### Finished run-tests step (success) 04:20:51 INFO - ##### 04:20:51 INFO - Running post-run listener: _resource_record_post_run 04:20:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541360128; Read time: 4; Write time: 504156 04:20:51 INFO - TinderboxPrint: CPU usage
13.5% 04:20:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 04:20:51 INFO - TinderboxPrint: I/O write bytes / time
541,360,128 / 504,156 04:20:51 INFO - TinderboxPrint: CPU idle
8,219.4 (86.5%) 04:20:51 INFO - TinderboxPrint: CPU user
1,226.7 (12.9%) 04:20:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248004608; Read time: 0; Write time: 317068 04:20:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293355520; Read time: 4; Write time: 187088 04:20:52 INFO - Running post-run listener: _upload_blobber_files 04:20:52 INFO - Blob upload gear active. 04:20:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:20:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:57 INFO - (blobuploader) - INFO - Done attempting. 04:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:57 INFO - (blobuploader) - INFO - Done attempting. 04:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:58 INFO - (blobuploader) - INFO - Done attempting. 04:20:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:58 INFO - Return code: 0 04:20:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61696e310f01cda1fdceda9cbe5636038badf34eed21c4fca712b0632bde52084eacaec3352a6b3e0d3d3400c61b464f44a8bb1c5fdb5b416770779596c6f39b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db54ad4256c7f1f671cfbdbabf8cc89210a2899fc2f11fcba33cc3f4e0a2e2c661e8212c9f369d07bf0e45422565b4838990e7b07334f7c90a026d26ea3494d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4773f6f62ab950eb868bc1ebd9d69b6664dc6df15f1436832c7030361c9a0468754e2bb1e9051e58c41b88f8c1dba569c6fe9bb7b372564626fd37d9dfaa7c9b"} 04:20:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:58 INFO - Contents: 04:20:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61696e310f01cda1fdceda9cbe5636038badf34eed21c4fca712b0632bde52084eacaec3352a6b3e0d3d3400c61b464f44a8bb1c5fdb5b416770779596c6f39b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db54ad4256c7f1f671cfbdbabf8cc89210a2899fc2f11fcba33cc3f4e0a2e2c661e8212c9f369d07bf0e45422565b4838990e7b07334f7c90a026d26ea3494d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4773f6f62ab950eb868bc1ebd9d69b6664dc6df15f1436832c7030361c9a0468754e2bb1e9051e58c41b88f8c1dba569c6fe9bb7b372564626fd37d9dfaa7c9b"} 04:20:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:58 INFO - Copying logs to upload dir... 04:20:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.156669 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-05 04:20:56.720029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:20:56.723999) ========= 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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 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/61696e310f01cda1fdceda9cbe5636038badf34eed21c4fca712b0632bde52084eacaec3352a6b3e0d3d3400c61b464f44a8bb1c5fdb5b416770779596c6f39b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db54ad4256c7f1f671cfbdbabf8cc89210a2899fc2f11fcba33cc3f4e0a2e2c661e8212c9f369d07bf0e45422565b4838990e7b07334f7c90a026d26ea3494d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4773f6f62ab950eb868bc1ebd9d69b6664dc6df15f1436832c7030361c9a0468754e2bb1e9051e58c41b88f8c1dba569c6fe9bb7b372564626fd37d9dfaa7c9b"} build_url:https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.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/61696e310f01cda1fdceda9cbe5636038badf34eed21c4fca712b0632bde52084eacaec3352a6b3e0d3d3400c61b464f44a8bb1c5fdb5b416770779596c6f39b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db54ad4256c7f1f671cfbdbabf8cc89210a2899fc2f11fcba33cc3f4e0a2e2c661e8212c9f369d07bf0e45422565b4838990e7b07334f7c90a026d26ea3494d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4773f6f62ab950eb868bc1ebd9d69b6664dc6df15f1436832c7030361c9a0468754e2bb1e9051e58c41b88f8c1dba569c6fe9bb7b372564626fd37d9dfaa7c9b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:20:56.749277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:20:56.749627) ========= 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=232498196343f89f466a4a9a000001c8-1465123083.715265-884554080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:20:56.835480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:20:56.835816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:20:56.836138) ========= ========= Total master_lag: 0.17 =========