builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1466215645.69 results: success (0) buildid: 20160617163038 builduid: 3045e765fb3c49fda1d33cbbc0176776 revision: 35530c11c1631b62e2e02c59e071f49d877b1184 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:25.693402) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:25.693874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:25.694202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:25.788022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:25.788317) ========= 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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 19:07:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.9M=0s 2016-06-17 19:07:26 (89.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175503 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.011869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.012187) ========= 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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.069306 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.092216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.092594) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 35530c11c1631b62e2e02c59e071f49d877b1184 --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 35530c11c1631b62e2e02c59e071f49d877b1184 --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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 19:07:26,182 truncating revision to first 12 chars 2016-06-17 19:07:26,182 Setting DEBUG logging. 2016-06-17 19:07:26,182 attempt 1/10 2016-06-17 19:07:26,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/35530c11c163?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 19:07:26,535 unpacking tar archive at: mozilla-inbound-35530c11c163/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.873144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.873485) ========= script_repo_revision: 35530c11c1631b62e2e02c59e071f49d877b1184 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.873987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.874298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 19:07:26.888853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-17 19:07:26.889172) ========= /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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:27 INFO - MultiFileLogger online at 20160617 19:07:27 in /builds/slave/test 19:07:27 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 19:07:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:27 INFO - {'append_to_log': False, 19:07:27 INFO - 'base_work_dir': '/builds/slave/test', 19:07:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:07:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:27 INFO - 'branch': 'Mozilla-Inbound', 19:07:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:27 INFO - 'config_files': ('talos/linux_config.py',), 19:07:27 INFO - 'default_actions': ('clobber', 19:07:27 INFO - 'read-buildbot-config', 19:07:27 INFO - 'download-and-extract', 19:07:27 INFO - 'populate-webroot', 19:07:27 INFO - 'create-virtualenv', 19:07:27 INFO - 'install', 19:07:27 INFO - 'run-tests'), 19:07:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:27 INFO - 'download_minidump_stackwalk': True, 19:07:27 INFO - 'download_symbols': 'ondemand', 19:07:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:27 INFO - 'installer_path': 'installer.exe', 19:07:27 INFO - 'log_level': 'info', 19:07:27 INFO - 'log_name': 'talos', 19:07:27 INFO - 'log_to_console': True, 19:07:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:27 INFO - 'opt_config_files': (), 19:07:27 INFO - 'pip_index': False, 19:07:27 INFO - 'sps_profile': False, 19:07:27 INFO - 'sps_profile_interval': 0, 19:07:27 INFO - 'suite': 'dromaeojs-e10s', 19:07:27 INFO - 'system_bits': '32', 19:07:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:27 INFO - 'title': 'talos-linux64-ix-003', 19:07:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:27 INFO - 'use_talos_json': True, 19:07:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:27 INFO - 'work_dir': 'build'} 19:07:27 INFO - ##### 19:07:27 INFO - ##### Running clobber step. 19:07:27 INFO - ##### 19:07:27 INFO - Running pre-action listener: _resource_record_pre_action 19:07:27 INFO - Running main action method: clobber 19:07:27 INFO - rmtree: /builds/slave/test/build 19:07:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - ##### 19:07:29 INFO - ##### Finished clobber step (success) 19:07:29 INFO - ##### 19:07:29 INFO - ##### 19:07:29 INFO - ##### Running read-buildbot-config step. 19:07:29 INFO - ##### 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: read_buildbot_config 19:07:29 INFO - Using buildbot properties: 19:07:29 INFO - { 19:07:29 INFO - "project": "", 19:07:29 INFO - "product": "firefox", 19:07:29 INFO - "script_repo_revision": "production", 19:07:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:07:29 INFO - "repository": "", 19:07:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:07:29 INFO - "buildid": "20160617163038", 19:07:29 INFO - "pgo_build": "True", 19:07:29 INFO - "basedir": "/builds/slave/test", 19:07:29 INFO - "buildnumber": 725, 19:07:29 INFO - "slavename": "talos-linux64-ix-003", 19:07:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:29 INFO - "platform": "ubuntu64_hw", 19:07:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:07:29 INFO - "branch": "mozilla-inbound", 19:07:29 INFO - "repo_path": "integration/mozilla-inbound", 19:07:29 INFO - "revision": "35530c11c1631b62e2e02c59e071f49d877b1184", 19:07:29 INFO - "stage_platform": "linux64-pgo", 19:07:29 INFO - "builduid": "3045e765fb3c49fda1d33cbbc0176776", 19:07:29 INFO - "slavebuilddir": "test" 19:07:29 INFO - } 19:07:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - ##### 19:07:29 INFO - ##### Finished read-buildbot-config step (success) 19:07:29 INFO - ##### 19:07:29 INFO - ##### 19:07:29 INFO - ##### Running download-and-extract step. 19:07:29 INFO - ##### 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: download_and_extract 19:07:29 INFO - mkdir: /builds/slave/test/build/tests 19:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:29 INFO - https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:07:31 INFO - Downloaded 1361 bytes. 19:07:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:31 INFO - Using the following test package requirements: 19:07:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:07:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'jsshell-linux-x86_64.zip'], 19:07:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:31 INFO - https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:07:34 INFO - Downloaded 24221045 bytes. 19:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:07:36 INFO - Return code: 0 19:07:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:36 INFO - https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:07:44 INFO - Downloaded 24221045 bytes. 19:07:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:07:45 INFO - Return code: 0 19:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:45 INFO - https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:07:46 INFO - Downloaded 14405384 bytes. 19:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:07:47 INFO - Return code: 0 19:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:47 INFO - https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:07:48 INFO - Downloaded 60119231 bytes. 19:07:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:48 INFO - mkdir: /builds/slave/test/properties 19:07:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:48 INFO - Contents: 19:07:48 INFO - build_url:https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:49 INFO - Running post-action listener: _resource_record_post_action 19:07:49 INFO - Running post-action listener: set_extra_try_arguments 19:07:49 INFO - ##### 19:07:49 INFO - ##### Finished download-and-extract step (success) 19:07:49 INFO - ##### 19:07:49 INFO - ##### 19:07:49 INFO - ##### Running populate-webroot step. 19:07:49 INFO - ##### 19:07:49 INFO - Running pre-action listener: _resource_record_pre_action 19:07:49 INFO - Running main action method: populate_webroot 19:07:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:49 INFO - '--tppagecycles', 19:07:49 INFO - '7'], 19:07:49 INFO - 'tests': ['tsvgm']}}, 19:07:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['damp', 'tps']}, 19:07:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'tests': ['damp', 'tps']}, 19:07:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['dromaeo_dom']}, 19:07:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['basic_compositor_video']}, 19:07:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:07:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['a11yr', 19:07:49 INFO - 'ts_paint', 19:07:49 INFO - 'tpaint', 19:07:49 INFO - 'sessionrestore', 19:07:49 INFO - 'sessionrestore_no_auto_restore', 19:07:49 INFO - 'tabpaint']}, 19:07:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['tsvgx', 19:07:49 INFO - 'tsvgr_opacity', 19:07:49 INFO - 'tart', 19:07:49 INFO - 'tscrollx', 19:07:49 INFO - 'cart']}, 19:07:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:49 INFO - 'tsvgr_opacity', 19:07:49 INFO - 'tart', 19:07:49 INFO - 'tscrollx', 19:07:49 INFO - 'cart']}, 19:07:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'talos_options': ['--disable-e10s'], 19:07:49 INFO - 'tests': ['tp5o']}, 19:07:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'tests': ['tp5o']}, 19:07:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'talos_options': ['--disable-e10s', 19:07:49 INFO - '--xperf_path', 19:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:49 INFO - 'tests': ['tp5n']}, 19:07:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:49 INFO - 'talos_options': ['--xperf_path', 19:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:49 INFO - 'tests': ['tp5n']}}, 19:07:49 INFO - 'talos.zip': {'path': '', 19:07:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:49 INFO - Running post-action listener: _resource_record_post_action 19:07:49 INFO - ##### 19:07:49 INFO - ##### Finished populate-webroot step (success) 19:07:49 INFO - ##### 19:07:49 INFO - ##### 19:07:49 INFO - ##### Running create-virtualenv step. 19:07:49 INFO - ##### 19:07:49 INFO - Running pre-action listener: _resource_record_pre_action 19:07:49 INFO - Running main action method: create_virtualenv 19:07:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:07:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:49 INFO - Using real prefix '/usr' 19:07:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:52 INFO - Installing pip.................done. 19:07:52 INFO - Return code: 0 19:07:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:52 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:07:52 INFO - Using env: {'DISPLAY': ':0', 19:07:52 INFO - 'HOME': '/home/cltbld', 19:07:52 INFO - 'LANG': 'en_US.UTF-8', 19:07:52 INFO - 'LANGUAGE': 'en_US:en', 19:07:52 INFO - 'LOGNAME': 'cltbld', 19:07:52 INFO - 'MAIL': '/var/mail/cltbld', 19:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:52 INFO - 'MOZ_NO_REMOTE': '1', 19:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:52 INFO - 'NO_EM_RESTART': '1', 19:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:52 INFO - 'PWD': '/builds/slave/test', 19:07:52 INFO - 'SHELL': '/bin/bash', 19:07:52 INFO - 'SHLVL': '1', 19:07:52 INFO - 'TERM': 'linux', 19:07:52 INFO - 'TMOUT': '86400', 19:07:52 INFO - 'USER': 'cltbld', 19:07:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:52 INFO - '_': '/tools/buildbot/bin/python'} 19:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:07:53 INFO - Cleaning up... 19:07:53 INFO - Return code: 0 19:07:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:53 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:07:53 INFO - Using env: {'DISPLAY': ':0', 19:07:53 INFO - 'HOME': '/home/cltbld', 19:07:53 INFO - 'LANG': 'en_US.UTF-8', 19:07:53 INFO - 'LANGUAGE': 'en_US:en', 19:07:53 INFO - 'LOGNAME': 'cltbld', 19:07:53 INFO - 'MAIL': '/var/mail/cltbld', 19:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:53 INFO - 'MOZ_NO_REMOTE': '1', 19:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:53 INFO - 'NO_EM_RESTART': '1', 19:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:53 INFO - 'PWD': '/builds/slave/test', 19:07:53 INFO - 'SHELL': '/bin/bash', 19:07:53 INFO - 'SHLVL': '1', 19:07:53 INFO - 'TERM': 'linux', 19:07:53 INFO - 'TMOUT': '86400', 19:07:53 INFO - 'USER': 'cltbld', 19:07:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:53 INFO - '_': '/tools/buildbot/bin/python'} 19:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:53 INFO - Downloading/unpacking psutil>=3.1.1 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:55 INFO - Installing collected packages: psutil 19:07:55 INFO - Running setup.py install for psutil 19:07:55 INFO - building 'psutil._psutil_linux' extension 19:07:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:07:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:07:56 INFO - building 'psutil._psutil_posix' extension 19:07:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:07:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:57 INFO - Successfully installed psutil 19:07:57 INFO - Cleaning up... 19:07:57 INFO - Return code: 0 19:07:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:07: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 mozsystemmonitor==0.3 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:07:59 INFO - Installing collected packages: mozsystemmonitor 19:07:59 INFO - Running setup.py install for mozsystemmonitor 19:07:59 INFO - Successfully installed mozsystemmonitor 19:07:59 INFO - Cleaning up... 19:07:59 INFO - Return code: 0 19:07:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:59 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:07:59 INFO - Using env: {'DISPLAY': ':0', 19:07:59 INFO - 'HOME': '/home/cltbld', 19:07:59 INFO - 'LANG': 'en_US.UTF-8', 19:07:59 INFO - 'LANGUAGE': 'en_US:en', 19:07:59 INFO - 'LOGNAME': 'cltbld', 19:07:59 INFO - 'MAIL': '/var/mail/cltbld', 19:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:59 INFO - 'MOZ_NO_REMOTE': '1', 19:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:59 INFO - 'NO_EM_RESTART': '1', 19:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:59 INFO - 'PWD': '/builds/slave/test', 19:07:59 INFO - 'SHELL': '/bin/bash', 19:07:59 INFO - 'SHLVL': '1', 19:07:59 INFO - 'TERM': 'linux', 19:07:59 INFO - 'TMOUT': '86400', 19:07:59 INFO - 'USER': 'cltbld', 19:07:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:59 INFO - '_': '/tools/buildbot/bin/python'} 19:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:59 INFO - Downloading/unpacking jsonschema==2.5.1 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:08:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:01 INFO - warning: no files found matching '*.txt' 19:08:01 INFO - no previously-included directories found matching 'build' 19:08:01 INFO - no previously-included directories found matching 'dist' 19:08:01 INFO - no previously-included directories found matching '.git*' 19:08:01 INFO - Installing collected packages: jsonschema, functools32 19:08:01 INFO - Running setup.py install for functools32 19:08:01 INFO - warning: no files found matching '*.txt' 19:08:01 INFO - no previously-included directories found matching 'build' 19:08:01 INFO - no previously-included directories found matching 'dist' 19:08:01 INFO - no previously-included directories found matching '.git*' 19:08:01 INFO - Successfully installed jsonschema functools32 19:08:01 INFO - Cleaning up... 19:08:02 INFO - Return code: 0 19:08:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:02 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:08:02 INFO - Using env: {'DISPLAY': ':0', 19:08:02 INFO - 'HOME': '/home/cltbld', 19:08:02 INFO - 'LANG': 'en_US.UTF-8', 19:08:02 INFO - 'LANGUAGE': 'en_US:en', 19:08:02 INFO - 'LOGNAME': 'cltbld', 19:08:02 INFO - 'MAIL': '/var/mail/cltbld', 19:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:02 INFO - 'MOZ_NO_REMOTE': '1', 19:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:02 INFO - 'NO_EM_RESTART': '1', 19:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:02 INFO - 'PWD': '/builds/slave/test', 19:08:02 INFO - 'SHELL': '/bin/bash', 19:08:02 INFO - 'SHLVL': '1', 19:08:02 INFO - 'TERM': 'linux', 19:08:02 INFO - 'TMOUT': '86400', 19:08:02 INFO - 'USER': 'cltbld', 19:08:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:02 INFO - '_': '/tools/buildbot/bin/python'} 19:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Downloading docopt-0.6.1.tar.gz 19:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:04 INFO - Running setup.py install for blobuploader 19:08:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:04 INFO - Running setup.py install for requests 19:08:05 INFO - Running setup.py install for docopt 19:08:05 INFO - Successfully installed blobuploader requests docopt 19:08:05 INFO - Cleaning up... 19:08:05 INFO - Return code: 0 19:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:08:05 INFO - Using env: {'DISPLAY': ':0', 19:08:05 INFO - 'HOME': '/home/cltbld', 19:08:05 INFO - 'LANG': 'en_US.UTF-8', 19:08:05 INFO - 'LANGUAGE': 'en_US:en', 19:08:05 INFO - 'LOGNAME': 'cltbld', 19:08:05 INFO - 'MAIL': '/var/mail/cltbld', 19:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:05 INFO - 'MOZ_NO_REMOTE': '1', 19:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:05 INFO - 'NO_EM_RESTART': '1', 19:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:05 INFO - 'PWD': '/builds/slave/test', 19:08:05 INFO - 'SHELL': '/bin/bash', 19:08:05 INFO - 'SHLVL': '1', 19:08:05 INFO - 'TERM': 'linux', 19:08:05 INFO - 'TMOUT': '86400', 19:08:05 INFO - 'USER': 'cltbld', 19:08:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:05 INFO - '_': '/tools/buildbot/bin/python'} 19:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:05 INFO - Running setup.py (path:/tmp/pip-jNhsGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:05 INFO - Running setup.py (path:/tmp/pip-pSZgRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:05 INFO - Running setup.py (path:/tmp/pip-O6eNLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:05 INFO - Running setup.py (path:/tmp/pip-WC__Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:06 INFO - Running setup.py (path:/tmp/pip-aouVSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:06 INFO - Running setup.py (path:/tmp/pip-fnY6M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:06 INFO - Running setup.py (path:/tmp/pip-WATp4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:06 INFO - Running setup.py (path:/tmp/pip-3tnefB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:06 INFO - Running setup.py (path:/tmp/pip-ywKQzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:06 INFO - Running setup.py (path:/tmp/pip-KS0F92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:06 INFO - Running setup.py (path:/tmp/pip-BkKJaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:06 INFO - Running setup.py (path:/tmp/pip-X9MKqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:06 INFO - Running setup.py (path:/tmp/pip-IKKnIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:06 INFO - Running setup.py (path:/tmp/pip-q9_OZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:06 INFO - Running setup.py (path:/tmp/pip-7o7t4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:06 INFO - Running setup.py (path:/tmp/pip-w1W9zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:06 INFO - Running setup.py (path:/tmp/pip-3JTqYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:06 INFO - Running setup.py install for manifestparser 19:08:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozcrash 19:08:07 INFO - Running setup.py install for mozdebug 19:08:07 INFO - Running setup.py install for mozdevice 19:08:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozfile 19:08:07 INFO - Running setup.py install for mozhttpd 19:08:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozinfo 19:08:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozInstall 19:08:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozleak 19:08:07 INFO - Running setup.py install for mozlog 19:08:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for moznetwork 19:08:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozprocess 19:08:08 INFO - Running setup.py install for mozprofile 19:08:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozrunner 19:08:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozscreenshot 19:08:08 INFO - Running setup.py install for moztest 19:08:08 INFO - Running setup.py install for mozversion 19:08:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:08 INFO - Running setup.py (path:/tmp/pip-sSoP5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 INFO - Running setup.py (path:/tmp/pip-EPAhDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 INFO - Running setup.py (path:/tmp/pip-GCHztw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Running setup.py (path:/tmp/pip-dkgnKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Running setup.py (path:/tmp/pip-5SseRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Running setup.py (path:/tmp/pip-r6wf3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Running setup.py (path:/tmp/pip-PeVsXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Running setup.py (path:/tmp/pip-G1J50c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Running setup.py (path:/tmp/pip-mqT7As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:09 INFO - Running setup.py (path:/tmp/pip-Anlhu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:09 INFO - Running setup.py (path:/tmp/pip-1Ik63s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:09 INFO - Running setup.py (path:/tmp/pip-2I8Fzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:09 INFO - Running setup.py (path:/tmp/pip-qVtAsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:09 INFO - Running setup.py (path:/tmp/pip-iaVrpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:09 INFO - Running setup.py (path:/tmp/pip-CNkcyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:10 INFO - Running setup.py (path:/tmp/pip-g7CpXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:10 INFO - Running setup.py (path:/tmp/pip-NJl1iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:12 INFO - Downloading blessings-1.6.tar.gz 19:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:12 INFO - Installing collected packages: blessings 19:08:12 INFO - Running setup.py install for blessings 19:08:12 INFO - Successfully installed blessings 19:08:12 INFO - Cleaning up... 19:08:12 INFO - Return code: 0 19:08:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:12 INFO - Reading from file tmpfile_stdout 19:08:12 INFO - Current package versions: 19:08:12 INFO - argparse == 1.2.1 19:08:12 INFO - blessings == 1.6 19:08:12 INFO - blobuploader == 1.2.4 19:08:12 INFO - docopt == 0.6.1 19:08:12 INFO - functools32 == 3.2.3-2 19:08:12 INFO - jsonschema == 2.5.1 19:08:12 INFO - manifestparser == 1.1 19:08:12 INFO - mozInstall == 1.12 19:08:12 INFO - mozcrash == 0.17 19:08:12 INFO - mozdebug == 0.1 19:08:12 INFO - mozdevice == 0.48 19:08:12 INFO - mozfile == 1.2 19:08:12 INFO - mozhttpd == 0.7 19:08:12 INFO - mozinfo == 0.9 19:08:12 INFO - mozleak == 0.1 19:08:12 INFO - mozlog == 3.2 19:08:12 INFO - moznetwork == 0.27 19:08:12 INFO - mozprocess == 0.22 19:08:12 INFO - mozprofile == 0.28 19:08:12 INFO - mozrunner == 6.11 19:08:12 INFO - mozscreenshot == 0.1 19:08:12 INFO - mozsystemmonitor == 0.3 19:08:12 INFO - moztest == 0.7 19:08:12 INFO - mozversion == 1.4 19:08:12 INFO - psutil == 3.1.1 19:08:12 INFO - requests == 1.2.3 19:08:12 INFO - wsgiref == 0.1.2 19:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:08:12 INFO - Using env: {'DISPLAY': ':0', 19:08:12 INFO - 'HOME': '/home/cltbld', 19:08:12 INFO - 'LANG': 'en_US.UTF-8', 19:08:12 INFO - 'LANGUAGE': 'en_US:en', 19:08:12 INFO - 'LOGNAME': 'cltbld', 19:08:12 INFO - 'MAIL': '/var/mail/cltbld', 19:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:12 INFO - 'MOZ_NO_REMOTE': '1', 19:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:12 INFO - 'NO_EM_RESTART': '1', 19:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:12 INFO - 'PWD': '/builds/slave/test', 19:08:12 INFO - 'SHELL': '/bin/bash', 19:08:12 INFO - 'SHLVL': '1', 19:08:12 INFO - 'TERM': 'linux', 19:08:12 INFO - 'TMOUT': '86400', 19:08:12 INFO - 'USER': 'cltbld', 19:08:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:12 INFO - '_': '/tools/buildbot/bin/python'} 19:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:08:12 INFO - Cleaning up... 19:08:12 INFO - Return code: 0 19:08:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:08:12 INFO - Using env: {'DISPLAY': ':0', 19:08:12 INFO - 'HOME': '/home/cltbld', 19:08:12 INFO - 'LANG': 'en_US.UTF-8', 19:08:12 INFO - 'LANGUAGE': 'en_US:en', 19:08:12 INFO - 'LOGNAME': 'cltbld', 19:08:12 INFO - 'MAIL': '/var/mail/cltbld', 19:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:12 INFO - 'MOZ_NO_REMOTE': '1', 19:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:12 INFO - 'NO_EM_RESTART': '1', 19:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:12 INFO - 'PWD': '/builds/slave/test', 19:08:12 INFO - 'SHELL': '/bin/bash', 19:08:12 INFO - 'SHLVL': '1', 19:08:12 INFO - 'TERM': 'linux', 19:08:12 INFO - 'TMOUT': '86400', 19:08:12 INFO - 'USER': 'cltbld', 19:08:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:12 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:13 INFO - Cleaning up... 19:08:13 INFO - Return code: 0 19:08:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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 0x7f71edf46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, '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': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:08:13 INFO - Using env: {'DISPLAY': ':0', 19:08:13 INFO - 'HOME': '/home/cltbld', 19:08:13 INFO - 'LANG': 'en_US.UTF-8', 19:08:13 INFO - 'LANGUAGE': 'en_US:en', 19:08:13 INFO - 'LOGNAME': 'cltbld', 19:08:13 INFO - 'MAIL': '/var/mail/cltbld', 19:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:13 INFO - 'MOZ_NO_REMOTE': '1', 19:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:13 INFO - 'NO_EM_RESTART': '1', 19:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:13 INFO - 'PWD': '/builds/slave/test', 19:08:13 INFO - 'SHELL': '/bin/bash', 19:08:13 INFO - 'SHLVL': '1', 19:08:13 INFO - 'TERM': 'linux', 19:08:13 INFO - 'TMOUT': '86400', 19:08:13 INFO - 'USER': 'cltbld', 19:08:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:13 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 INFO - Downloading/unpacking flake8 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:15 INFO - no previously-included directories found matching 'docs/_build' 19:08:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:15 INFO - Running setup.py install for pep8 19:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:15 INFO - no previously-included directories found matching 'docs/_build' 19:08:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:16 INFO - Cleaning up... 19:08:16 INFO - Return code: 0 19:08:16 INFO - Running post-action listener: _resource_record_post_action 19:08:16 INFO - Running post-action listener: _start_resource_monitoring 19:08:16 INFO - Starting resource monitoring. 19:08:16 INFO - ##### 19:08:16 INFO - ##### Finished create-virtualenv step (success) 19:08:16 INFO - ##### 19:08:16 INFO - ##### 19:08:16 INFO - ##### Running install step. 19:08:16 INFO - ##### 19:08:16 INFO - Running pre-action listener: _resource_record_pre_action 19:08:16 INFO - Running main action method: install 19:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:16 INFO - Reading from file tmpfile_stdout 19:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:16 INFO - Reading from file tmpfile_stdout 19:08:16 INFO - Output received: 19:08:16 INFO - Usage: mozinstall [options] installer 19:08:16 INFO - Options: 19:08:16 INFO - -h, --help show this help message and exit 19:08:16 INFO - -d DEST, --destination=DEST 19:08:16 INFO - Directory to install application into. [default: 19:08:16 INFO - "/builds/slave/test"] 19:08:16 INFO - --app=APP Application being installed. [default: firefox] 19:08:16 INFO - mkdir: /builds/slave/test/build/application 19:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:08:33 INFO - Reading from file tmpfile_stdout 19:08:33 INFO - Output received: 19:08:33 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:33 INFO - Running post-action listener: _resource_record_post_action 19:08:33 INFO - ##### 19:08:33 INFO - ##### Finished install step (success) 19:08:33 INFO - ##### 19:08:33 INFO - ##### 19:08:33 INFO - ##### Running run-tests step. 19:08:33 INFO - ##### 19:08:33 INFO - Running pre-action listener: _resource_record_pre_action 19:08:33 INFO - Running main action method: run_tests 19:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:33 INFO - Python 2.7.3 19:08:33 INFO - Return code: 0 19:08:33 INFO - grabbing minidump binary from tooltool 19:08: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')]} 19:08:33 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 0x17592e0>, '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 0x16c5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:08:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:08:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:08:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:33 INFO - Return code: 0 19:08:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:34 INFO - Return code: 0 19:08:34 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/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:08:34 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/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 19:08:34 INFO - Using env: {'DISPLAY': ':0', 19:08:34 INFO - 'HOME': '/home/cltbld', 19:08:34 INFO - 'LANG': 'en_US.UTF-8', 19:08:34 INFO - 'LANGUAGE': 'en_US:en', 19:08:34 INFO - 'LOGNAME': 'cltbld', 19:08:34 INFO - 'MAIL': '/var/mail/cltbld', 19:08:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:34 INFO - 'MOZ_NO_REMOTE': '1', 19:08:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:34 INFO - 'NO_EM_RESTART': '1', 19:08:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:34 INFO - 'PWD': '/builds/slave/test', 19:08:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:34 INFO - 'SHELL': '/bin/bash', 19:08:34 INFO - 'SHLVL': '1', 19:08:34 INFO - 'TERM': 'linux', 19:08:34 INFO - 'TMOUT': '86400', 19:08:34 INFO - 'USER': 'cltbld', 19:08:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466206197.752485-474588126', 19:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:34 INFO - '_': '/tools/buildbot/bin/python'} 19:08:34 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/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:08:34 INFO - mozversion application_buildid: 20160617163038 19:08:34 INFO - mozversion application_changeset: 35530c11c1631b62e2e02c59e071f49d877b1184 19:08:34 INFO - mozversion application_display_name: Nightly 19:08:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:34 INFO - mozversion application_name: Firefox 19:08:34 INFO - mozversion application_remotingname: firefox 19:08:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:08:34 INFO - mozversion application_vendor: Mozilla 19:08:34 INFO - mozversion application_version: 50.0a1 19:08:34 INFO - mozversion platform_buildid: 20160617163038 19:08:34 INFO - mozversion platform_changeset: 35530c11c1631b62e2e02c59e071f49d877b1184 19:08:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:08:34 INFO - mozversion platform_version: 50.0a1 19:08:34 INFO - using testdate: 1466215714 19:08:34 INFO - actual date: 1466215714 19:08:34 INFO - starting webserver on 'localhost:52214' 19:08:34 INFO - SUITE-START | Running 2 tests 19:08:34 INFO - TEST-START | dromaeo_css 19:08:34 INFO - operating with platform_type : linux_ 19:08:34 INFO - Initialising browser for dromaeo_css test... 19:08:35 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGujeG3/profile http://localhost:52214/getInfo.html) 19:08:41 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 19:08:41 INFO - PROCESS | 3333 | colorDepth:24 19:08:41 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 19:08:41 INFO - PROCESS | 3333 | __metrics 19:08:42 ERROR - PROCESS | 3333 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:08:43 INFO - TEST-INFO | 3333: exit 0 19:08:43 INFO - Browser initialized. 19:08:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:43 INFO - TEST-INFO | started process 3454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGujeG3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:55 INFO - PROCESS | 3454 | RSS: Main: 184930304 19:08:55 INFO - PROCESS | 3454 | 19:09:44 INFO - PROCESS | 3454 | 1466215784843 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:11:53 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52214/tests/dromaeo/cssquery-ext.html) 19:11:54 INFO - PROCESS | 3454 | RSS: Main: 189984768 19:11:54 INFO - PROCESS | 3454 | 19:14:56 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-ext.html (next: http://localhost:52214/tests/dromaeo/cssquery-jquery.html) 19:14:56 INFO - PROCESS | 3454 | RSS: Main: 187412480 19:14:56 INFO - PROCESS | 3454 | 19:17:58 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52214/tests/dromaeo/cssquery-mootools.html) 19:17:59 INFO - PROCESS | 3454 | RSS: Main: 189218816 19:17:59 INFO - PROCESS | 3454 | 19:21:00 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52214/tests/dromaeo/cssquery-prototype.html) 19:21:01 INFO - PROCESS | 3454 | RSS: Main: 186568704 19:21:01 INFO - PROCESS | 3454 | 19:24:04 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52214/tests/dromaeo/cssquery-yui.html) 19:24:04 INFO - PROCESS | 3454 | RSS: Main: 188866560 19:24:04 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:52214/tests/dromaeo/cssquery-yui.html (next: http://localhost:52214/tests/dromaeo/cssquery-dojo.html) 19:27:07 INFO - PROCESS | 3454 | RSS: Main: 189927424 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | __start_tp_report 19:27:07 INFO - PROCESS | 3454 | _x_x_mozilla_page_load 19:27:07 INFO - PROCESS | 3454 | _x_x_mozilla_page_load_details 19:27:07 INFO - PROCESS | 3454 | |i|pagename|runs| 19:27:07 INFO - PROCESS | 3454 | |0;dojo.html;3090.768192385571;3136.576562164107;3164.9367012659745;3167.382360439714;3167.7624178186643;5333.519983201516;5401.972990135048;5447.809326673567;5478.972605136979;5493.615446918708;5319.255304257407;5323.866903327419;5370.382406023299;5407.026735187665;5415.160650099241;4823.999999999991;4847.951520484803;4873.658843880929;4999.9500004999845;5049.141645920184;4865.464798872121;5094.821681241157;5124.333836601237;5125.384953805548;5130.333056702642;4859.878503037435;4913.336699545569;4939.234418665077;4944;4945.406551213878;4959.05777902201;4959.900801983977;4971.875703107415;4976.87557811054;5029.647924645276;4929.137400954819;4934.555889969884;4945.703257804507;4961.5286547777905;4997.825076122318;5232.032074066272;5317;5338.519533242027;5379.1662292344745;5405.810796622139;5753.079507278857;5804.187413762034;5811.767529298823;5824.679642619654;5833.533317334603;5708.771649134072;5878.294604647427;5883.14694369314;5883.941160588382;5887.676177810219;5445.809396671137;5450.700211488366;5495.422980587021;5515.25544051556;5528.087865502228;5967.522598192134;5980.282366116007;5984.072468767261;5986.281646202484;6031.577789554777;5627.662340259598;5654.038813401731;5769.105788602773;5777.740001699934;5778.797742079091;5735.340435849847;5797.652140871562;5799.985002624524;5821.883562328814;5864.67744274069;5491.066518691832;5662.8301150965535;5707.400722924116;5742.712864356849;5774.2782152230975;5562.916556251659;5693.430656934273;5751.568632352591;5757.560609847538;5786.855328616818;4406.515283318832;4406.603405693439;4438.933415998763;4447.066116115588;4447.266201076851;3975.7018223633345;3982.6216509431556;3987.9202415951518;3995.400689896481;4031.9718471789506;5486.149646804752;5512.200730893998;5542.0301447246575;5547.1679248113105;5563.443655634404;5813.128030795415;5835.883282334415;5853.063509838491;5856.912146317809;5897.469227769521;5558.138488534284;5564.749586268627;5566.55467562594;5568.554515638739;5571.60998730085;4953.00939812039;4989;5016.122178618727;5035.571976382049;5063.620228482879;5971.134185543159;6002.369751176151;6009.038553831366;6015;6022.608530445507;5827.825165244964;5843.211166492469;5844.707764611838;5847.239858818326;5855.59010869235;5845.444682755132;5952.404759524013;5985.221921150222;6011.098335249748;6042.969785151046;5730.74211660468;5740.770369185353;5746.42535746422;5747.051736463437;5747.770089196385;5679.176519404746;5845.1232315151365;5856.560757943256;5860.355360910211;5862.501687356623;5574.331080270394;5623.943760562342;5646.830595082154;5662.03745363281;5703.914441283301;5496.203050557727;5608.6073974823;5639.351474580476;5661.915071273852;5668.234788303526;5589.80435684749;5595.07681232592;5606.6636001840025;5606.887862242814;5608.747606357642;5520;5713.285839270091;5743.798967036134;5799.333076696234;5834;5608.831735047955;5639.943600563942;5645.520130788929;5658.519025882846;5658.547316214611 19:27:07 INFO - PROCESS | 3454 | |1;ext.html;595.553334998751;613.6594190224425;618.0667192539264;656.4977791989128;657.944074753646;36939;41444.17111657765;41554.16891662169;41696.58303416965;41821;42507.14985700284;43032.3545146823;43277.78361108198;43284;43286.7835660822;8763.255123314526;8917.464952102862;8941.731748047569;8954.86567701485;8988.730338089836;8741.562921853914;8829.690960816373;8838.955805220965;8854.557272136399;8880.333974951873;8963.282937365027;8983.146601072887;8983.326250531203;8996.640134394616;8998.235150012257;8779.165979231962;8847.646094156225;8860.689875854347;8871.689490867853;8923.866142007875;8793.340499462565;8881.911180888173;8894.155055269805;8906.73279801607;8920.821583568293;33622;40470;40497.79751101255;40728;40822.59177408247;3299.8185099819502;3336.5996080470254;3577.3560759063357;3798.620137986207;4110.835566577333;30602.84698576515;31345.216369590944;31683.04950851478;31875.84062079698;32573.511397329057;4184.811683474251;4195.748255104703;4210.663146948237;4219.789010549491;4256.978715106436;284506;285189;287568.9999999979;287593;288313.9999999979;34016.82991585026;34425.139371515914;34603.307933841184;34706.65293347085;34836.82581587076;35298.64701353005;35960.82019589885;36323;36332.81833590815;36368.81815590905;15696.136712480924;15791.447299344467;15886.364545418053;15909;15913.204339782964;13176.077674562688;13308.93345533266;13357.198568085945;13375;13393.732125357634;8270.297024752843;8340.124286949904;8363.414560980795;8442.53566053873;8447.662093516314;3285.901422957315;3290.621578518501;3300.1089705779787;3334.583177102862;3359.8320083995704;982.5136557403988;988.6885631026347;1015.8069966706303;1068.8984546468073;1098.4068602954314;31450.21374465657;32156;32375.190620234684;32386.514202286984;32783.180420489676;1088.508743022049;1165.6211731187398;1170.1107158559555;1209.2623499665197;1233.5127624588238;16572.83427165737;17196.742048869277;17205.91397043007;17260.309587616353;17285.827141728423;509765;511378;516114;516384;517027;57320;57581.71209143927;57949.130763038585;58035.709821450626;58152.12771808426;1339.9531016414378;1388.8680575345327;1391.0957877379583;1398.084254813099;1408.8520705325998;31121;31676.208094796893;31884.202894927814;32017;32246.516302255954;50780.23829642632;50784.492155077976;51076.489235107176;51151;51281.48718512767;394735;405465;405511;405570;406085;27980.44039119247;28027.859860700566;28083.859580701966;28268.293292667848;28268.85865570659;47282.52717472919;47944.28083578679;48102.518974809806;48432.27351589799;49148.50851491439;40428.393574095826;41198.79400602978;41804.26462547792;42058;42382.57617423786;40275.79862100671;40442;40587;40902.1819563613;41158.588414115475;35894.64105358913;40148.598514015655;40251.79874100611;41034.38448423336;41085.58914410818;35476;36267.637323626426;36540;36883.262334753694;37100.25799483941;27282.181534553994;27837.304067398476;28132.57801132944;28184.29539261535;28383 19:27:07 INFO - PROCESS | 3454 | |2;jquery.html;376.4748176294069;386.13313112063423;394.80851786883363;395.07749405139;400.2575222961407;16933.83066169338;19223.90388048058;19970.600587988232;19992.20031198754;20042.899785501053;18556.907215463936;18577.25690972363;18606.16272267748;18955.52611184721;18959.33642322519;5593.776248950037;5682.488576028157;5744.138379243105;5775.306963164405;5800.361960184377;5546.91679624806;5621.915671264935;5664.971675141618;5691.4024027476935;5720.1991721159075;5603.439656034405;5654.349749778767;5677.233573467591;5704.258446401962;5997.220361353018;5388.380336261341;6084.513238940896;6105.084237364386;6129.509639228851;6133.754649814002;5443.918341224885;5470.070088085035;5483.040467918138;5499.4225606311165;5530.917036244459;13657.590272291747;18648.881067136015;21512.247071352584;22981.425464363358;23028.424289392733;2328.4877326988035;2380.1193558383334;2507.323022783838;2878.4962631539606;3001.7598592112795;10036.347637403545;10694.732631684192;11023.503942322535;11919.523219071314;14423.27883605826;1790.8477779388768;1839.7884243312058;1851.4829791048387;1944.4361135270753;1972.6252012117652;75001.62499187524;77135;77762;78610;78774;10425.530851111718;10619.256652034283;10823.35059896393;10892.40091794943;10979.780404391868;15138.167400793061;15150.393984240727;15255.160966146968;15290.847091529165;15297.617559560877;8145.918540814635;8267.586620668942;8322.45904016237;8421.831563368822;8519.062903080656;8302.418830681794;8312;8312.584370781558;8472.915270847336;8487.363447741443;4649.95350046502;4676.508966558463;4717.386739723814;4759.6668233223345;4786.617070634341;1919.894405807694;1961.1861077652613;1962.5878565501405;2004.1582535335194;2005.6590379635204;850.4174640371242;947.1002547579827;966.6809952715587;983.8524221366853;1044.9007344302279;18412.907935460236;19105.713414298796;19329.613407731766;19381.321653742052;19777.703334449994;965.6234068713208;1005.3917379985004;1035.177034257767;1042.697617690861;1047.638564695179;9998.900560714088;10669.559609452624;10773.138148948065;10887.673369798918;10933.945330273456;418464;424823;424920;426236;428756;86217;89187.55406222928;89814;91873.54063229641;94478;990.8959559246175;1002.9619343979092;1013.8834034086027;1033.571068006784;1033.927625066238;16684.49946501607;16937.491875243762;16979.151042448077;17177.398791042753;17491.21289541948;38820.41769373518;39038;39886.40170397505;40685.186296273314;40774.59225407708;54465;57121.71439142778;58047;58051.70974145102;58095.804730740216;7408.740694075682;7835.981322428048;8450.450720703135;8492.193241642035;8539.8719019216;10344.27590068688;13466.461341546621;13827.51603693866;13830.861691382957;14255.857441425867;11853.525858965544;12139.210951288138;12236.143469957018;12240.449179787109;12498.821100074794;11995.64013079609;12032.27806331623;12440.253584784941;12475.313857737912;12626.684332891751;12122.333271670142;12395.566155184526;12580.119391642864;12749;12882.935585322013;7981;7996.760097197093;8078.474899131537;8209.466384685215;8281.337493000667;10531.684049478528;11723.35521546323;12043.578474753342;12499.56251531192;12611.558595449114 19:27:07 INFO - PROCESS | 3454 | |3;mootools.html;1472.5729538433852;1498.423107103765;1619.813721422037;1741.75615413842;1757.428835628421;7626.7330643427495;8126.715564955228;8421.957890210548;8962.148595883396;8968.282537397;8225.794355141124;8406.579671016456;8482.109378515244;8510.574471276426;8524.104968978245;2244.9102035918586;2286.965695514569;2290.1068583252463;2293.908243670251;2294.4149241943283;2200.6588978708246;2213.800757931786;2240.182333448296;2245.0682966568857;2253.4141123307895;2221.566794475078;2227.576760415524;2239.608068587999;2248.617734985048;2264.830137739668;2111.5354621983292;2137.8824164670937;2145.5923374558784;2152.6878602602615;2158.4495953531905;2111.419359676086;2115.3125234298914;2115.333669893994;2115.7989990950837;2119.173522326294;8499.107593702634;8666.86999695005;8677.913220867773;8684.739457816213;8734.781630459225;4799.13615549201;4896.4858689837765;4900.166971614834;4908.460069392364;4926.975365123188;3058.694130586946;3143.6699146589735;3246.2533617267923;3249.8537565809597;3257.4299497588063;977.310995748003;1033.3438266700623;1046.529061922138;1054.488573042074;1055.2349546578669;12064.517419303218;12124.575639852652;12159.27044377349;12166.270023798601;12186.329751863645;4509.661775366795;4517.299818528133;4522.389477420506;4522.796474158671;4528.343390208402;10298.07317341428;10299.691009269734;10311.793764124826;10351.63769268072;10353.327033742782;5089.898202036013;5126.154184559506;5147.202183661539;5151;5158.380994280636;3988.4219982033787;4502.077074199781;4516.299973504047;4762.595179409789;4766.046790641816;3897.61023897608;3920.6471417571984;3983.940240896389;4020.7386519876113;4065.308897487375;1220.4873952939786;1228.4287806170173;1247.1830950727287;1251.9624411267675;1268.61307301274;875.5840975536696;884.3014018925106;997.8474861534938;1003.172382784206;1023.6570748799087;6088.11722300264;6098.1157732128595;6106.419890110521;6146.907796383058;6156.630602163885;426.413681188366;431.67408606502516;438.15217554033046;443.80173531465175;446.90614970855836;4210.2842516772225;4267.1892340455215;4367.956320436755;4396.318570621559;4398.516163222043;10463.372197668165;10858.511366988505;10898.94550527258;10920.781584368267;10983.450827458755;10513.579456821795;10844.186685998582;10887.455627218607;10956.671299861016;10978.176636752116;8145.7556273313085;8217.301529369952;8226.136255693185;8265.132161123116;8279;5621.353544342453;5673.319201695823;5711.914321285267;5893.557983151195;5902.439268269508;9672.322937394596;9839.606415743576;10045.146162576262;10106.19150467946;10111.3427627204;10060.597576097167;10077.445740484343;10092.091711745978;10093.142082923034;10240.743981400525;7089.964550177422;7366.889496657447;7511.887321690069;7681.731139410093;7719.922800772145;8466.74599762008;8485.533295668798;8488.363372746946;8545.572721363782;8592.398532102943;7426.888596671162;7471.40228781707;7535.208803075599;7632.274933881273;7755.457118001911;7380.446466514925;7488.213737557696;7560.8487830244185;7621.275978782007;7642.121156066901;7113.253108423541;7176.533525320838;7219.133703955349;7243.311885370881;7249.782506524813;5060.797568097235;5130.820421285237;5206.739663016759;5265.526102650627;5284.471552844685;5393.1370980642905;5442.809501667422;5465.289512363367;5472.753726082256;5490.835274941758 19:27:07 INFO - PROCESS | 3454 | |4;prototype.html;321.23225491076323;321.34445730709353;325.4792332268369;330.5240453746606;330.8329293706678;5662.292213473316;5706.828795136143;5715.371309155989;5741.569382296334;5749.856253593663;5573.498385145336;5604.943950560493;5615.775368985236;5620.325560932683;5647.322321321447;4057.695672824535;4336.349547567875;4369.3664418659355;4403.405540252057;4414.78593386818;4311.762853043081;4322.97838510807;4326.663601655118;4329.350597410382;4340.913181736363;4322.157179350028;4325.74045557266;4326.831755426033;4337.371081193225;4341.590417318387;4099.754014759109;4138.8344466221315;4285.250081235802;4289.892752681177;4390.51704312527;3711.6102809204913;3724.2365315110337;3724.6777394025003;3726;3731.738778285521;5460.726963651841;5461.754221060062;5473.151661492475;5508.421615730371;5516.806911758109;4830.637702172316;4929.457759646436;4955.653104282702;4974.129527332702;5003.199488081926;5853.3903176626345;5853.619514731528;5916.497097746654;5949.851253718648;5970.34326224115;4067.2068946555432;4083.1221287423346;4090.4886889138857;4097.057676734368;4100.384942258655;5760.395158508338;6089.725962331661;6137.693115344259;6153.354057755164;6167.383261673842;4174;4184.14225083857;4198.6641068714425;4200.15996800635;4207.537170911197;4180.226658068267;4212.241796476664;4215.388768628532;4252.787360631956;4270.145970805851;4793.18515852306;4940.776650507286;4943.233798761198;4954.405471343462;4969.403671559436;5892.292924849045;5937.960856850034;5940.762369505172;6001.849953751192;6033.276006879202;1465.2673663168416;1475.4688312207597;1493.5444689369629;1494.2230040378943;1496.6034000989746;935.1256575102301;942.3450701762209;985.2118305355687;989.7674046599044;997.6209040564539;5645.379008309083;5693.5160511357;5705.91587598355;5761.164631128463;5782.768689252467;5979.133025711248;6011.6693581853415;6057.182280392179;6082.513398928075;6123.540734444934;5488.862778430492;5602.439756024365;5746.540276777848;5760.251167348218;5784.305883293948;3242.319112986252;3250.317433338978;3262.722668573198;3269.6566860479784;3312.3209742003314;6120.867639486709;6172.611162488404;6280.466160376419;6294.2446906370615;6341.968290158519;6278.780242691575;6285.182926219562;6286.762317406539;6312.589681670676;6335.334789847092;6231.781887634002;6282.811515654537;6298.149749783812;6346.143270658402;6352.745890164341;5844.590878638454;6086.60437071589;6099.451049405575;6101.60339577926;6122.418370254819;6072.514198864169;6093.933561626786;6104.69476526163;6110.26676798787;6116.9202471160015;5990.903183885605;6272.874542509033;6335.809925702236;6348.555601107878;6365.77719779824;4248.2353176427305;4265.91468170641;4280.61474467287;4281.464816897887;4295.742255464682;6140.8771824564155;6155.415235552616;6160.353162917829;6165.691715414122;6167.506599471942;5768.596198266081;5960.254968128984;5963.658176910334;5964.284285885721;6008.849778755566;5880.06035955902;5908.350081490947;5910.1725758392995;5940.287165540163;5942.881142377215;5715.599678078897;5818.592698511064;5833.329167145833;5866.413358664099;5903.229031290682;5910;5949;5952.940470595238;5984.491318237999;6053.577409308897;5754.712264386848;5788.942110579009;5847.152162936265;5854.560907931837;5867.591777973341 19:27:07 INFO - PROCESS | 3454 | |5;yui.html;688.311688311688;725.3906718356579;750.9962450187749;761.033487470912;788.5978151142915;14495.927520362397;15889;16053;16269.023858568495;16378.590535236624;14635.92682036591;14768.483103091394;14794;14794.112353258784;14819.777703334432;665.5407768639648;778.5367706214793;783.1698399696326;790.7627711686471;802.5505716798582;786.6892577431911;792.3779832831228;792.7344339646226;795.0896223823719;796.8844517544952;843.42225575481;846.3144852669358;846.3652260804397;846.6655671009947;847.2120927537388;838.6351936907434;840.9117042710519;841.5792103948025;844.5228445928062;847.1740053447901;610.4780412747126;610.9114178444145;612.1552257884136;612.874360756044;613.8833621611924;14955.850441495555;14958.252087395695;14963.775543366859;14968.101913885093;15050.548483545512;15298.923505382512;15421.15183664898;15468.690626187527;15571.299291531908;15901.443449479328;12031.699207519794;12302.938485307515;12404.56584019564;12417.130800843945;12593.93703031479;3934.626210509997;3951.328274193394;3955.3078211312904;3966.484357033596;4045.9797701011603;77647.6117619414;78168.21831781666;78604.21395786083;81265.59367203126;81269.59365203195;11992.460339284753;12127.696807579881;12227.205231659913;12287.078469114853;12330.445129969174;22758.772412275997;22952.311430657108;22999.540009200056;23036.89001984744;23087.307380778602;8794.120587941155;8939.195472407515;8960.283177345797;8967.997087470618;9088.500132492643;4569.702969306984;4594.655400844883;4595.908081838412;4629.583337499574;4696.671233013724;3506.8246587670515;3592.604813470516;3616.4213725803747;3620.9818950905606;3648.2338708871434;597.3787261248253;609.2262826210776;614.0850133301349;616.3713012726994;621.1986537366837;596.785157343356;599.4994179859779;681.6652963599652;739.7706710919524;746.2910235276509;8945.910540894638;9155.450672959643;9190.172884440433;9545.47499887499;9549.65219477095;558.8574913397058;656.2223764838682;667.1593791822339;679.296927679849;765.0475158427682;4295.484541854935;4481.305397663367;4631.490536041033;4639.932815452465;4683.601893838993;114857;116453.41773291079;117778;118455.40772296084;119127;62237.06644400338;101225.49387253016;102712.48643756734;102828;103053;73801.26198737943;74844;83096;85174.57412712897;86627.56686216529;9085.54572271397;9509.476978766234;10230;10288.897111029093;10363.585456581652;49614;50191.4942551724;50196.749016256144;50739.49260507496;52264.21603676024;66921.33078669151;75432.24567754252;76066.23933760592;76878.23121768935;77877;13021.739565208452;13130;13190;13301.534446294334;13625.727485450434;14622.251034757977;14884.181370024753;15082.321295541507;15254;15492.457763978207;14049.508267211007;14118.364673589918;14381;14515.637109072357;14565.490207842675;12830.358482076046;12938.223706577635;12954.417051232529;13408.463661453432;13713.725725485236;13503.59489215325;13676.794848077487;13988.000318928189;14490.63773405631;14495.275236237934;11579.942100289782;11762.470688819194;11829.231099978473;11862.584809531625;12177.33024683651;11093.556257749922;11253;11566.884331156918;11874.643760687193;11897.940510297392 19:27:07 INFO - PROCESS | 3454 | __end_tp_report 19:27:07 INFO - PROCESS | 3454 | __start_cc_report 19:27:07 INFO - PROCESS | 3454 | _x_x_mozilla_cycle_collect,362 19:27:07 INFO - PROCESS | 3454 | __end_cc_report 19:27:07 INFO - PROCESS | 3454 | __startTimestamp1466216827465__endTimestamp 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | ------- Summary: start ------- 19:27:07 INFO - PROCESS | 3454 | Number of tests: 6 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#0] dojo.html Cycles:165 Average:5398.35 Median:5606.66 stddev:607.14 (10.8%) stddev-sans-first:581.38 19:27:07 INFO - PROCESS | 3454 | Values: 3090.8 3136.6 3164.9 3167.4 3167.8 5333.5 5402.0 5447.8 5479.0 5493.6 5319.3 5323.9 5370.4 5407.0 5415.2 4824.0 4848.0 4873.7 5000.0 5049.1 4865.5 5094.8 5124.3 5125.4 5130.3 4859.9 4913.3 4939.2 4944.0 4945.4 4959.1 4959.9 4971.9 4976.9 5029.6 4929.1 4934.6 4945.7 4961.5 4997.8 5232.0 5317.0 5338.5 5379.2 5405.8 5753.1 5804.2 5811.8 5824.7 5833.5 5708.8 5878.3 5883.1 5883.9 5887.7 5445.8 5450.7 5495.4 5515.3 5528.1 5967.5 5980.3 5984.1 5986.3 6031.6 5627.7 5654.0 5769.1 5777.7 5778.8 5735.3 5797.7 5800.0 5821.9 5864.7 5491.1 5662.8 5707.4 5742.7 5774.3 5562.9 5693.4 5751.6 5757.6 5786.9 4406.5 4406.6 4438.9 4447.1 4447.3 3975.7 3982.6 3987.9 3995.4 4032.0 5486.1 5512.2 5542.0 5547.2 5563.4 5813.1 5835.9 5853.1 5856.9 5897.5 5558.1 5564.7 5566.6 5568.6 5571.6 4953.0 4989.0 5016.1 5035.6 5063.6 5971.1 6002.4 6009.0 6015.0 6022.6 5827.8 5843.2 5844.7 5847.2 5855.6 5845.4 5952.4 5985.2 6011.1 6043.0 5730.7 5740.8 5746.4 5747.1 5747.8 5679.2 5845.1 5856.6 5860.4 5862.5 5574.3 5623.9 5646.8 5662.0 5703.9 5496.2 5608.6 5639.4 5661.9 5668.2 5589.8 5595.1 5606.7 5606.9 5608.7 5520.0 5713.3 5743.8 5799.3 5834.0 5608.8 5639.9 5645.5 5658.5 5658.5 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#1] ext.html Cycles:180 Average:54983.27 Median:40456.00 stddev:109397.35 (270.4%) stddev-sans-first:109628.02 19:27:07 INFO - PROCESS | 3454 | Values: 595.6 613.7 618.1 656.5 657.9 36939.0 41444.2 41554.2 41696.6 41821.0 42507.1 43032.4 43277.8 43284.0 43286.8 8763.3 8917.5 8941.7 8954.9 8988.7 8741.6 8829.7 8839.0 8854.6 8880.3 8963.3 8983.1 8983.3 8996.6 8998.2 8779.2 8847.6 8860.7 8871.7 8923.9 8793.3 8881.9 8894.2 8906.7 8920.8 33622.0 40470.0 40497.8 40728.0 40822.6 3299.8 3336.6 3577.4 3798.6 4110.8 30602.8 31345.2 31683.0 31875.8 32573.5 4184.8 4195.7 4210.7 4219.8 4257.0 284506.0 285189.0 287569.0 287593.0 288314.0 34016.8 34425.1 34603.3 34706.7 34836.8 35298.6 35960.8 36323.0 36332.8 36368.8 15696.1 15791.4 15886.4 15909.0 15913.2 13176.1 13308.9 13357.2 13375.0 13393.7 8270.3 8340.1 8363.4 8442.5 8447.7 3285.9 3290.6 3300.1 3334.6 3359.8 982.5 988.7 1015.8 1068.9 1098.4 31450.2 32156.0 32375.2 32386.5 32783.2 1088.5 1165.6 1170.1 1209.3 1233.5 16572.8 17196.7 17205.9 17260.3 17285.8 509765.0 511378.0 516114.0 516384.0 517027.0 57320.0 57581.7 57949.1 58035.7 58152.1 1340.0 1388.9 1391.1 1398.1 1408.9 31121.0 31676.2 31884.2 32017.0 32246.5 50780.2 50784.5 51076.5 51151.0 51281.5 394735.0 405465.0 405511.0 405570.0 406085.0 27980.4 28027.9 28083.9 28268.3 28268.9 47282.5 47944.3 48102.5 48432.3 49148.5 40428.4 41198.8 41804.3 42058.0 42382.6 40275.8 40442.0 40587.0 40902.2 41158.6 35894.6 40148.6 40251.8 41034.4 41085.6 35476.0 36267.6 36540.0 36883.3 37100.3 27282.2 27837.3 28132.6 28184.3 28383.0 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#2] jquery.html Cycles:180 Average:26944.66 Median:2692.91 stddev:70286.18 (2610.0%) stddev-sans-first:70455.04 19:27:07 INFO - PROCESS | 3454 | Values: 376.5 386.1 394.8 395.1 400.3 16933.8 19223.9 19970.6 19992.2 20042.9 18556.9 18577.3 18606.2 18955.5 18959.3 5593.8 5682.5 5744.1 5775.3 5800.4 5546.9 5621.9 5665.0 5691.4 5720.2 5603.4 5654.3 5677.2 5704.3 5997.2 5388.4 6084.5 6105.1 6129.5 6133.8 5443.9 5470.1 5483.0 5499.4 5530.9 13657.6 18648.9 21512.2 22981.4 23028.4 2328.5 2380.1 2507.3 2878.5 3001.8 10036.3 10694.7 11023.5 11919.5 14423.3 1790.8 1839.8 1851.5 1944.4 1972.6 75001.6 77135.0 77762.0 78610.0 78774.0 10425.5 10619.3 10823.4 10892.4 10979.8 15138.2 15150.4 15255.2 15290.8 15297.6 8145.9 8267.6 8322.5 8421.8 8519.1 8302.4 8312.0 8312.6 8472.9 8487.4 4650.0 4676.5 4717.4 4759.7 4786.6 1919.9 1961.2 1962.6 2004.2 2005.7 850.4 947.1 966.7 983.9 1044.9 18412.9 19105.7 19329.6 19381.3 19777.7 965.6 1005.4 1035.2 1042.7 1047.6 9998.9 10669.6 10773.1 10887.7 10933.9 418464.0 424823.0 424920.0 426236.0 428756.0 86217.0 89187.6 89814.0 91873.5 94478.0 990.9 1003.0 1013.9 1033.6 1033.9 16684.5 16937.5 16979.2 17177.4 17491.2 38820.4 39038.0 39886.4 40685.2 40774.6 54465.0 57121.7 58047.0 58051.7 58095.8 7408.7 7836.0 8450.5 8492.2 8539.9 10344.3 13466.5 13827.5 13830.9 14255.9 11853.5 12139.2 12236.1 12240.4 12498.8 11995.6 12032.3 12440.3 12475.3 12626.7 12122.3 12395.6 12580.1 12749.0 12882.9 7981.0 7996.8 8078.5 8209.5 8281.3 10531.7 11723.4 12043.6 12499.6 12611.6 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#3] mootools.html Cycles:180 Average:5710.59 Median:4505.87 stddev:3296.12 (73.2%) stddev-sans-first:3289.99 19:27:07 INFO - PROCESS | 3454 | Values: 1472.6 1498.4 1619.8 1741.8 1757.4 7626.7 8126.7 8422.0 8962.1 8968.3 8225.8 8406.6 8482.1 8510.6 8524.1 2244.9 2287.0 2290.1 2293.9 2294.4 2200.7 2213.8 2240.2 2245.1 2253.4 2221.6 2227.6 2239.6 2248.6 2264.8 2111.5 2137.9 2145.6 2152.7 2158.4 2111.4 2115.3 2115.3 2115.8 2119.2 8499.1 8666.9 8677.9 8684.7 8734.8 4799.1 4896.5 4900.2 4908.5 4927.0 3058.7 3143.7 3246.3 3249.9 3257.4 977.3 1033.3 1046.5 1054.5 1055.2 12064.5 12124.6 12159.3 12166.3 12186.3 4509.7 4517.3 4522.4 4522.8 4528.3 10298.1 10299.7 10311.8 10351.6 10353.3 5089.9 5126.2 5147.2 5151.0 5158.4 3988.4 4502.1 4516.3 4762.6 4766.0 3897.6 3920.6 3983.9 4020.7 4065.3 1220.5 1228.4 1247.2 1252.0 1268.6 875.6 884.3 997.8 1003.2 1023.7 6088.1 6098.1 6106.4 6146.9 6156.6 426.4 431.7 438.2 443.8 446.9 4210.3 4267.2 4368.0 4396.3 4398.5 10463.4 10858.5 10898.9 10920.8 10983.5 10513.6 10844.2 10887.5 10956.7 10978.2 8145.8 8217.3 8226.1 8265.1 8279.0 5621.4 5673.3 5711.9 5893.6 5902.4 9672.3 9839.6 10045.1 10106.2 10111.3 10060.6 10077.4 10092.1 10093.1 10240.7 7090.0 7366.9 7511.9 7681.7 7719.9 8466.7 8485.5 8488.4 8545.6 8592.4 7426.9 7471.4 7535.2 7632.3 7755.5 7380.4 7488.2 7560.8 7621.3 7642.1 7113.3 7176.5 7219.1 7243.3 7249.8 5060.8 5130.8 5206.7 5265.5 5284.5 5393.1 5442.8 5465.3 5472.8 5490.8 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#4] prototype.html Cycles:180 Average:4963.88 Median:5748.20 stddev:1494.87 (26.0%) stddev-sans-first:1457.88 19:27:07 INFO - PROCESS | 3454 | Values: 321.2 321.3 325.5 330.5 330.8 5662.3 5706.8 5715.4 5741.6 5749.9 5573.5 5604.9 5615.8 5620.3 5647.3 4057.7 4336.3 4369.4 4403.4 4414.8 4311.8 4323.0 4326.7 4329.4 4340.9 4322.2 4325.7 4326.8 4337.4 4341.6 4099.8 4138.8 4285.3 4289.9 4390.5 3711.6 3724.2 3724.7 3726.0 3731.7 5460.7 5461.8 5473.2 5508.4 5516.8 4830.6 4929.5 4955.7 4974.1 5003.2 5853.4 5853.6 5916.5 5949.9 5970.3 4067.2 4083.1 4090.5 4097.1 4100.4 5760.4 6089.7 6137.7 6153.4 6167.4 4174.0 4184.1 4198.7 4200.2 4207.5 4180.2 4212.2 4215.4 4252.8 4270.1 4793.2 4940.8 4943.2 4954.4 4969.4 5892.3 5938.0 5940.8 6001.8 6033.3 1465.3 1475.5 1493.5 1494.2 1496.6 935.1 942.3 985.2 989.8 997.6 5645.4 5693.5 5705.9 5761.2 5782.8 5979.1 6011.7 6057.2 6082.5 6123.5 5488.9 5602.4 5746.5 5760.3 5784.3 3242.3 3250.3 3262.7 3269.7 3312.3 6120.9 6172.6 6280.5 6294.2 6342.0 6278.8 6285.2 6286.8 6312.6 6335.3 6231.8 6282.8 6298.1 6346.1 6352.7 5844.6 6086.6 6099.5 6101.6 6122.4 6072.5 6093.9 6104.7 6110.3 6116.9 5990.9 6272.9 6335.8 6348.6 6365.8 4248.2 4265.9 4280.6 4281.5 4295.7 6140.9 6155.4 6160.4 6165.7 6167.5 5768.6 5960.3 5963.7 5964.3 6008.8 5880.1 5908.4 5910.2 5940.3 5942.9 5715.6 5818.6 5833.3 5866.4 5903.2 5910.0 5949.0 5952.9 5984.5 6053.6 5754.7 5788.9 5847.2 5854.6 5867.6 19:27:07 INFO - PROCESS | 3454 | 19:27:07 INFO - PROCESS | 3454 | [#5] yui.html Cycles:180 Average:20842.03 Median:4006.23 stddev:29735.53 (742.2%) stddev-sans-first:29780.44 19:27:07 INFO - PROCESS | 3454 | Values: 688.3 725.4 751.0 761.0 788.6 14495.9 15889.0 16053.0 16269.0 16378.6 14635.9 14768.5 14794.0 14794.1 14819.8 665.5 778.5 783.2 790.8 802.6 786.7 792.4 792.7 795.1 796.9 843.4 846.3 846.4 846.7 847.2 838.6 840.9 841.6 844.5 847.2 610.5 610.9 612.2 612.9 613.9 14955.9 14958.3 14963.8 14968.1 15050.5 15298.9 15421.2 15468.7 15571.3 15901.4 12031.7 12302.9 12404.6 12417.1 12593.9 3934.6 3951.3 3955.3 3966.5 4046.0 77647.6 78168.2 78604.2 81265.6 81269.6 11992.5 12127.7 12227.2 12287.1 12330.4 22758.8 22952.3 22999.5 23036.9 23087.3 8794.1 8939.2 8960.3 8968.0 9088.5 4569.7 4594.7 4595.9 4629.6 4696.7 3506.8 3592.6 3616.4 3621.0 3648.2 597.4 609.2 614.1 616.4 621.2 596.8 599.5 681.7 739.8 746.3 8945.9 9155.5 9190.2 9545.5 9549.7 558.9 656.2 667.2 679.3 765.0 4295.5 4481.3 4631.5 4639.9 4683.6 114857.0 116453.4 117778.0 118455.4 119127.0 62237.1 101225.5 102712.5 102828.0 103053.0 73801.3 74844.0 83096.0 85174.6 86627.6 9085.5 9509.5 10230.0 10288.9 10363.6 49614.0 50191.5 50196.7 50739.5 52264.2 66921.3 75432.2 76066.2 76878.2 77877.0 13021.7 13130.0 13190.0 13301.5 13625.7 14622.3 14884.2 15082.3 15254.0 15492.5 14049.5 14118.4 14381.0 14515.6 14565.5 12830.4 12938.2 12954.4 13408.5 13713.7 13503.6 13676.8 13988.0 14490.6 14495.3 11579.9 11762.5 11829.2 11862.6 12177.3 11093.6 11253.0 11566.9 11874.6 11897.9 19:27:07 INFO - PROCESS | 3454 | -------- Summary: end -------- 19:27:07 INFO - PROCESS | 3454 | 19:27:08 INFO - TEST-INFO | 3454: exit 0 19:27:08 INFO - TEST-OK | dromaeo_css | took 1113296ms 19:27:08 INFO - TEST-START | kraken 19:27:08 INFO - operating with platform_type : linux_ 19:27:08 INFO - Initialising browser for kraken test... 19:27:08 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC4gBa9/profile http://localhost:52214/getInfo.html) 19:27:13 INFO - PROCESS | 3689 | __metrics Screen width/height:1600/1200 19:27:13 INFO - PROCESS | 3689 | colorDepth:24 19:27:13 INFO - PROCESS | 3689 | Browser inner width/height: 1024/697 19:27:13 INFO - PROCESS | 3689 | __metrics 19:27:13 ERROR - PROCESS | 3689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:27:14 INFO - TEST-INFO | 3689: exit 0 19:27:14 INFO - Browser initialized. 19:27:14 INFO - Running cycle 1/1 for kraken test... 19:27:14 INFO - TEST-INFO | started process 3808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC4gBa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:26 INFO - PROCESS | 3808 | RSS: Main: 185159680 19:27:26 INFO - PROCESS | 3808 | 19:27:29 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52214/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:30 INFO - PROCESS | 3808 | RSS: Main: 190787584 19:27:30 INFO - PROCESS | 3808 | 19:27:32 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52214/tests/kraken/driver.html?testName=audio-dft) 19:27:33 INFO - PROCESS | 3808 | RSS: Main: 190099456 19:27:33 INFO - PROCESS | 3808 | 19:27:36 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52214/tests/kraken/driver.html?testName=audio-fft) 19:27:36 INFO - PROCESS | 3808 | RSS: Main: 184659968 19:27:36 INFO - PROCESS | 3808 | 19:27:39 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52214/tests/kraken/driver.html?testName=audio-oscillator) 19:27:39 INFO - PROCESS | 3808 | RSS: Main: 185860096 19:27:39 INFO - PROCESS | 3808 | 19:27:42 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:42 INFO - PROCESS | 3808 | RSS: Main: 186023936 19:27:42 INFO - PROCESS | 3808 | 19:27:45 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52214/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:46 INFO - PROCESS | 3808 | RSS: Main: 186535936 19:27:46 INFO - PROCESS | 3808 | 19:27:49 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52214/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:50 INFO - PROCESS | 3808 | RSS: Main: 183193600 19:27:50 INFO - PROCESS | 3808 | 19:27:53 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52214/tests/kraken/driver.html?testName=json-parse-financial) 19:27:54 INFO - PROCESS | 3808 | RSS: Main: 185618432 19:27:54 INFO - PROCESS | 3808 | 19:27:55 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:56 INFO - PROCESS | 3808 | RSS: Main: 186130432 19:27:56 INFO - PROCESS | 3808 | 19:27:58 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:58 INFO - PROCESS | 3808 | RSS: Main: 186241024 19:27:58 INFO - PROCESS | 3808 | 19:28:00 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:01 INFO - PROCESS | 3808 | RSS: Main: 186535936 19:28:01 INFO - PROCESS | 3808 | 19:28:04 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:04 INFO - PROCESS | 3808 | RSS: Main: 186511360 19:28:04 INFO - PROCESS | 3808 | 19:28:07 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:08 INFO - PROCESS | 3808 | RSS: Main: 186068992 19:28:08 INFO - PROCESS | 3808 | 19:28:09 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:52214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52214/tests/kraken/driver.html?testName=ai-astar) 19:28:10 INFO - PROCESS | 3808 | RSS: Main: 186826752 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | __start_tp_report 19:28:10 INFO - PROCESS | 3808 | _x_x_mozilla_page_load 19:28:10 INFO - PROCESS | 3808 | _x_x_mozilla_page_load_details 19:28:10 INFO - PROCESS | 3808 | |i|pagename|runs| 19:28:10 INFO - PROCESS | 3808 | |0;ai-astar;114;105;112;112;114;111;112;112;112;112 19:28:10 INFO - PROCESS | 3808 | |1;audio-beat-detection;151;142;157;186;127;154;155;127;178;134 19:28:10 INFO - PROCESS | 3808 | |2;audio-dft;163;161;160;161;162;167;168;163;160;162 19:28:10 INFO - PROCESS | 3808 | |3;audio-fft;76;76;74;159;76;75;84;75;172;75 19:28:10 INFO - PROCESS | 3808 | |4;audio-oscillator;86;85;138;85;85;84;135;85;84;144 19:28:10 INFO - PROCESS | 3808 | |5;imaging-gaussian-blur;117;117;119;117;119;118;117;117;117;117 19:28:10 INFO - PROCESS | 3808 | |6;imaging-darkroom;147;147;148;149;147;148;147;147;146;147 19:28:10 INFO - PROCESS | 3808 | |7;imaging-desaturate;95;95;100;96;96;96;96;96;97;96 19:28:10 INFO - PROCESS | 3808 | |8;json-parse-financial;56;55;55;55;56;55;57;59;55;56 19:28:10 INFO - PROCESS | 3808 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;62 19:28:10 INFO - PROCESS | 3808 | |10;stanford-crypto-aes;84;80;82;81;81;81;80;80;108;86 19:28:10 INFO - PROCESS | 3808 | |11;stanford-crypto-ccm;142;123;131;121;120;137;124;123;139;132 19:28:10 INFO - PROCESS | 3808 | |12;stanford-crypto-pbkdf2;161;162;162;160;168;159;169;171;158;161 19:28:10 INFO - PROCESS | 3808 | |13;stanford-crypto-sha256-iterative;64;62;67;79;62;65;63;64;66;62 19:28:10 INFO - PROCESS | 3808 | __end_tp_report 19:28:10 INFO - PROCESS | 3808 | __start_cc_report 19:28:10 INFO - PROCESS | 3808 | _x_x_mozilla_cycle_collect,912 19:28:10 INFO - PROCESS | 3808 | __end_cc_report 19:28:10 INFO - PROCESS | 3808 | __startTimestamp1466216890010__endTimestamp 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | ------- Summary: start ------- 19:28:10 INFO - PROCESS | 3808 | Number of tests: 14 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:2.50 19:28:10 INFO - PROCESS | 3808 | Values: 114.0 105.0 112.0 112.0 114.0 111.0 112.0 112.0 112.0 112.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:154.50 stddev:19.82 (12.8%) stddev-sans-first:21.03 19:28:10 INFO - PROCESS | 3808 | Values: 151.0 142.0 157.0 186.0 127.0 154.0 155.0 127.0 178.0 134.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.75 (1.7%) stddev-sans-first:2.92 19:28:10 INFO - PROCESS | 3808 | Values: 163.0 161.0 160.0 161.0 162.0 167.0 168.0 163.0 160.0 162.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:37.81 (50.1%) stddev-sans-first:39.52 19:28:10 INFO - PROCESS | 3808 | Values: 76.0 76.0 74.0 159.0 76.0 75.0 84.0 75.0 172.0 75.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:85.00 stddev:26.25 (30.9%) stddev-sans-first:27.27 19:28:10 INFO - PROCESS | 3808 | Values: 86.0 85.0 138.0 85.0 85.0 84.0 135.0 85.0 84.0 144.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 19:28:10 INFO - PROCESS | 3808 | Values: 117.0 117.0 119.0 117.0 119.0 118.0 117.0 117.0 117.0 117.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 19:28:10 INFO - PROCESS | 3808 | Values: 147.0 147.0 148.0 149.0 147.0 148.0 147.0 147.0 146.0 147.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 19:28:10 INFO - PROCESS | 3808 | Values: 95.0 95.0 100.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.29 (2.3%) stddev-sans-first:1.36 19:28:10 INFO - PROCESS | 3808 | Values: 56.0 55.0 55.0 55.0 56.0 55.0 57.0 59.0 55.0 56.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:28:10 INFO - PROCESS | 3808 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:8.55 (10.6%) stddev-sans-first:9.07 19:28:10 INFO - PROCESS | 3808 | Values: 84.0 80.0 82.0 81.0 81.0 81.0 80.0 80.0 108.0 86.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:131.50 stddev:8.08 (6.1%) stddev-sans-first:7.12 19:28:10 INFO - PROCESS | 3808 | Values: 142.0 123.0 131.0 121.0 120.0 137.0 124.0 123.0 139.0 132.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:162.00 stddev:4.53 (2.8%) stddev-sans-first:4.74 19:28:10 INFO - PROCESS | 3808 | Values: 161.0 162.0 162.0 160.0 168.0 159.0 169.0 171.0 158.0 161.0 19:28:10 INFO - PROCESS | 3808 | 19:28:10 INFO - PROCESS | 3808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:64.50 stddev:5.08 (7.9%) stddev-sans-first:5.36 19:28:10 INFO - PROCESS | 3808 | Values: 64.0 62.0 67.0 79.0 62.0 65.0 63.0 64.0 66.0 62.0 19:28:10 INFO - PROCESS | 3808 | -------- Summary: end -------- 19:28:10 INFO - PROCESS | 3808 | 19:28:11 INFO - TEST-INFO | 3808: exit 0 19:28:11 INFO - TEST-OK | kraken | took 62789ms 19:28:11 INFO - SUITE-END | took 1176s 19:28:11 INFO - Completed test suite (00:19:36) 19:28:11 INFO - javascript benchmark 19:28:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7189.304145321706, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.768192385571, 3136.576562164107, 3164.9367012659745, 3167.382360439714, 3167.7624178186643, 5333.519983201516, 5401.972990135048, 5447.809326673567, 5478.972605136979, 5493.615446918708, 5319.255304257407, 5323.866903327419, 5370.382406023299, 5407.026735187665, 5415.160650099241, 4823.999999999991, 4847.951520484803, 4873.658843880929, 4999.9500004999845, 5049.141645920184, 4865.464798872121, 5094.821681241157, 5124.333836601237, 5125.384953805548, 5130.333056702642, 4859.878503037435, 4913.336699545569, 4939.234418665077, 4944.0, 4945.406551213878, 4959.05777902201, 4959.900801983977, 4971.875703107415, 4976.87557811054, 5029.647924645276, 4929.137400954819, 4934.555889969884, 4945.703257804507, 4961.5286547777905, 4997.825076122318, 5232.032074066272, 5317.0, 5338.519533242027, 5379.1662292344745, 5405.810796622139, 5753.079507278857, 5804.187413762034, 5811.767529298823, 5824.679642619654, 5833.533317334603, 5708.771649134072, 5878.294604647427, 5883.14694369314, 5883.941160588382, 5887.676177810219, 5445.809396671137, 5450.700211488366, 5495.422980587021, 5515.25544051556, 5528.087865502228, 5967.522598192134, 5980.282366116007, 5984.072468767261, 5986.281646202484, 6031.577789554777, 5627.662340259598, 5654.038813401731, 5769.105788602773, 5777.740001699934, 5778.797742079091, 5735.340435849847, 5797.652140871562, 5799.985002624524, 5821.883562328814, 5864.67744274069, 5491.066518691832, 5662.8301150965535, 5707.400722924116, 5742.712864356849, 5774.2782152230975, 5562.916556251659, 5693.430656934273, 5751.568632352591, 5757.560609847538, 5786.855328616818, 4406.515283318832, 4406.603405693439, 4438.933415998763, 4447.066116115588, 4447.266201076851, 3975.7018223633345, 3982.6216509431556, 3987.9202415951518, 3995.400689896481, 4031.9718471789506, 5486.149646804752, 5512.200730893998, 5542.0301447246575, 5547.1679248113105, 5563.443655634404, 5813.128030795415, 5835.883282334415, 5853.063509838491, 5856.912146317809, 5897.469227769521, 5558.138488534284, 5564.749586268627, 5566.55467562594, 5568.554515638739, 5571.60998730085, 4953.00939812039, 4989.0, 5016.122178618727, 5035.571976382049, 5063.620228482879, 5971.134185543159, 6002.369751176151, 6009.038553831366, 6015.0, 6022.608530445507, 5827.825165244964, 5843.211166492469, 5844.707764611838, 5847.239858818326, 5855.59010869235, 5845.444682755132, 5952.404759524013, 5985.221921150222, 6011.098335249748, 6042.969785151046, 5730.74211660468, 5740.770369185353, 5746.42535746422, 5747.051736463437, 5747.770089196385, 5679.176519404746, 5845.1232315151365, 5856.560757943256, 5860.355360910211, 5862.501687356623, 5574.331080270394, 5623.943760562342, 5646.830595082154, 5662.03745363281, 5703.914441283301, 5496.203050557727, 5608.6073974823, 5639.351474580476, 5661.915071273852, 5668.234788303526, 5589.80435684749, 5595.07681232592, 5606.6636001840025, 5606.887862242814, 5608.747606357642, 5520.0, 5713.285839270091, 5743.798967036134, 5799.333076696234, 5834.0, 5608.831735047955, 5639.943600563942, 5645.520130788929, 5658.519025882846, 5658.547316214611], "value": 5357.68013460898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.553334998751, 613.6594190224425, 618.0667192539264, 656.4977791989128, 657.944074753646, 36939.0, 41444.17111657765, 41554.16891662169, 41696.58303416965, 41821.0, 42507.14985700284, 43032.3545146823, 43277.78361108198, 43284.0, 43286.7835660822, 8763.255123314526, 8917.464952102862, 8941.731748047569, 8954.86567701485, 8988.730338089836, 8741.562921853914, 8829.690960816373, 8838.955805220965, 8854.557272136399, 8880.333974951873, 8963.282937365027, 8983.146601072887, 8983.326250531203, 8996.640134394616, 8998.235150012257, 8779.165979231962, 8847.646094156225, 8860.689875854347, 8871.689490867853, 8923.866142007875, 8793.340499462565, 8881.911180888173, 8894.155055269805, 8906.73279801607, 8920.821583568293, 33622.0, 40470.0, 40497.79751101255, 40728.0, 40822.59177408247, 3299.8185099819502, 3336.5996080470254, 3577.3560759063357, 3798.620137986207, 4110.835566577333, 30602.84698576515, 31345.216369590944, 31683.04950851478, 31875.84062079698, 32573.511397329057, 4184.811683474251, 4195.748255104703, 4210.663146948237, 4219.789010549491, 4256.978715106436, 284506.0, 285189.0, 287568.9999999979, 287593.0, 288313.9999999979, 34016.82991585026, 34425.139371515914, 34603.307933841184, 34706.65293347085, 34836.82581587076, 35298.64701353005, 35960.82019589885, 36323.0, 36332.81833590815, 36368.81815590905, 15696.136712480924, 15791.447299344467, 15886.364545418053, 15909.0, 15913.204339782964, 13176.077674562688, 13308.93345533266, 13357.198568085945, 13375.0, 13393.732125357634, 8270.297024752843, 8340.124286949904, 8363.414560980795, 8442.53566053873, 8447.662093516314, 3285.901422957315, 3290.621578518501, 3300.1089705779787, 3334.583177102862, 3359.8320083995704, 982.5136557403988, 988.6885631026347, 1015.8069966706303, 1068.8984546468073, 1098.4068602954314, 31450.21374465657, 32156.0, 32375.190620234684, 32386.514202286984, 32783.180420489676, 1088.508743022049, 1165.6211731187398, 1170.1107158559555, 1209.2623499665197, 1233.5127624588238, 16572.83427165737, 17196.742048869277, 17205.91397043007, 17260.309587616353, 17285.827141728423, 509765.0, 511378.0, 516114.0, 516384.0, 517027.0, 57320.0, 57581.71209143927, 57949.130763038585, 58035.709821450626, 58152.12771808426, 1339.9531016414378, 1388.8680575345327, 1391.0957877379583, 1398.084254813099, 1408.8520705325998, 31121.0, 31676.208094796893, 31884.202894927814, 32017.0, 32246.516302255954, 50780.23829642632, 50784.492155077976, 51076.489235107176, 51151.0, 51281.48718512767, 394735.0, 405465.0, 405511.0, 405570.0, 406085.0, 27980.44039119247, 28027.859860700566, 28083.859580701966, 28268.293292667848, 28268.85865570659, 47282.52717472919, 47944.28083578679, 48102.518974809806, 48432.27351589799, 49148.50851491439, 40428.393574095826, 41198.79400602978, 41804.26462547792, 42058.0, 42382.57617423786, 40275.79862100671, 40442.0, 40587.0, 40902.1819563613, 41158.588414115475, 35894.64105358913, 40148.598514015655, 40251.79874100611, 41034.38448423336, 41085.58914410818, 35476.0, 36267.637323626426, 36540.0, 36883.262334753694, 37100.25799483941, 27282.181534553994, 27837.304067398476, 28132.57801132944, 28184.29539261535, 28383.0], "value": 18487.700666164637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4748176294069, 386.13313112063423, 394.80851786883363, 395.07749405139, 400.2575222961407, 16933.83066169338, 19223.90388048058, 19970.600587988232, 19992.20031198754, 20042.899785501053, 18556.907215463936, 18577.25690972363, 18606.16272267748, 18955.52611184721, 18959.33642322519, 5593.776248950037, 5682.488576028157, 5744.138379243105, 5775.306963164405, 5800.361960184377, 5546.91679624806, 5621.915671264935, 5664.971675141618, 5691.4024027476935, 5720.1991721159075, 5603.439656034405, 5654.349749778767, 5677.233573467591, 5704.258446401962, 5997.220361353018, 5388.380336261341, 6084.513238940896, 6105.084237364386, 6129.509639228851, 6133.754649814002, 5443.918341224885, 5470.070088085035, 5483.040467918138, 5499.4225606311165, 5530.917036244459, 13657.590272291747, 18648.881067136015, 21512.247071352584, 22981.425464363358, 23028.424289392733, 2328.4877326988035, 2380.1193558383334, 2507.323022783838, 2878.4962631539606, 3001.7598592112795, 10036.347637403545, 10694.732631684192, 11023.503942322535, 11919.523219071314, 14423.27883605826, 1790.8477779388768, 1839.7884243312058, 1851.4829791048387, 1944.4361135270753, 1972.6252012117652, 75001.62499187524, 77135.0, 77762.0, 78610.0, 78774.0, 10425.530851111718, 10619.256652034283, 10823.35059896393, 10892.40091794943, 10979.780404391868, 15138.167400793061, 15150.393984240727, 15255.160966146968, 15290.847091529165, 15297.617559560877, 8145.918540814635, 8267.586620668942, 8322.45904016237, 8421.831563368822, 8519.062903080656, 8302.418830681794, 8312.0, 8312.584370781558, 8472.915270847336, 8487.363447741443, 4649.95350046502, 4676.508966558463, 4717.386739723814, 4759.6668233223345, 4786.617070634341, 1919.894405807694, 1961.1861077652613, 1962.5878565501405, 2004.1582535335194, 2005.6590379635204, 850.4174640371242, 947.1002547579827, 966.6809952715587, 983.8524221366853, 1044.9007344302279, 18412.907935460236, 19105.713414298796, 19329.613407731766, 19381.321653742052, 19777.703334449994, 965.6234068713208, 1005.3917379985004, 1035.177034257767, 1042.697617690861, 1047.638564695179, 9998.900560714088, 10669.559609452624, 10773.138148948065, 10887.673369798918, 10933.945330273456, 418464.0, 424823.0, 424920.0, 426236.0, 428756.0, 86217.0, 89187.55406222928, 89814.0, 91873.54063229641, 94478.0, 990.8959559246175, 1002.9619343979092, 1013.8834034086027, 1033.571068006784, 1033.927625066238, 16684.49946501607, 16937.491875243762, 16979.151042448077, 17177.398791042753, 17491.21289541948, 38820.41769373518, 39038.0, 39886.40170397505, 40685.186296273314, 40774.59225407708, 54465.0, 57121.71439142778, 58047.0, 58051.70974145102, 58095.804730740216, 7408.740694075682, 7835.981322428048, 8450.450720703135, 8492.193241642035, 8539.8719019216, 10344.27590068688, 13466.461341546621, 13827.51603693866, 13830.861691382957, 14255.857441425867, 11853.525858965544, 12139.210951288138, 12236.143469957018, 12240.449179787109, 12498.821100074794, 11995.64013079609, 12032.27806331623, 12440.253584784941, 12475.313857737912, 12626.684332891751, 12122.333271670142, 12395.566155184526, 12580.119391642864, 12749.0, 12882.935585322013, 7981.0, 7996.760097197093, 8078.474899131537, 8209.466384685215, 8281.337493000667, 10531.684049478528, 11723.35521546323, 12043.578474753342, 12499.56251531192, 12611.558595449114], "value": 9187.472296600114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.5729538433852, 1498.423107103765, 1619.813721422037, 1741.75615413842, 1757.428835628421, 7626.7330643427495, 8126.715564955228, 8421.957890210548, 8962.148595883396, 8968.282537397, 8225.794355141124, 8406.579671016456, 8482.109378515244, 8510.574471276426, 8524.104968978245, 2244.9102035918586, 2286.965695514569, 2290.1068583252463, 2293.908243670251, 2294.4149241943283, 2200.6588978708246, 2213.800757931786, 2240.182333448296, 2245.0682966568857, 2253.4141123307895, 2221.566794475078, 2227.576760415524, 2239.608068587999, 2248.617734985048, 2264.830137739668, 2111.5354621983292, 2137.8824164670937, 2145.5923374558784, 2152.6878602602615, 2158.4495953531905, 2111.419359676086, 2115.3125234298914, 2115.333669893994, 2115.7989990950837, 2119.173522326294, 8499.107593702634, 8666.86999695005, 8677.913220867773, 8684.739457816213, 8734.781630459225, 4799.13615549201, 4896.4858689837765, 4900.166971614834, 4908.460069392364, 4926.975365123188, 3058.694130586946, 3143.6699146589735, 3246.2533617267923, 3249.8537565809597, 3257.4299497588063, 977.310995748003, 1033.3438266700623, 1046.529061922138, 1054.488573042074, 1055.2349546578669, 12064.517419303218, 12124.575639852652, 12159.27044377349, 12166.270023798601, 12186.329751863645, 4509.661775366795, 4517.299818528133, 4522.389477420506, 4522.796474158671, 4528.343390208402, 10298.07317341428, 10299.691009269734, 10311.793764124826, 10351.63769268072, 10353.327033742782, 5089.898202036013, 5126.154184559506, 5147.202183661539, 5151.0, 5158.380994280636, 3988.4219982033787, 4502.077074199781, 4516.299973504047, 4762.595179409789, 4766.046790641816, 3897.61023897608, 3920.6471417571984, 3983.940240896389, 4020.7386519876113, 4065.308897487375, 1220.4873952939786, 1228.4287806170173, 1247.1830950727287, 1251.9624411267675, 1268.61307301274, 875.5840975536696, 884.3014018925106, 997.8474861534938, 1003.172382784206, 1023.6570748799087, 6088.11722300264, 6098.1157732128595, 6106.419890110521, 6146.907796383058, 6156.630602163885, 426.413681188366, 431.67408606502516, 438.15217554033046, 443.80173531465175, 446.90614970855836, 4210.2842516772225, 4267.1892340455215, 4367.956320436755, 4396.318570621559, 4398.516163222043, 10463.372197668165, 10858.511366988505, 10898.94550527258, 10920.781584368267, 10983.450827458755, 10513.579456821795, 10844.186685998582, 10887.455627218607, 10956.671299861016, 10978.176636752116, 8145.7556273313085, 8217.301529369952, 8226.136255693185, 8265.132161123116, 8279.0, 5621.353544342453, 5673.319201695823, 5711.914321285267, 5893.557983151195, 5902.439268269508, 9672.322937394596, 9839.606415743576, 10045.146162576262, 10106.19150467946, 10111.3427627204, 10060.597576097167, 10077.445740484343, 10092.091711745978, 10093.142082923034, 10240.743981400525, 7089.964550177422, 7366.889496657447, 7511.887321690069, 7681.731139410093, 7719.922800772145, 8466.74599762008, 8485.533295668798, 8488.363372746946, 8545.572721363782, 8592.398532102943, 7426.888596671162, 7471.40228781707, 7535.208803075599, 7632.274933881273, 7755.457118001911, 7380.446466514925, 7488.213737557696, 7560.8487830244185, 7621.275978782007, 7642.121156066901, 7113.253108423541, 7176.533525320838, 7219.133703955349, 7243.311885370881, 7249.782506524813, 5060.797568097235, 5130.820421285237, 5206.739663016759, 5265.526102650627, 5284.471552844685, 5393.1370980642905, 5442.809501667422, 5465.289512363367, 5472.753726082256, 5490.835274941758], "value": 4464.765053060168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.23225491076323, 321.34445730709353, 325.4792332268369, 330.5240453746606, 330.8329293706678, 5662.292213473316, 5706.828795136143, 5715.371309155989, 5741.569382296334, 5749.856253593663, 5573.498385145336, 5604.943950560493, 5615.775368985236, 5620.325560932683, 5647.322321321447, 4057.695672824535, 4336.349547567875, 4369.3664418659355, 4403.405540252057, 4414.78593386818, 4311.762853043081, 4322.97838510807, 4326.663601655118, 4329.350597410382, 4340.913181736363, 4322.157179350028, 4325.74045557266, 4326.831755426033, 4337.371081193225, 4341.590417318387, 4099.754014759109, 4138.8344466221315, 4285.250081235802, 4289.892752681177, 4390.51704312527, 3711.6102809204913, 3724.2365315110337, 3724.6777394025003, 3726.0, 3731.738778285521, 5460.726963651841, 5461.754221060062, 5473.151661492475, 5508.421615730371, 5516.806911758109, 4830.637702172316, 4929.457759646436, 4955.653104282702, 4974.129527332702, 5003.199488081926, 5853.3903176626345, 5853.619514731528, 5916.497097746654, 5949.851253718648, 5970.34326224115, 4067.2068946555432, 4083.1221287423346, 4090.4886889138857, 4097.057676734368, 4100.384942258655, 5760.395158508338, 6089.725962331661, 6137.693115344259, 6153.354057755164, 6167.383261673842, 4174.0, 4184.14225083857, 4198.6641068714425, 4200.15996800635, 4207.537170911197, 4180.226658068267, 4212.241796476664, 4215.388768628532, 4252.787360631956, 4270.145970805851, 4793.18515852306, 4940.776650507286, 4943.233798761198, 4954.405471343462, 4969.403671559436, 5892.292924849045, 5937.960856850034, 5940.762369505172, 6001.849953751192, 6033.276006879202, 1465.2673663168416, 1475.4688312207597, 1493.5444689369629, 1494.2230040378943, 1496.6034000989746, 935.1256575102301, 942.3450701762209, 985.2118305355687, 989.7674046599044, 997.6209040564539, 5645.379008309083, 5693.5160511357, 5705.91587598355, 5761.164631128463, 5782.768689252467, 5979.133025711248, 6011.6693581853415, 6057.182280392179, 6082.513398928075, 6123.540734444934, 5488.862778430492, 5602.439756024365, 5746.540276777848, 5760.251167348218, 5784.305883293948, 3242.319112986252, 3250.317433338978, 3262.722668573198, 3269.6566860479784, 3312.3209742003314, 6120.867639486709, 6172.611162488404, 6280.466160376419, 6294.2446906370615, 6341.968290158519, 6278.780242691575, 6285.182926219562, 6286.762317406539, 6312.589681670676, 6335.334789847092, 6231.781887634002, 6282.811515654537, 6298.149749783812, 6346.143270658402, 6352.745890164341, 5844.590878638454, 6086.60437071589, 6099.451049405575, 6101.60339577926, 6122.418370254819, 6072.514198864169, 6093.933561626786, 6104.69476526163, 6110.26676798787, 6116.9202471160015, 5990.903183885605, 6272.874542509033, 6335.809925702236, 6348.555601107878, 6365.77719779824, 4248.2353176427305, 4265.91468170641, 4280.61474467287, 4281.464816897887, 4295.742255464682, 6140.8771824564155, 6155.415235552616, 6160.353162917829, 6165.691715414122, 6167.506599471942, 5768.596198266081, 5960.254968128984, 5963.658176910334, 5964.284285885721, 6008.849778755566, 5880.06035955902, 5908.350081490947, 5910.1725758392995, 5940.287165540163, 5942.881142377215, 5715.599678078897, 5818.592698511064, 5833.329167145833, 5866.413358664099, 5903.229031290682, 5910.0, 5949.0, 5952.940470595238, 5984.491318237999, 6053.577409308897, 5754.712264386848, 5788.942110579009, 5847.152162936265, 5854.560907931837, 5867.591777973341], "value": 4477.4115987069, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.311688311688, 725.3906718356579, 750.9962450187749, 761.033487470912, 788.5978151142915, 14495.927520362397, 15889.0, 16053.0, 16269.023858568495, 16378.590535236624, 14635.92682036591, 14768.483103091394, 14794.0, 14794.112353258784, 14819.777703334432, 665.5407768639648, 778.5367706214793, 783.1698399696326, 790.7627711686471, 802.5505716798582, 786.6892577431911, 792.3779832831228, 792.7344339646226, 795.0896223823719, 796.8844517544952, 843.42225575481, 846.3144852669358, 846.3652260804397, 846.6655671009947, 847.2120927537388, 838.6351936907434, 840.9117042710519, 841.5792103948025, 844.5228445928062, 847.1740053447901, 610.4780412747126, 610.9114178444145, 612.1552257884136, 612.874360756044, 613.8833621611924, 14955.850441495555, 14958.252087395695, 14963.775543366859, 14968.101913885093, 15050.548483545512, 15298.923505382512, 15421.15183664898, 15468.690626187527, 15571.299291531908, 15901.443449479328, 12031.699207519794, 12302.938485307515, 12404.56584019564, 12417.130800843945, 12593.93703031479, 3934.626210509997, 3951.328274193394, 3955.3078211312904, 3966.484357033596, 4045.9797701011603, 77647.6117619414, 78168.21831781666, 78604.21395786083, 81265.59367203126, 81269.59365203195, 11992.460339284753, 12127.696807579881, 12227.205231659913, 12287.078469114853, 12330.445129969174, 22758.772412275997, 22952.311430657108, 22999.540009200056, 23036.89001984744, 23087.307380778602, 8794.120587941155, 8939.195472407515, 8960.283177345797, 8967.997087470618, 9088.500132492643, 4569.702969306984, 4594.655400844883, 4595.908081838412, 4629.583337499574, 4696.671233013724, 3506.8246587670515, 3592.604813470516, 3616.4213725803747, 3620.9818950905606, 3648.2338708871434, 597.3787261248253, 609.2262826210776, 614.0850133301349, 616.3713012726994, 621.1986537366837, 596.785157343356, 599.4994179859779, 681.6652963599652, 739.7706710919524, 746.2910235276509, 8945.910540894638, 9155.450672959643, 9190.172884440433, 9545.47499887499, 9549.65219477095, 558.8574913397058, 656.2223764838682, 667.1593791822339, 679.296927679849, 765.0475158427682, 4295.484541854935, 4481.305397663367, 4631.490536041033, 4639.932815452465, 4683.601893838993, 114857.0, 116453.41773291079, 117778.0, 118455.40772296084, 119127.0, 62237.06644400338, 101225.49387253016, 102712.48643756734, 102828.0, 103053.0, 73801.26198737943, 74844.0, 83096.0, 85174.57412712897, 86627.56686216529, 9085.54572271397, 9509.476978766234, 10230.0, 10288.897111029093, 10363.585456581652, 49614.0, 50191.4942551724, 50196.749016256144, 50739.49260507496, 52264.21603676024, 66921.33078669151, 75432.24567754252, 76066.23933760592, 76878.23121768935, 77877.0, 13021.739565208452, 13130.0, 13190.0, 13301.534446294334, 13625.727485450434, 14622.251034757977, 14884.181370024753, 15082.321295541507, 15254.0, 15492.457763978207, 14049.508267211007, 14118.364673589918, 14381.0, 14515.637109072357, 14565.490207842675, 12830.358482076046, 12938.223706577635, 12954.417051232529, 13408.463661453432, 13713.725725485236, 13503.59489215325, 13676.794848077487, 13988.000318928189, 14490.63773405631, 14495.275236237934, 11579.942100289782, 11762.470688819194, 11829.231099978473, 11862.584809531625, 12177.33024683651, 11093.556257749922, 11253.0, 11566.884331156918, 11874.643760687193, 11897.940510297392], "value": 7589.251291653968, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 112.0, 112.0, 114.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 142.0, 157.0, 186.0, 127.0, 154.0, 155.0, 127.0, 178.0, 134.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 162.0, 167.0, 168.0, 163.0, 160.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 159.0, 76.0, 75.0, 84.0, 75.0, 172.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 138.0, 85.0, 85.0, 84.0, 135.0, 85.0, 84.0, 144.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 57.0, 59.0, 55.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 82.0, 81.0, 81.0, 81.0, 80.0, 80.0, 108.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 123.0, 131.0, 121.0, 120.0, 137.0, 124.0, 123.0, 139.0, 132.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 168.0, 159.0, 169.0, 171.0, 158.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 67.0, 79.0, 62.0, 65.0, 63.0, 64.0, 66.0, 62.0], "value": 65.4, "unit": "score"}]}]} 19:28:11 INFO - Return code: 0 19:28:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:11 ERROR - # TBPL SUCCESS # 19:28:11 INFO - Running post-action listener: _resource_record_post_action 19:28:11 INFO - ##### 19:28:11 INFO - ##### Finished run-tests step (success) 19:28:11 INFO - ##### 19:28:11 INFO - Running post-run listener: _resource_record_post_run 19:28:11 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 367181824; Read time: 1200; Write time: 307212 19:28:11 INFO - TinderboxPrint: CPU usage
13.4% 19:28:11 INFO - TinderboxPrint: I/O read bytes / time
7,806,976 / 1,200 19:28:11 INFO - TinderboxPrint: I/O write bytes / time
367,181,824 / 307,212 19:28:11 INFO - TinderboxPrint: CPU idle
8,251.0 (86.6%) 19:28:11 INFO - TinderboxPrint: CPU user
1,223.4 (12.8%) 19:28:11 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1363968; Read time: 0; Write time: 524 19:28:11 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 312975360; Read time: 1068; Write time: 276928 19:28:11 INFO - Running post-run listener: _upload_blobber_files 19:28:11 INFO - Blob upload gear active. 19:28:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:28:11 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'] 19:28:11 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 19:28:12 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:13 INFO - (blobuploader) - INFO - Done attempting. 19:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:14 INFO - (blobuploader) - INFO - Done attempting. 19:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:18 INFO - (blobuploader) - INFO - Done attempting. 19:28:18 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:18 INFO - Return code: 0 19:28:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa88244176c13f36d271ceec60bfca0943129e264c217220bbc5e7f05eaadf8db884d4dae7936ecbec32ad011c813642e8ef60c53a39edd44d07a4fa97155e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60e24ea58ed25c428fb4bc8ea1f3f28073cb5136aee179a65851d1c4174f2a95ae4ffccb7e8a00a234a165bef9826a2eff11f5b2e2d23a861f75410d566a8bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b39be92977a15a94668c8c30bf3aa3fa4db4768e07ee7d8f6889b00b25ba49c5d9144ffd25831d40a5fe6bcf5e69376fc9c8a2a75a811a3de0088f5494b74a8"} 19:28:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:18 INFO - Contents: 19:28:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa88244176c13f36d271ceec60bfca0943129e264c217220bbc5e7f05eaadf8db884d4dae7936ecbec32ad011c813642e8ef60c53a39edd44d07a4fa97155e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60e24ea58ed25c428fb4bc8ea1f3f28073cb5136aee179a65851d1c4174f2a95ae4ffccb7e8a00a234a165bef9826a2eff11f5b2e2d23a861f75410d566a8bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b39be92977a15a94668c8c30bf3aa3fa4db4768e07ee7d8f6889b00b25ba49c5d9144ffd25831d40a5fe6bcf5e69376fc9c8a2a75a811a3de0088f5494b74a8"} 19:28:18 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:18 INFO - Copying logs to upload dir... 19:28:18 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.122563 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-17 19:28:18.033912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 19:28:18.038052) ========= 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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 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/fa88244176c13f36d271ceec60bfca0943129e264c217220bbc5e7f05eaadf8db884d4dae7936ecbec32ad011c813642e8ef60c53a39edd44d07a4fa97155e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60e24ea58ed25c428fb4bc8ea1f3f28073cb5136aee179a65851d1c4174f2a95ae4ffccb7e8a00a234a165bef9826a2eff11f5b2e2d23a861f75410d566a8bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b39be92977a15a94668c8c30bf3aa3fa4db4768e07ee7d8f6889b00b25ba49c5d9144ffd25831d40a5fe6bcf5e69376fc9c8a2a75a811a3de0088f5494b74a8"} build_url:https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/W_dUAYnNTkCK1iK0TUi8Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa88244176c13f36d271ceec60bfca0943129e264c217220bbc5e7f05eaadf8db884d4dae7936ecbec32ad011c813642e8ef60c53a39edd44d07a4fa97155e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60e24ea58ed25c428fb4bc8ea1f3f28073cb5136aee179a65851d1c4174f2a95ae4ffccb7e8a00a234a165bef9826a2eff11f5b2e2d23a861f75410d566a8bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b39be92977a15a94668c8c30bf3aa3fa4db4768e07ee7d8f6889b00b25ba49c5d9144ffd25831d40a5fe6bcf5e69376fc9c8a2a75a811a3de0088f5494b74a8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 19:28:18.064042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:28:18.064418) ========= 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=7de08804244eb36560b44971000001c3-1466206197.752485-474588126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 19:28:18.150113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 19:28:18.150469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 19:28:18.150828) ========= ========= Total master_lag: 0.19 =========