builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1467081172.52 results: success (0) buildid: 20160627163033 builduid: 657e5cffe6a14dbb9abb02fcbdc017ce revision: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:52.523578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:52.524301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:52.524693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:52.553569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:52.553936) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 19:32:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.0M=0s 2016-06-27 19:32:52 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109269 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:53.079514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:53.079926) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020955 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:53.218995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 19:32:53.222450) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 --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 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 --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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 19:32:53,495 truncating revision to first 12 chars 2016-06-27 19:32:53,496 Setting DEBUG logging. 2016-06-27 19:32:53,496 attempt 1/10 2016-06-27 19:32:53,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7bcb335a9bc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 19:32:54,383 unpacking tar archive at: mozilla-inbound-7bcb335a9bc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.235040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 19:32:54.472536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:54.472917) ========= script_repo_revision: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:54.473388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:54.473757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:54.483337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 19:32:54.483705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:32:54 INFO - MultiFileLogger online at 20160627 19:32:54 in /builds/slave/test 19:32:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:32:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:32:54 INFO - {'append_to_log': False, 19:32:54 INFO - 'base_work_dir': '/builds/slave/test', 19:32:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:32:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:32:54 INFO - 'branch': 'Mozilla-Inbound', 19:32:54 INFO - 'buildbot_json_path': 'buildprops.json', 19:32:54 INFO - 'config_files': ('talos/linux_config.py',), 19:32:54 INFO - 'default_actions': ('clobber', 19:32:54 INFO - 'read-buildbot-config', 19:32:54 INFO - 'download-and-extract', 19:32:54 INFO - 'populate-webroot', 19:32:54 INFO - 'create-virtualenv', 19:32:54 INFO - 'install', 19:32:54 INFO - 'run-tests'), 19:32:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:32:54 INFO - 'download_minidump_stackwalk': True, 19:32:54 INFO - 'download_symbols': 'ondemand', 19:32:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:32:54 INFO - 'tooltool.py': '/tools/tooltool.py', 19:32:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:32:54 INFO - '/tools/misc-python/virtualenv.py')}, 19:32:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:32:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:32:54 INFO - 'installer_path': 'installer.exe', 19:32:54 INFO - 'log_level': 'info', 19:32:54 INFO - 'log_name': 'talos', 19:32:54 INFO - 'log_to_console': True, 19:32:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:32:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:32:54 INFO - 'opt_config_files': (), 19:32:54 INFO - 'pip_index': False, 19:32:54 INFO - 'sps_profile': False, 19:32:54 INFO - 'sps_profile_interval': 0, 19:32:54 INFO - 'suite': 'dromaeojs', 19:32:54 INFO - 'system_bits': '32', 19:32:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:32:54 INFO - 'title': 'talos-linux64-ix-051', 19:32:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:32:54 INFO - 'use_talos_json': True, 19:32:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:32:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:32:54 INFO - 'work_dir': 'build'} 19:32:54 INFO - ##### 19:32:54 INFO - ##### Running clobber step. 19:32:54 INFO - ##### 19:32:54 INFO - Running pre-action listener: _resource_record_pre_action 19:32:54 INFO - Running main action method: clobber 19:32:54 INFO - rmtree: /builds/slave/test/build 19:32:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:32:55 INFO - Running post-action listener: _resource_record_post_action 19:32:55 INFO - ##### 19:32:55 INFO - ##### Finished clobber step (success) 19:32:55 INFO - ##### 19:32:55 INFO - ##### 19:32:55 INFO - ##### Running read-buildbot-config step. 19:32:55 INFO - ##### 19:32:55 INFO - Running pre-action listener: _resource_record_pre_action 19:32:55 INFO - Running main action method: read_buildbot_config 19:32:55 INFO - Using buildbot properties: 19:32:55 INFO - { 19:32:55 INFO - "project": "", 19:32:55 INFO - "product": "firefox", 19:32:55 INFO - "script_repo_revision": "production", 19:32:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:32:55 INFO - "repository": "", 19:32:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:32:55 INFO - "buildid": "20160627163033", 19:32:55 INFO - "pgo_build": "True", 19:32:55 INFO - "basedir": "/builds/slave/test", 19:32:55 INFO - "buildnumber": 1989, 19:32:55 INFO - "slavename": "talos-linux64-ix-051", 19:32:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:32:55 INFO - "platform": "ubuntu64_hw", 19:32:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:32:55 INFO - "branch": "mozilla-inbound", 19:32:55 INFO - "repo_path": "integration/mozilla-inbound", 19:32:55 INFO - "revision": "7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95", 19:32:55 INFO - "stage_platform": "linux64-pgo", 19:32:55 INFO - "builduid": "657e5cffe6a14dbb9abb02fcbdc017ce", 19:32:55 INFO - "slavebuilddir": "test" 19:32:55 INFO - } 19:32:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:32:55 INFO - Running post-action listener: _resource_record_post_action 19:32:55 INFO - ##### 19:32:55 INFO - ##### Finished read-buildbot-config step (success) 19:32:55 INFO - ##### 19:32:55 INFO - ##### 19:32:55 INFO - ##### Running download-and-extract step. 19:32:55 INFO - ##### 19:32:55 INFO - Running pre-action listener: _resource_record_pre_action 19:32:55 INFO - Running main action method: download_and_extract 19:32:55 INFO - mkdir: /builds/slave/test/build/tests 19:32:55 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:32:55 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:56 INFO - Downloaded 1361 bytes. 19:32:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:56 INFO - Using the following test package requirements: 19:32:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:32:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:32:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'jsshell-linux-x86_64.zip'], 19:32:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:32:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:32:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:32:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:32:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:32:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:56 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:57 INFO - Downloaded 24282861 bytes. 19:32:57 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:32:57 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:32:58 INFO - Return code: 0 19:32:58 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:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:58 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:32:59 INFO - Downloaded 24282861 bytes. 19:32:59 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:32:59 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:33:01 INFO - Return code: 0 19:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:01 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:33:02 INFO - Downloaded 14405240 bytes. 19:33:02 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:33:02 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:33:03 INFO - Return code: 0 19:33:03 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:33:03 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/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:33:04 INFO - Downloaded 60322333 bytes. 19:33:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:04 INFO - mkdir: /builds/slave/test/properties 19:33:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:33:04 INFO - Writing to file /builds/slave/test/properties/build_url 19:33:04 INFO - Contents: 19:33:04 INFO - build_url:https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:05 INFO - Running post-action listener: _resource_record_post_action 19:33:05 INFO - Running post-action listener: set_extra_try_arguments 19:33:05 INFO - ##### 19:33:05 INFO - ##### Finished download-and-extract step (success) 19:33:05 INFO - ##### 19:33:05 INFO - ##### 19:33:05 INFO - ##### Running populate-webroot step. 19:33:05 INFO - ##### 19:33:05 INFO - Running pre-action listener: _resource_record_pre_action 19:33:05 INFO - Running main action method: populate_webroot 19:33:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:33:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:33:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:33:05 INFO - '--tppagecycles', 19:33:05 INFO - '7'], 19:33:05 INFO - 'tests': ['tsvgm']}}, 19:33:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:33:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:33:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:33:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:33:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['damp', 'tps']}, 19:33:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'tests': ['damp', 'tps']}, 19:33:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['dromaeo_dom']}, 19:33:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:33:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['basic_compositor_video']}, 19:33:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:33:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['a11yr', 19:33:05 INFO - 'ts_paint', 19:33:05 INFO - 'tpaint', 19:33:05 INFO - 'sessionrestore', 19:33:05 INFO - 'sessionrestore_no_auto_restore', 19:33:05 INFO - 'tabpaint']}, 19:33:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['tsvgx', 19:33:05 INFO - 'tsvgr_opacity', 19:33:05 INFO - 'tart', 19:33:05 INFO - 'tscrollx', 19:33:05 INFO - 'cart']}, 19:33:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:33:05 INFO - 'tsvgr_opacity', 19:33:05 INFO - 'tart', 19:33:05 INFO - 'tscrollx', 19:33:05 INFO - 'cart']}, 19:33:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'talos_options': ['--disable-e10s'], 19:33:05 INFO - 'tests': ['tp5o']}, 19:33:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'tests': ['tp5o']}, 19:33:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'talos_options': ['--disable-e10s', 19:33:05 INFO - '--xperf_path', 19:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:05 INFO - 'tests': ['tp5n']}, 19:33:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:05 INFO - 'talos_options': ['--xperf_path', 19:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:05 INFO - 'tests': ['tp5n']}}, 19:33:05 INFO - 'talos.zip': {'path': '', 19:33:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:33:05 INFO - Running post-action listener: _resource_record_post_action 19:33:05 INFO - ##### 19:33:05 INFO - ##### Finished populate-webroot step (success) 19:33:05 INFO - ##### 19:33:05 INFO - ##### 19:33:05 INFO - ##### Running create-virtualenv step. 19:33:05 INFO - ##### 19:33:05 INFO - Running pre-action listener: _resource_record_pre_action 19:33:05 INFO - Running main action method: create_virtualenv 19:33:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:33:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:33:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:33:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:33:05 INFO - Using real prefix '/usr' 19:33:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:33:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:33:07 INFO - Installing pip.................done. 19:33:07 INFO - Return code: 0 19:33:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:33:07 INFO - Using env: {'DISPLAY': ':0', 19:33:07 INFO - 'HOME': '/home/cltbld', 19:33:07 INFO - 'LANG': 'en_US.UTF-8', 19:33:07 INFO - 'LANGUAGE': 'en_US:en', 19:33:07 INFO - 'LOGNAME': 'cltbld', 19:33:07 INFO - 'MAIL': '/var/mail/cltbld', 19:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:07 INFO - 'MOZ_NO_REMOTE': '1', 19:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:07 INFO - 'NO_EM_RESTART': '1', 19:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:07 INFO - 'PWD': '/builds/slave/test', 19:33:07 INFO - 'SHELL': '/bin/bash', 19:33:07 INFO - 'SHLVL': '1', 19:33:07 INFO - 'TERM': 'linux', 19:33:07 INFO - 'TMOUT': '86400', 19:33:07 INFO - 'USER': 'cltbld', 19:33:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:07 INFO - '_': '/tools/buildbot/bin/python'} 19:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:33:07 INFO - Cleaning up... 19:33:07 INFO - Return code: 0 19:33:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:33:07 INFO - Using env: {'DISPLAY': ':0', 19:33:07 INFO - 'HOME': '/home/cltbld', 19:33:07 INFO - 'LANG': 'en_US.UTF-8', 19:33:07 INFO - 'LANGUAGE': 'en_US:en', 19:33:07 INFO - 'LOGNAME': 'cltbld', 19:33:07 INFO - 'MAIL': '/var/mail/cltbld', 19:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:07 INFO - 'MOZ_NO_REMOTE': '1', 19:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:07 INFO - 'NO_EM_RESTART': '1', 19:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:07 INFO - 'PWD': '/builds/slave/test', 19:33:07 INFO - 'SHELL': '/bin/bash', 19:33:07 INFO - 'SHLVL': '1', 19:33:07 INFO - 'TERM': 'linux', 19:33:07 INFO - 'TMOUT': '86400', 19:33:07 INFO - 'USER': 'cltbld', 19:33:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:07 INFO - '_': '/tools/buildbot/bin/python'} 19:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:08 INFO - Downloading/unpacking psutil>=3.1.1 19:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:33:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:10 INFO - Installing collected packages: psutil 19:33:10 INFO - Running setup.py install for psutil 19:33:10 INFO - building 'psutil._psutil_linux' extension 19:33:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:33:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:33:10 INFO - building 'psutil._psutil_posix' extension 19:33:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:33:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:33:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:10 INFO - Successfully installed psutil 19:33:10 INFO - Cleaning up... 19:33:10 INFO - Return code: 0 19:33:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:33:10 INFO - Using env: {'DISPLAY': ':0', 19:33:10 INFO - 'HOME': '/home/cltbld', 19:33:10 INFO - 'LANG': 'en_US.UTF-8', 19:33:10 INFO - 'LANGUAGE': 'en_US:en', 19:33:10 INFO - 'LOGNAME': 'cltbld', 19:33:10 INFO - 'MAIL': '/var/mail/cltbld', 19:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:10 INFO - 'MOZ_NO_REMOTE': '1', 19:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:10 INFO - 'NO_EM_RESTART': '1', 19:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:10 INFO - 'PWD': '/builds/slave/test', 19:33:10 INFO - 'SHELL': '/bin/bash', 19:33:10 INFO - 'SHLVL': '1', 19:33:10 INFO - 'TERM': 'linux', 19:33:10 INFO - 'TMOUT': '86400', 19:33:10 INFO - 'USER': 'cltbld', 19:33:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:10 INFO - '_': '/tools/buildbot/bin/python'} 19:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:33: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:33: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:33: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:33: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:33: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:33: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:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:33:12 INFO - Installing collected packages: mozsystemmonitor 19:33:12 INFO - Running setup.py install for mozsystemmonitor 19:33:12 INFO - Successfully installed mozsystemmonitor 19:33:12 INFO - Cleaning up... 19:33:13 INFO - Return code: 0 19:33:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:33: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:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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', '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 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:33: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 jsonschema==2.5.1 19:33:13 INFO - Using env: {'DISPLAY': ':0', 19:33:13 INFO - 'HOME': '/home/cltbld', 19:33:13 INFO - 'LANG': 'en_US.UTF-8', 19:33:13 INFO - 'LANGUAGE': 'en_US:en', 19:33:13 INFO - 'LOGNAME': 'cltbld', 19:33:13 INFO - 'MAIL': '/var/mail/cltbld', 19:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:13 INFO - 'MOZ_NO_REMOTE': '1', 19:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:13 INFO - 'NO_EM_RESTART': '1', 19:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:13 INFO - 'PWD': '/builds/slave/test', 19:33:13 INFO - 'SHELL': '/bin/bash', 19:33:13 INFO - 'SHLVL': '1', 19:33:13 INFO - 'TERM': 'linux', 19:33:13 INFO - 'TMOUT': '86400', 19:33:13 INFO - 'USER': 'cltbld', 19:33:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:13 INFO - '_': '/tools/buildbot/bin/python'} 19:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:13 INFO - Downloading/unpacking jsonschema==2.5.1 19:33: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:33: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:33: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:33: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:33: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:33: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:33:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:33:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:33: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:33: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:33: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:33: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:33: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:33: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:33:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:33:15 INFO - warning: no files found matching '*.txt' 19:33:15 INFO - no previously-included directories found matching 'build' 19:33:15 INFO - no previously-included directories found matching 'dist' 19:33:15 INFO - no previously-included directories found matching '.git*' 19:33:15 INFO - Installing collected packages: jsonschema, functools32 19:33:15 INFO - Running setup.py install for functools32 19:33:15 INFO - warning: no files found matching '*.txt' 19:33:15 INFO - no previously-included directories found matching 'build' 19:33:15 INFO - no previously-included directories found matching 'dist' 19:33:15 INFO - no previously-included directories found matching '.git*' 19:33:15 INFO - Successfully installed jsonschema functools32 19:33:15 INFO - Cleaning up... 19:33:15 INFO - Return code: 0 19:33:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:33:15 INFO - Using env: {'DISPLAY': ':0', 19:33:15 INFO - 'HOME': '/home/cltbld', 19:33:15 INFO - 'LANG': 'en_US.UTF-8', 19:33:15 INFO - 'LANGUAGE': 'en_US:en', 19:33:15 INFO - 'LOGNAME': 'cltbld', 19:33:15 INFO - 'MAIL': '/var/mail/cltbld', 19:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:15 INFO - 'MOZ_NO_REMOTE': '1', 19:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:15 INFO - 'NO_EM_RESTART': '1', 19:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:15 INFO - 'PWD': '/builds/slave/test', 19:33:15 INFO - 'SHELL': '/bin/bash', 19:33:15 INFO - 'SHLVL': '1', 19:33:15 INFO - 'TERM': 'linux', 19:33:15 INFO - 'TMOUT': '86400', 19:33:15 INFO - 'USER': 'cltbld', 19:33:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:15 INFO - '_': '/tools/buildbot/bin/python'} 19:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 19:33: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:33: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:33: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:33: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:33: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:33: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:33:17 INFO - Downloading blobuploader-1.2.4.tar.gz 19:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:33:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:18 INFO - Downloading docopt-0.6.1.tar.gz 19:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:33:18 INFO - Installing collected packages: blobuploader, requests, docopt 19:33:18 INFO - Running setup.py install for blobuploader 19:33:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:33:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:33:18 INFO - Running setup.py install for requests 19:33:18 INFO - Running setup.py install for docopt 19:33:18 INFO - Successfully installed blobuploader requests docopt 19:33:18 INFO - Cleaning up... 19:33:19 INFO - Return code: 0 19:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:19 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:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:19 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:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:19 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 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:19 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:33:19 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:33:19 INFO - Using env: {'DISPLAY': ':0', 19:33:19 INFO - 'HOME': '/home/cltbld', 19:33:19 INFO - 'LANG': 'en_US.UTF-8', 19:33:19 INFO - 'LANGUAGE': 'en_US:en', 19:33:19 INFO - 'LOGNAME': 'cltbld', 19:33:19 INFO - 'MAIL': '/var/mail/cltbld', 19:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:19 INFO - 'MOZ_NO_REMOTE': '1', 19:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:19 INFO - 'NO_EM_RESTART': '1', 19:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:19 INFO - 'PWD': '/builds/slave/test', 19:33:19 INFO - 'SHELL': '/bin/bash', 19:33:19 INFO - 'SHLVL': '1', 19:33:19 INFO - 'TERM': 'linux', 19:33:19 INFO - 'TMOUT': '86400', 19:33:19 INFO - 'USER': 'cltbld', 19:33:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:19 INFO - '_': '/tools/buildbot/bin/python'} 19:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:19 INFO - Running setup.py (path:/tmp/pip-tgpkaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:19 INFO - Running setup.py (path:/tmp/pip-T53yUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:19 INFO - Running setup.py (path:/tmp/pip-lfa_1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:19 INFO - Running setup.py (path:/tmp/pip-jM_WRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:19 INFO - Running setup.py (path:/tmp/pip-dj47TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:19 INFO - Running setup.py (path:/tmp/pip-A6q0JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:19 INFO - Running setup.py (path:/tmp/pip-uM9sFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:19 INFO - Running setup.py (path:/tmp/pip-_93zzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:19 INFO - Running setup.py (path:/tmp/pip-Q6yXf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:19 INFO - Running setup.py (path:/tmp/pip-bt1IDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:19 INFO - Running setup.py (path:/tmp/pip-vKeNg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:20 INFO - Running setup.py (path:/tmp/pip-rSfSyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:20 INFO - Running setup.py (path:/tmp/pip-nS65RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:20 INFO - Running setup.py (path:/tmp/pip-LHc9pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:20 INFO - Running setup.py (path:/tmp/pip-wKb0Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:20 INFO - Running setup.py (path:/tmp/pip-PUuz4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:20 INFO - Running setup.py (path:/tmp/pip-XjWZBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:33:20 INFO - Running setup.py install for manifestparser 19:33:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozcrash 19:33:20 INFO - Running setup.py install for mozdebug 19:33:20 INFO - Running setup.py install for mozdevice 19:33:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozfile 19:33:20 INFO - Running setup.py install for mozhttpd 19:33:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozinfo 19:33:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozInstall 19:33:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozleak 19:33:21 INFO - Running setup.py install for mozlog 19:33:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for moznetwork 19:33:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozprocess 19:33:21 INFO - Running setup.py install for mozprofile 19:33:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozrunner 19:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozscreenshot 19:33:22 INFO - Running setup.py install for moztest 19:33:22 INFO - Running setup.py install for mozversion 19:33:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:33:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:33:22 INFO - Cleaning up... 19:33:22 INFO - Return code: 0 19:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:22 INFO - Using env: {'DISPLAY': ':0', 19:33:22 INFO - 'HOME': '/home/cltbld', 19:33:22 INFO - 'LANG': 'en_US.UTF-8', 19:33:22 INFO - 'LANGUAGE': 'en_US:en', 19:33:22 INFO - 'LOGNAME': 'cltbld', 19:33:22 INFO - 'MAIL': '/var/mail/cltbld', 19:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:22 INFO - 'MOZ_NO_REMOTE': '1', 19:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:22 INFO - 'NO_EM_RESTART': '1', 19:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:22 INFO - 'PWD': '/builds/slave/test', 19:33:22 INFO - 'SHELL': '/bin/bash', 19:33:22 INFO - 'SHLVL': '1', 19:33:22 INFO - 'TERM': 'linux', 19:33:22 INFO - 'TMOUT': '86400', 19:33:22 INFO - 'USER': 'cltbld', 19:33:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:22 INFO - '_': '/tools/buildbot/bin/python'} 19:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:22 INFO - Running setup.py (path:/tmp/pip-rYtJD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:22 INFO - Running setup.py (path:/tmp/pip-JYqZDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:22 INFO - Running setup.py (path:/tmp/pip-qwzvKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:22 INFO - Running setup.py (path:/tmp/pip-btPUR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:22 INFO - Running setup.py (path:/tmp/pip-t5TQEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:22 INFO - Running setup.py (path:/tmp/pip-uWALGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:22 INFO - Running setup.py (path:/tmp/pip-DJOa3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:23 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:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:23 INFO - Running setup.py (path:/tmp/pip-FSftu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:23 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:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:23 INFO - Running setup.py (path:/tmp/pip-urBYfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:23 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:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:23 INFO - Running setup.py (path:/tmp/pip-i5ORZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:23 INFO - Running setup.py (path:/tmp/pip-Ofunel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:23 INFO - Running setup.py (path:/tmp/pip-_SkcWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:23 INFO - Running setup.py (path:/tmp/pip-WBp6Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:23 INFO - Running setup.py (path:/tmp/pip-5M_ChX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:23 INFO - Running setup.py (path:/tmp/pip-nS5GTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:23 INFO - Running setup.py (path:/tmp/pip-I1NhiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:23 INFO - Running setup.py (path:/tmp/pip-pa2EM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:25 INFO - Downloading blessings-1.6.tar.gz 19:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:33:25 INFO - Installing collected packages: blessings 19:33:25 INFO - Running setup.py install for blessings 19:33:25 INFO - Successfully installed blessings 19:33:25 INFO - Cleaning up... 19:33:25 INFO - Return code: 0 19:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:26 INFO - Reading from file tmpfile_stdout 19:33:26 INFO - Current package versions: 19:33:26 INFO - argparse == 1.2.1 19:33:26 INFO - blessings == 1.6 19:33:26 INFO - blobuploader == 1.2.4 19:33:26 INFO - docopt == 0.6.1 19:33:26 INFO - functools32 == 3.2.3-2 19:33:26 INFO - jsonschema == 2.5.1 19:33:26 INFO - manifestparser == 1.1 19:33:26 INFO - mozInstall == 1.12 19:33:26 INFO - mozcrash == 0.17 19:33:26 INFO - mozdebug == 0.1 19:33:26 INFO - mozdevice == 0.48 19:33:26 INFO - mozfile == 1.2 19:33:26 INFO - mozhttpd == 0.7 19:33:26 INFO - mozinfo == 0.9 19:33:26 INFO - mozleak == 0.1 19:33:26 INFO - mozlog == 3.2 19:33:26 INFO - moznetwork == 0.27 19:33:26 INFO - mozprocess == 0.22 19:33:26 INFO - mozprofile == 0.28 19:33:26 INFO - mozrunner == 6.11 19:33:26 INFO - mozscreenshot == 0.1 19:33:26 INFO - mozsystemmonitor == 0.3 19:33:26 INFO - moztest == 0.7 19:33:26 INFO - mozversion == 1.4 19:33:26 INFO - psutil == 3.1.1 19:33:26 INFO - requests == 1.2.3 19:33:26 INFO - wsgiref == 0.1.2 19:33:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 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 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:26 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:33:26 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:33:26 INFO - Using env: {'DISPLAY': ':0', 19:33:26 INFO - 'HOME': '/home/cltbld', 19:33:26 INFO - 'LANG': 'en_US.UTF-8', 19:33:26 INFO - 'LANGUAGE': 'en_US:en', 19:33:26 INFO - 'LOGNAME': 'cltbld', 19:33:26 INFO - 'MAIL': '/var/mail/cltbld', 19:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:26 INFO - 'MOZ_NO_REMOTE': '1', 19:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:26 INFO - 'NO_EM_RESTART': '1', 19:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:26 INFO - 'PWD': '/builds/slave/test', 19:33:26 INFO - 'SHELL': '/bin/bash', 19:33:26 INFO - 'SHLVL': '1', 19:33:26 INFO - 'TERM': 'linux', 19:33:26 INFO - 'TMOUT': '86400', 19:33:26 INFO - 'USER': 'cltbld', 19:33:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:26 INFO - '_': '/tools/buildbot/bin/python'} 19:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:33:26 INFO - Cleaning up... 19:33:26 INFO - Return code: 0 19:33:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:33:26 INFO - Using env: {'DISPLAY': ':0', 19:33:26 INFO - 'HOME': '/home/cltbld', 19:33:26 INFO - 'LANG': 'en_US.UTF-8', 19:33:26 INFO - 'LANGUAGE': 'en_US:en', 19:33:26 INFO - 'LOGNAME': 'cltbld', 19:33:26 INFO - 'MAIL': '/var/mail/cltbld', 19:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:26 INFO - 'MOZ_NO_REMOTE': '1', 19:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:26 INFO - 'NO_EM_RESTART': '1', 19:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:26 INFO - 'PWD': '/builds/slave/test', 19:33:26 INFO - 'SHELL': '/bin/bash', 19:33:26 INFO - 'SHLVL': '1', 19:33:26 INFO - 'TERM': 'linux', 19:33:26 INFO - 'TMOUT': '86400', 19:33:26 INFO - 'USER': 'cltbld', 19:33:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:26 INFO - '_': '/tools/buildbot/bin/python'} 19:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:33:26 INFO - Cleaning up... 19:33:26 INFO - Return code: 0 19:33:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ffb529f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', '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:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:33:26 INFO - Using env: {'DISPLAY': ':0', 19:33:26 INFO - 'HOME': '/home/cltbld', 19:33:26 INFO - 'LANG': 'en_US.UTF-8', 19:33:26 INFO - 'LANGUAGE': 'en_US:en', 19:33:26 INFO - 'LOGNAME': 'cltbld', 19:33:26 INFO - 'MAIL': '/var/mail/cltbld', 19:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:26 INFO - 'MOZ_NO_REMOTE': '1', 19:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:26 INFO - 'NO_EM_RESTART': '1', 19:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:26 INFO - 'PWD': '/builds/slave/test', 19:33:26 INFO - 'SHELL': '/bin/bash', 19:33:26 INFO - 'SHLVL': '1', 19:33:26 INFO - 'TERM': 'linux', 19:33:26 INFO - 'TMOUT': '86400', 19:33:26 INFO - 'USER': 'cltbld', 19:33:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:26 INFO - '_': '/tools/buildbot/bin/python'} 19:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:26 INFO - Downloading/unpacking flake8 19:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:33:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:33:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:33:29 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:33:29 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:33:29 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:33:29 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:33:29 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:33:29 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:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:33:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:33:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:33:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:33:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:33:29 INFO - no previously-included directories found matching 'docs/_build' 19:33:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:33:29 INFO - Running setup.py install for pep8 19:33:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:33:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:33:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:33:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:33:29 INFO - no previously-included directories found matching 'docs/_build' 19:33:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:33:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:33:29 INFO - Cleaning up... 19:33:29 INFO - Return code: 0 19:33:29 INFO - Running post-action listener: _resource_record_post_action 19:33:29 INFO - Running post-action listener: _start_resource_monitoring 19:33:29 INFO - Starting resource monitoring. 19:33:29 INFO - ##### 19:33:29 INFO - ##### Finished create-virtualenv step (success) 19:33:29 INFO - ##### 19:33:29 INFO - ##### 19:33:29 INFO - ##### Running install step. 19:33:29 INFO - ##### 19:33:29 INFO - Running pre-action listener: _resource_record_pre_action 19:33:29 INFO - Running main action method: install 19:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:29 INFO - Reading from file tmpfile_stdout 19:33:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:33:29 INFO - Reading from file tmpfile_stdout 19:33:29 INFO - Output received: 19:33:29 INFO - Usage: mozinstall [options] installer 19:33:29 INFO - Options: 19:33:29 INFO - -h, --help show this help message and exit 19:33:29 INFO - -d DEST, --destination=DEST 19:33:29 INFO - Directory to install application into. [default: 19:33:29 INFO - "/builds/slave/test"] 19:33:29 INFO - --app=APP Application being installed. [default: firefox] 19:33:29 INFO - mkdir: /builds/slave/test/build/application 19:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:33:47 INFO - Reading from file tmpfile_stdout 19:33:47 INFO - Output received: 19:33:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:33:47 INFO - Running post-action listener: _resource_record_post_action 19:33:47 INFO - ##### 19:33:47 INFO - ##### Finished install step (success) 19:33:47 INFO - ##### 19:33:47 INFO - ##### 19:33:47 INFO - ##### Running run-tests step. 19:33:47 INFO - ##### 19:33:47 INFO - Running pre-action listener: _resource_record_pre_action 19:33:47 INFO - Running main action method: run_tests 19:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:33:47 INFO - Python 2.7.3 19:33:47 INFO - Return code: 0 19:33:47 INFO - grabbing minidump binary from tooltool 19:33: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:33:47 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 0x22b96f0>, '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 0x22ba5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22baaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:33:47 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:33:47 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:33:47 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:33:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:33:47 INFO - Return code: 0 19:33:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:33:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:33:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:33:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:33:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:33:48 INFO - Return code: 0 19:33:48 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:33:48 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:33:48 INFO - Using env: {'DISPLAY': ':0', 19:33:48 INFO - 'HOME': '/home/cltbld', 19:33:48 INFO - 'LANG': 'en_US.UTF-8', 19:33:48 INFO - 'LANGUAGE': 'en_US:en', 19:33:48 INFO - 'LOGNAME': 'cltbld', 19:33:48 INFO - 'MAIL': '/var/mail/cltbld', 19:33:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:33:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:48 INFO - 'MOZ_NO_REMOTE': '1', 19:33:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:48 INFO - 'NO_EM_RESTART': '1', 19:33:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:48 INFO - 'PWD': '/builds/slave/test', 19:33:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:33:48 INFO - 'SHELL': '/bin/bash', 19:33:48 INFO - 'SHLVL': '1', 19:33:48 INFO - 'TERM': 'linux', 19:33:48 INFO - 'TMOUT': '86400', 19:33:48 INFO - 'USER': 'cltbld', 19:33:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168', 19:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:48 INFO - '_': '/tools/buildbot/bin/python'} 19:33:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:33:48 INFO - mozversion application_buildid: 20160627163033 19:33:48 INFO - mozversion application_changeset: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 19:33:48 INFO - mozversion application_display_name: Nightly 19:33:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:48 INFO - mozversion application_name: Firefox 19:33:48 INFO - mozversion application_remotingname: firefox 19:33:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:33:48 INFO - mozversion application_vendor: Mozilla 19:33:48 INFO - mozversion application_version: 50.0a1 19:33:48 INFO - mozversion platform_buildid: 20160627163033 19:33:48 INFO - mozversion platform_changeset: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 19:33:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:33:48 INFO - mozversion platform_version: 50.0a1 19:33:48 INFO - using testdate: 1467081228 19:33:48 INFO - actual date: 1467081228 19:33:48 INFO - starting webserver on 'localhost:50871' 19:33:48 INFO - SUITE-START | Running 2 tests 19:33:48 INFO - TEST-START | dromaeo_css 19:33:48 INFO - operating with platform_type : linux_ 19:33:48 INFO - Initialising browser for dromaeo_css test... 19:33:48 INFO - TEST-INFO | started process 7510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYacNiz/profile http://localhost:50871/getInfo.html) 19:33:52 INFO - PROCESS | 7510 | __metrics Screen width/height:1600/1200 19:33:52 INFO - PROCESS | 7510 | colorDepth:24 19:33:52 INFO - PROCESS | 7510 | Browser inner width/height: 1024/697 19:33:52 INFO - PROCESS | 7510 | __metrics 19:33:53 INFO - PROCESS | 7510 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:33:54 INFO - TEST-INFO | 7510: exit 0 19:33:54 INFO - Browser initialized. 19:33:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:54 INFO - TEST-INFO | started process 7593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYacNiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:05 INFO - PROCESS | 7593 | RSS: Main: 156712960 19:34:05 INFO - PROCESS | 7593 | 19:34:57 INFO - PROCESS | 7593 | 1467081297364 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:37:05 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50871/tests/dromaeo/cssquery-ext.html) 19:37:06 INFO - PROCESS | 7593 | RSS: Main: 248090624 19:37:06 INFO - PROCESS | 7593 | 19:40:08 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-ext.html (next: http://localhost:50871/tests/dromaeo/cssquery-jquery.html) 19:40:09 INFO - PROCESS | 7593 | RSS: Main: 242724864 19:40:09 INFO - PROCESS | 7593 | 19:43:11 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50871/tests/dromaeo/cssquery-mootools.html) 19:43:12 INFO - PROCESS | 7593 | RSS: Main: 254115840 19:43:12 INFO - PROCESS | 7593 | 19:46:14 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50871/tests/dromaeo/cssquery-prototype.html) 19:46:14 INFO - PROCESS | 7593 | RSS: Main: 247955456 19:46:14 INFO - PROCESS | 7593 | 19:49:17 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50871/tests/dromaeo/cssquery-yui.html) 19:49:18 INFO - PROCESS | 7593 | RSS: Main: 221720576 19:49:18 INFO - PROCESS | 7593 | 19:52:20 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:50871/tests/dromaeo/cssquery-yui.html (next: http://localhost:50871/tests/dromaeo/cssquery-dojo.html) 19:52:21 INFO - PROCESS | 7593 | RSS: Main: 292392960 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | __start_tp_report 19:52:21 INFO - PROCESS | 7593 | _x_x_mozilla_page_load 19:52:21 INFO - PROCESS | 7593 | _x_x_mozilla_page_load_details 19:52:21 INFO - PROCESS | 7593 | |i|pagename|runs| 19:52:21 INFO - PROCESS | 7593 | |0;dojo.html;3071.8003329783564;3098.5197294419368;3108.48709962856;3131;3147.260393807455;5221.608379371543;5231.921521177181;5236.79052837887;5416.837494875155;5448.237246785453;5333.466653334664;5357.1696387060065;5358.410574836775;5382.784688612461;5446.046941785192;4820.614350851933;4879.9512004880025;4899.216125419934;4914.680545764531;5066.822661206858;4964.503549645043;4966.826161084363;5009.223570346584;5009.724465154415;5016.899662006757;4765.380500534926;4814;4815.398075240595;4890.5109489051165;4901.534354236342;4888.242322440027;4897.04507621014;4897.9224570594415;4910.050383722012;4961.9751901240625;4873.585745211626;4891.4863939286215;4893.412790465131;4935.3090567320605;4943.258511223309;5208.5572726318305;5325.893482130375;5398.1902714593125;5398.2982212312545;5411.107167317388;5834.095715164156;5840.941590584082;5842.065269556893;5845.123231515264;5855.326637436707;5831.883362332772;5836.9124463133085;5869.031609784381;5889.381614930414;5890;5241.977814326208;5390.164524498669;5402.459754024645;5418.485243901783;5429.267048948421;5877.089051196986;5891.234139561915;5945.613535120204;5950.19672344228;6007.48936340416;5471.124620060771;5760.193572899798;5767.913481297784;5770.42295770428;5778.046622307273;5708.942910570841;5738.1679656450415;5745.942540574624;5751.597388182787;5773.5958482906635;5718.313802343662;5750.079987202028;5759.136129580596;5766.798162064308;5770.538356931435;5531.751071201725;5642.351129620064;5691.26013618227;5707.743151558107;5709.400512946164;4377.627901628397;4415.116976604628;4416.183006143874;4446.688731788809;4461.286194208976;3924.136689928211;3938.6258305460933;3939.8227079781477;3945.763254204757;3982.3429134192534;5196.714180720021;5262.684238945675;5338.599605029638;5440.183972404171;5468.398476167618;5734.369219385864;5750.511206547407;5774.82675519735;5776.42235776419;5842.094475356326;5403.054465468527;5407.053765591006;5412.269343638637;5416.052190866582;5418.214358917935;4718.646101542398;4818.253170758538;4843.467218605951;4871.95128048715;4909.091818013679;5907.586468947133;5940.673262970578;5945.613535120204;5946.345901950782;5990.4908082813445;5717.7141142941855;5737.9139312911175;5742.799002034909;5744.253247077853;5745.683987380734;5736.971315143398;5834.03738383179;5852.473277405054;5869.941300586939;5893.9115913260475;5624.156376543551;5637.238972738792;5641.5204707600315;5650.378458369658;5658.462446067617;5707.828765137053;5708.942910571007;5736.053551164011;5742.253507044057;5759.2512973313205;5360.946390536044;5413.052715774645;5468.125099984142;5522.282103326542;5531.778728850801;5526.834194974157;5527.917081243704;5529.060059789926;5530.364008138955;5532.30846144232;5363.436839131835;5417.620766546304;5431.646942948696;5433.293671822637;5485.533729632866;5598.720063996702;5643.802466913638;5649.71751412436;5727.799527016535;5729.627574207663;5535.418781027934;5543.113101903676;5543.584231182758;5553.805616803393;5595.412481689526 19:52:21 INFO - PROCESS | 7593 | |1;ext.html;596.5943158652116;599.4425184578344;612.8069658057709;626.7179769103901;632.6109442692742;33913;36379.63620363796;43759.34360984584;44345.55654443455;44385.556144438546;46052.3092153618;46596.53403465964;46676.29985550219;46688.29967550481;46718.29922551165;8990.865137022965;9168.770780730501;9172.082791720808;9172.220361269267;9176.17414432701;8298.294644955186;10543.47282635869;10857;10867.673969780919;11190.552377904874;11007.61473348433;11098.778024439507;11100.111991040738;11105.389203593799;11108.444577771079;8403.327733781283;10587.417692026935;10793.67618971432;10857.619983300625;10858.457077146111;10758.731031724192;10777;10837.729056773565;10842.891571084347;10857.23999320048;42281.1543769126;42394.364084538756;42458;42720.57279427197;42807.78596107031;3411.4200585900207;3505.8071806050657;3509.543759311299;3528.823558822074;3605.891823245307;32668.183295417566;32985.505217421756;33070.00789976305;33449.33101337984;34795.65204347975;4180.728252663597;4247.915041699149;4303.548127446636;4367.475902891641;4450.198964186445;336325;340391;340853;341140;342053;60862.391376086554;60914.390856091755;61161;61316.38683613196;61317.69341153266;64177.67911160507;64584.677076615255;64586.677066614364;64699.35300646933;64740;17200.569985750208;17279.65440691179;17611.471655850346;17624.735628965576;17669.11654417274;13443.529476468473;13622.659433514242;13623.114497557626;13624.591262262147;13629;20154.899225503777;20174.89912550428;20281.188752449736;20282;20336.966303369543;7161.427085833121;7216.855662886713;7356.301151390609;7379.520331178456;7417.258274172539;831.6382373667474;926.5413620258015;976.414151509103;1131.6984379791718;1132.9376884271444;33847.49228761571;34169.145771355914;34403.4839477408;34483.655163448544;34753.478697819555;1105.4307031878589;1121.4785124916789;1139.783441146196;1173.5481839491856;1248.5630029489605;17459.301627934994;17799.288028478717;17872.463826085237;17899.552511187325;17900.462986110437;531289;534802;536888;538576;538869;61858.381416185264;62617;62717.68641156856;62742;62766.37233627697;1229.5081967213187;1284.9743005140033;1308.3915979069589;1363.6522686714825;1387.840398354202;31041.534376983913;35057.47413788744;35105.64894351024;35175.296494069466;35684.821575892995;51975;52551;52562;52686.736566316926;52694.47305526896;411724;413370;415112;415709;416320;26652;27047.594286086118;27642.170734877986;27801.860990694917;29058.27354316159;49200.26199606937;49392.75303623603;50081.24878126758;50140.247896282315;51266.48733512617;41697.79151104225;41860;42116.578834211265;42974.355384668626;44295.335569965835;42465.36301955411;42570;42816;43033.354499681904;44092.33861492016;41570.258161926926;42573.78713106415;42792.144157117305;43172.78413607912;43418.13163736771;35786.284274313846;37204.627953721196;37389;38170.23659526849;38519.614803852724;28326.858365708038;28740.42519149647;28781.85609071941;28919.421611568072;29214.415711686073 19:52:21 INFO - PROCESS | 7593 | |2;jquery.html;376.9962300376996;383.859891139734;384.2066133434458;397.2392867658434;399.33909379976114;17258.568535786613;20526.38420847377;20786.06462709178;20795.480112997182;20799.792002079976;18657.25370985159;18766.906165469154;19140.808591914076;19514.512137196576;19559.70660440091;5461.590380721442;5508.7521061552325;5667.744951477193;5720.685362305072;5842;5788.71056447178;5803.390643982384;5804.303483581976;5811.0702287633985;5831.416858314177;5436.537894278991;5728.828135155931;5730.7707691692285;5821.53427725781;5830.562707796911;5748.770049198027;5784.942150578482;5806.622569532967;5812.738426770806;5821.825345239628;5428.212909128154;5536.446355364472;5537.723113844291;5540.778368865241;5544.417836127229;13545.59363219105;13761.724765504734;14469.565913022627;22820.429489262737;22864.199753008565;2166.8266538677026;2240.8543444676206;2357.446000189954;2408.506256217489;2766.634940725638;9104.954475227581;9520.476373799438;9602.66390676323;9923.603055877757;9969.850452243221;1897.7532920720357;1960.1767257751778;2010.7587089549347;2077.1379877351033;2174.2172817785586;77511.61244193799;77967.61016194883;80971.5951420245;83745;84976.15023849744;10761.623343182951;10796.190285728602;10929.398883061349;11046.226764126433;11052.778944421227;14945.925270373578;15060.623484412758;15064.34292227854;15069.321880515403;15086.245687715571;7463;7943.721969731032;8070.798230044178;8113.066997295268;8214.876776848352;7595.696172153052;7645.655945482466;7692.615369231516;7835.0989636191425;7859.174786647434;4642.744649044267;4674.789634466457;4702.717836929795;4717.127331443694;4804.2073057945745;1883.736276921232;1897.3548993342054;1919.3090487424515;1922.4424916773978;1966.606678664273;903.2773780975193;951.5575257505293;956.2636769687302;973.4110862927968;993.4883534979491;18651.90674046621;19269.22923083061;20141.367485478422;20208.191672333236;20550.794492055185;984.2519685039422;999.48526508848;1044.7805960748328;1049.6903413493037;1052.563186277686;10376.584936602603;11177.49701263445;11200.663980080612;11260.887391125983;11278.7180320491;393597;395203;421114;428604;432621;67829;87098;89843.10156898478;92283;92541;914.154407173362;968.1431932739576;1019.108280254777;1054.7415883108688;1055.2665897201525;16745.497635070966;18125.728114078564;18321.26714931441;18321.541961451072;18670;40656.39015414831;43011.13977720491;43069;43151.13697726091;43519.564804351554;57859;59091.40908590859;59427.40572594219;59453.70273148607;60132.39867601268;8622;8793.780155496164;8816.955915220382;8856.822863542822;9044.14080662336;9234.769130771516;11573.826392604286;12918.767899000919;13898.37457314403;14683.632909177357;12201;12479.93760031194;12542.24746515212;12700.936495317465;12706;5951.910721339097;10376.533056012648;11599.318098875785;12490.87509124897;12935.094543382249;12524.686882828002;12592.937035314764;12899.290539020069;12948.028897832888;13200;8886.289096872106;8947.821043579223;8990.235829954527;9003.189712925869;9266.11971862672;11664.125190610568;12333.321667308384;12505.187162834387;12531;12617.68455788576 19:52:21 INFO - PROCESS | 7593 | |3;mootools.html;1257.2645002673435;1410.896028736779;1469.3461409672695;1525.5118362124117;1666.500049985005;7984.520928744272;8364.623591938354;8365.874511882326;8657.091005444416;8661.437006594568;8318.37612179086;8546.059933407336;8561;8566.186212309836;8573;2023.4132101690493;2099.8530102892805;2103.5687684024815;2364.5507353602848;2398.556267090585;2346.495503466754;2423.6485709572103;2425.4906469641396;2441.523902838947;2447.2535876557645;2324.081987614891;2360.221127028077;2377.8454400464;2381.285614315707;2394.4971555973266;2002.2291417804104;2280.1905323610044;2321.8839058047115;2330.93007209784;2332.4518738096535;2332.6384410416413;2373.4659701567184;2376.524695060995;2377.5601513719844;2378.322178179211;8165;8209.09699933007;8221.342292616577;8221.342292616577;8224.62989165489;5059.6458247922665;5192.1692529195525;5213;5219.660722053092;5223.190405487156;3175.5077962915784;3322.966770332314;3453.637368076341;3500.1949551603275;3514.1566024154017;1164.615676826645;1171.3440473334874;1177.6172743858194;1197.6826141072622;1199.8440202773584;11897;11897.226680265756;11897.226680265756;11902.464389102512;11903.345316007617;4432.756198409054;4568.88577785558;4671.18254305502;4675.976620116878;4688.882777930511;10014.649487268056;10016.449095299828;10023;10025.348352357074;10029.097381235724;5224.764885580158;5228.398734145546;5229.215617657382;5233.476652334813;5234.581233501311;4117.938230926538;4635.95364046362;4687.320338550891;4799.9760001199775;4802.591779698695;3895;3923.862664806718;3997.740146890501;4019.6382325590253;4039.6162364575316;1253.9184952978028;1257.1200159888115;1259.924404535731;1274.471094495774;1280.9871901281053;918.7519369770125;927.5872236854669;990.1039559198937;990.5592011554933;1005.7737009172878;5888.411158884077;6024.57827952048;6087.939120608826;6118.938810611926;6257.5932564383165;934.63082082577;945.6028468043438;956.789506308611;974.3910056214866;979.9657012004689;3818.961810381916;3985.720999530005;3991.940120898189;4003.719739618257;4025.5571887092397;10313.27807053499;10446.68659940203;10675.466226688635;10715.83926241107;10731.926807319205;10545.57817687284;10620.575176992988;10679.83980240297;10698.465076746288;10700.89299106999;7545.547267164097;7933.603319833986;8081.6363263653275;8081.757547273592;8088;6010.278766548042;6158.815235542941;6177;6190.290796921261;6312.842178945563;9762.170215531476;9816.65641702537;9914.553845076845;9932.155766759906;9934;9606.711798646053;9853.901460985586;10009.099181073738;10028.24788140907;10028.548715307974;6631.204255489372;7354;7464.925350746423;7531.623418829146;7643.044619422572;8401.03388110375;8421.831563368822;8456.492610443393;8475.915240847513;8508.74473765788;7490.775276741707;7628.351590114902;7653.387728981556;7767.184445633353;7837.843243135219;7368.410527157922;7544.849103017799;7579.355754760907;7654.8086297843;7666.769996900102;6926.480513961373;6964.79105626832;6971.5468494547695;6977.302269772982;6981.0924579804305;4690.742009189527;4874.878128046827;4878.559881852909;4974.502549744997;4984.42679091909;4900.828471003498;4978.502149784992;4993.80024799004;5027.748612569284;5089.847304580869 19:52:21 INFO - PROCESS | 7593 | |4;prototype.html;310.86632747918384;320.6184640278069;326.83494835108297;328.412142265345;331.4034737472549;5435.347758269003;5436.72816359182;5445.48267914548;5459.3994660587305;5528.585356098293;5080.669756465836;5123.871903202422;5248.186531087678;5280.392754833195;5384.461553844613;4128.091819799639;4153.937690934638;4166.208420400129;4167.499500299811;4219.831206751734;4167.291560434734;4171.916561668765;4186.853460128896;4189.497260328765;4202.9405591260365;3860.8803447000478;3931.6854651627946;4033.5159780826343;4078.185207582627;4146.709730318879;4115.279826030448;4121.876343709679;4135.400366946806;4145.631941459311;4182.728122672047;3630.8366123524506;3656.8720094796554;3661.121330880596;3666.0285024468535;3682.705383569308;5076.400933705871;5093;5172.629253247892;5201.193814958688;5202.141646628302;4698.506656801055;4704.906316689075;4705.12955103307;4741.881452963669;4745.311929770199;5525.585581081435;5528.668279903219;5543.6396634218645;5556.91664625031;5569.498745112959;3871.2838124946693;4017.879463616096;4025.657819085381;4026.617471340218;4054.2296963576828;5693.430656934273;5713.542916566665;5738.4835364816945;5754.223179870748;5771.769129234825;4088.5911408858874;4089.3457046872954;4095.365218391154;4119.299719047769;4124.278251306009;4045.069633984141;4085.119990406756;4144.834206631761;4169.708120431601;4173.207090652766;4709.293605959065;4716.976415117971;4725.149473094807;4731.148393289172;4738.763061846894;5539.8892022160135;5569.136783798518;5585.854899745624;5600.327960644668;5603.187537806995;1359.8572149924314;1366.8154799102192;1410.3723842889815;1432.1908121911088;1441.2865631512468;966.6278482784179;994.3188915592842;997.8553109799038;1004.924630652704;1009.4700282351678;5056;5314.591633217201;5315.468453154654;5319.707416092152;5343.812966546152;5643.802466913638;5655.915161272585;5663.235463212496;5667.886642267132;5687.544996400278;5191.532762051434;5316;5316.7075810830775;5321.521063104339;5322.4411436799355;2988.506896362076;2998;3012.8493575321145;3014.216303760994;3015.62304711911;5780.248567686258;5780.971095144498;5786.508146807484;5796.348040808433;5810.767569297265;5527.44725527444;5745.942540574624;5753.993051216021;5896.557758168069;5898;5924.703764811742;5943.791967281211;5944.5838791284195;5955.7617695292565;5956.195913551702;5500.80747173847;5747.655140691572;5749.166370876116;5772.855678608068;5778.27771528559;5623.578231632726;5719.3136823581435;5744.741486633028;5766.3080430346945;5767.480926716616;5902.9964905966945;5917.378675239038;5920.348761636303;5993.741314324041;5995.940040599713;4007.6793856491995;4088.529819070845;4093.7748423836974;4103;4111.321631930698;5782.17861373666;5789;5810.302763668386;5811.389804070512;5826.213461182686;5319.840404787863;5415.241866138823;5536.861578460571;5628.367773345684;5709.914351284817;5617.578681598979;5646.71766411686;5648.689322087161;5659.801906933238;5673.9432605675065;5255.448177941261;5506.421825708243;5536.7231638417115;5556.694381809039;5559.471850174227;5645.092777219817;5675.318961724454;5693.975084484832;5721.768510280911;5721.885562288814;5445.863853403696;5481.808136715196;5508.14623733322;5525.668459892419;5540.667559946416 19:52:21 INFO - PROCESS | 7593 | |5;yui.html;691.9861602767947;753.0361137743687;769.6882762481197;781.7029528779063;791.5448617045199;14833.332500037497;16123.596910077255;16143.273552690127;16414;16918.830811691878;15953.84046159538;15963.361465541364;16129.112898790561;16141.273642686077;16169.757453638205;676.5365724478723;792.6076592086926;792.627465091409;801.6472751989136;803.7267329108131;793.4921650143883;796.2913007423398;797.5573556676071;798.317438590003;800.2797482265978;836.3016880904452;842.5660784695887;842.9873551896695;843.28320927212;843.6878355008624;705.9047028651144;813.9837203255961;838.786109542069;841.5707988925661;842.0148426341165;610.9816705498843;616.0820377637333;616.4236438929615;616.6146158650844;616.907463880417;15179.696406071816;15196.848031519654;15253.694926101527;15261.465848695243;15268.847311526964;13650.658733531642;14105.2242126683;14112.294385280798;14124.505642302573;14335.42658293667;13295.667608309774;13308.401121949535;13498.59504214875;13545.45818167272;13569.118007329591;4501.842435514741;4522.253828118356;4528.569785870337;4575.748333841638;4698.812047518095;75780.24219757787;77635.61182194053;77668.22331776666;78064.21935780626;78131.60934195292;11066.39134847591;11242.156838237;11325.743591790353;11356.772864542663;11373.829392559119;20659.793402066087;20686.275980340615;20691.27580534674;20694.793052069286;20704.171833126507;8482.151784821468;8510.148985101565;8524.70163544273;8667.046624871258;8797.604107815163;4795.808167673324;4834.685745426606;4912.937801330813;5027.396712394463;5261.105612045885;3635.7454978151804;3758.628100743209;3769.264993326275;3795.4876091727265;3802.372608519563;643.9066335381438;647.3138473218404;683.6205905722372;684.5003147702205;686.6532401137393;632.1006217139867;633.6831584207896;739.4786675393834;750.3734381791265;763.7823220382276;9321.72034838956;9440.622375105057;9558.28312876537;9829.31194816356;9950.80098398028;722.4762047515615;732.5641243460133;735.7719107076823;740.489062546841;741.7478057460489;4531.229690952546;4827.348307978448;4841.392360938256;4922.704637721748;4957.702537847741;111930.44034779775;113698;113950;115248.42375788068;117399.41300293444;85147.5742621283;99465.50267248762;99514;99569.50215249023;100426.49786751166;83168.58415707883;84496.57751711326;84749;85061.57469212738;87070.56464717763;8833.29333653319;9155.86266205994;9205.86191207119;9342.299327550325;9402.38884472507;51164;51688.22467662913;52230.47769522256;52775.47224527706;53782.19326710181;43340;49127;67924.6603766978;74907.62546187235;75864.24135758572;11924.463399147233;12071.614802772025;12075.335856527623;12120.393980300772;12285.69285767863;13480.988925830407;13593.320333983063;13657.726845463234;14075.859241407865;14676.77984830207;12822.679433013876;12969.740605188032;13208.405621747237;13328.600141995756;13656.112352697042;12848.164869283466;12924.462061719081;13399.933000335326;13449.394777234853;13457.798133027816;12861.807072894102;12932.55422402679;12997.338276769335;13013;13783;10641.414722190353;10947.890521094687;10968.122550195805;11157.386343750846;11168.385738784445;11114;11187;11252.943735281271;11419.200655954335;11523.654290371302 19:52:21 INFO - PROCESS | 7593 | __end_tp_report 19:52:21 INFO - PROCESS | 7593 | __start_cc_report 19:52:21 INFO - PROCESS | 7593 | _x_x_mozilla_cycle_collect,876 19:52:21 INFO - PROCESS | 7593 | __end_cc_report 19:52:21 INFO - PROCESS | 7593 | __startTimestamp1467082341144__endTimestamp 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | ------- Summary: start ------- 19:52:21 INFO - PROCESS | 7593 | Number of tests: 6 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#0] dojo.html Cycles:165 Average:5328.97 Median:5471.12 stddev:602.14 (11.0%) stddev-sans-first:577.36 19:52:21 INFO - PROCESS | 7593 | Values: 3071.8 3098.5 3108.5 3131.0 3147.3 5221.6 5231.9 5236.8 5416.8 5448.2 5333.5 5357.2 5358.4 5382.8 5446.0 4820.6 4880.0 4899.2 4914.7 5066.8 4964.5 4966.8 5009.2 5009.7 5016.9 4765.4 4814.0 4815.4 4890.5 4901.5 4888.2 4897.0 4897.9 4910.1 4962.0 4873.6 4891.5 4893.4 4935.3 4943.3 5208.6 5325.9 5398.2 5398.3 5411.1 5834.1 5840.9 5842.1 5845.1 5855.3 5831.9 5836.9 5869.0 5889.4 5890.0 5242.0 5390.2 5402.5 5418.5 5429.3 5877.1 5891.2 5945.6 5950.2 6007.5 5471.1 5760.2 5767.9 5770.4 5778.0 5708.9 5738.2 5745.9 5751.6 5773.6 5718.3 5750.1 5759.1 5766.8 5770.5 5531.8 5642.4 5691.3 5707.7 5709.4 4377.6 4415.1 4416.2 4446.7 4461.3 3924.1 3938.6 3939.8 3945.8 3982.3 5196.7 5262.7 5338.6 5440.2 5468.4 5734.4 5750.5 5774.8 5776.4 5842.1 5403.1 5407.1 5412.3 5416.1 5418.2 4718.6 4818.3 4843.5 4872.0 4909.1 5907.6 5940.7 5945.6 5946.3 5990.5 5717.7 5737.9 5742.8 5744.3 5745.7 5737.0 5834.0 5852.5 5869.9 5893.9 5624.2 5637.2 5641.5 5650.4 5658.5 5707.8 5708.9 5736.1 5742.3 5759.3 5360.9 5413.1 5468.1 5522.3 5531.8 5526.8 5527.9 5529.1 5530.4 5532.3 5363.4 5417.6 5431.6 5433.3 5485.5 5598.7 5643.8 5649.7 5727.8 5729.6 5535.4 5543.1 5543.6 5553.8 5595.4 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#1] ext.html Cycles:180 Average:60425.54 Median:38344.93 stddev:115785.77 (302.0%) stddev-sans-first:116023.44 19:52:21 INFO - PROCESS | 7593 | Values: 596.6 599.4 612.8 626.7 632.6 33913.0 36379.6 43759.3 44345.6 44385.6 46052.3 46596.5 46676.3 46688.3 46718.3 8990.9 9168.8 9172.1 9172.2 9176.2 8298.3 10543.5 10857.0 10867.7 11190.6 11007.6 11098.8 11100.1 11105.4 11108.4 8403.3 10587.4 10793.7 10857.6 10858.5 10758.7 10777.0 10837.7 10842.9 10857.2 42281.2 42394.4 42458.0 42720.6 42807.8 3411.4 3505.8 3509.5 3528.8 3605.9 32668.2 32985.5 33070.0 33449.3 34795.7 4180.7 4247.9 4303.5 4367.5 4450.2 336325.0 340391.0 340853.0 341140.0 342053.0 60862.4 60914.4 61161.0 61316.4 61317.7 64177.7 64584.7 64586.7 64699.4 64740.0 17200.6 17279.7 17611.5 17624.7 17669.1 13443.5 13622.7 13623.1 13624.6 13629.0 20154.9 20174.9 20281.2 20282.0 20337.0 7161.4 7216.9 7356.3 7379.5 7417.3 831.6 926.5 976.4 1131.7 1132.9 33847.5 34169.1 34403.5 34483.7 34753.5 1105.4 1121.5 1139.8 1173.5 1248.6 17459.3 17799.3 17872.5 17899.6 17900.5 531289.0 534802.0 536888.0 538576.0 538869.0 61858.4 62617.0 62717.7 62742.0 62766.4 1229.5 1285.0 1308.4 1363.7 1387.8 31041.5 35057.5 35105.6 35175.3 35684.8 51975.0 52551.0 52562.0 52686.7 52694.5 411724.0 413370.0 415112.0 415709.0 416320.0 26652.0 27047.6 27642.2 27801.9 29058.3 49200.3 49392.8 50081.2 50140.2 51266.5 41697.8 41860.0 42116.6 42974.4 44295.3 42465.4 42570.0 42816.0 43033.4 44092.3 41570.3 42573.8 42792.1 43172.8 43418.1 35786.3 37204.6 37389.0 38170.2 38519.6 28326.9 28740.4 28781.9 28919.4 29214.4 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#2] jquery.html Cycles:180 Average:26705.29 Median:20527.86 stddev:68740.73 (334.9%) stddev-sans-first:68905.14 19:52:21 INFO - PROCESS | 7593 | Values: 377.0 383.9 384.2 397.2 399.3 17258.6 20526.4 20786.1 20795.5 20799.8 18657.3 18766.9 19140.8 19514.5 19559.7 5461.6 5508.8 5667.7 5720.7 5842.0 5788.7 5803.4 5804.3 5811.1 5831.4 5436.5 5728.8 5730.8 5821.5 5830.6 5748.8 5784.9 5806.6 5812.7 5821.8 5428.2 5536.4 5537.7 5540.8 5544.4 13545.6 13761.7 14469.6 22820.4 22864.2 2166.8 2240.9 2357.4 2408.5 2766.6 9105.0 9520.5 9602.7 9923.6 9969.9 1897.8 1960.2 2010.8 2077.1 2174.2 77511.6 77967.6 80971.6 83745.0 84976.2 10761.6 10796.2 10929.4 11046.2 11052.8 14945.9 15060.6 15064.3 15069.3 15086.2 7463.0 7943.7 8070.8 8113.1 8214.9 7595.7 7645.7 7692.6 7835.1 7859.2 4642.7 4674.8 4702.7 4717.1 4804.2 1883.7 1897.4 1919.3 1922.4 1966.6 903.3 951.6 956.3 973.4 993.5 18651.9 19269.2 20141.4 20208.2 20550.8 984.3 999.5 1044.8 1049.7 1052.6 10376.6 11177.5 11200.7 11260.9 11278.7 393597.0 395203.0 421114.0 428604.0 432621.0 67829.0 87098.0 89843.1 92283.0 92541.0 914.2 968.1 1019.1 1054.7 1055.3 16745.5 18125.7 18321.3 18321.5 18670.0 40656.4 43011.1 43069.0 43151.1 43519.6 57859.0 59091.4 59427.4 59453.7 60132.4 8622.0 8793.8 8817.0 8856.8 9044.1 9234.8 11573.8 12918.8 13898.4 14683.6 12201.0 12479.9 12542.2 12700.9 12706.0 5951.9 10376.5 11599.3 12490.9 12935.1 12524.7 12592.9 12899.3 12948.0 13200.0 8886.3 8947.8 8990.2 9003.2 9266.1 11664.1 12333.3 12505.2 12531.0 12617.7 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#3] mootools.html Cycles:180 Average:5680.72 Median:4876.72 stddev:3182.06 (65.3%) stddev-sans-first:3173.62 19:52:21 INFO - PROCESS | 7593 | Values: 1257.3 1410.9 1469.3 1525.5 1666.5 7984.5 8364.6 8365.9 8657.1 8661.4 8318.4 8546.1 8561.0 8566.2 8573.0 2023.4 2099.9 2103.6 2364.6 2398.6 2346.5 2423.6 2425.5 2441.5 2447.3 2324.1 2360.2 2377.8 2381.3 2394.5 2002.2 2280.2 2321.9 2330.9 2332.5 2332.6 2373.5 2376.5 2377.6 2378.3 8165.0 8209.1 8221.3 8221.3 8224.6 5059.6 5192.2 5213.0 5219.7 5223.2 3175.5 3323.0 3453.6 3500.2 3514.2 1164.6 1171.3 1177.6 1197.7 1199.8 11897.0 11897.2 11897.2 11902.5 11903.3 4432.8 4568.9 4671.2 4676.0 4688.9 10014.6 10016.4 10023.0 10025.3 10029.1 5224.8 5228.4 5229.2 5233.5 5234.6 4117.9 4636.0 4687.3 4800.0 4802.6 3895.0 3923.9 3997.7 4019.6 4039.6 1253.9 1257.1 1259.9 1274.5 1281.0 918.8 927.6 990.1 990.6 1005.8 5888.4 6024.6 6087.9 6118.9 6257.6 934.6 945.6 956.8 974.4 980.0 3819.0 3985.7 3991.9 4003.7 4025.6 10313.3 10446.7 10675.5 10715.8 10731.9 10545.6 10620.6 10679.8 10698.5 10700.9 7545.5 7933.6 8081.6 8081.8 8088.0 6010.3 6158.8 6177.0 6190.3 6312.8 9762.2 9816.7 9914.6 9932.2 9934.0 9606.7 9853.9 10009.1 10028.2 10028.5 6631.2 7354.0 7464.9 7531.6 7643.0 8401.0 8421.8 8456.5 8475.9 8508.7 7490.8 7628.4 7653.4 7767.2 7837.8 7368.4 7544.8 7579.4 7654.8 7666.8 6926.5 6964.8 6971.5 6977.3 6981.1 4690.7 4874.9 4878.6 4974.5 4984.4 4900.8 4978.5 4993.8 5027.7 5089.8 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#4] prototype.html Cycles:180 Average:4696.88 Median:5321.98 stddev:1383.10 (26.0%) stddev-sans-first:1347.24 19:52:21 INFO - PROCESS | 7593 | Values: 310.9 320.6 326.8 328.4 331.4 5435.3 5436.7 5445.5 5459.4 5528.6 5080.7 5123.9 5248.2 5280.4 5384.5 4128.1 4153.9 4166.2 4167.5 4219.8 4167.3 4171.9 4186.9 4189.5 4202.9 3860.9 3931.7 4033.5 4078.2 4146.7 4115.3 4121.9 4135.4 4145.6 4182.7 3630.8 3656.9 3661.1 3666.0 3682.7 5076.4 5093.0 5172.6 5201.2 5202.1 4698.5 4704.9 4705.1 4741.9 4745.3 5525.6 5528.7 5543.6 5556.9 5569.5 3871.3 4017.9 4025.7 4026.6 4054.2 5693.4 5713.5 5738.5 5754.2 5771.8 4088.6 4089.3 4095.4 4119.3 4124.3 4045.1 4085.1 4144.8 4169.7 4173.2 4709.3 4717.0 4725.1 4731.1 4738.8 5539.9 5569.1 5585.9 5600.3 5603.2 1359.9 1366.8 1410.4 1432.2 1441.3 966.6 994.3 997.9 1004.9 1009.5 5056.0 5314.6 5315.5 5319.7 5343.8 5643.8 5655.9 5663.2 5667.9 5687.5 5191.5 5316.0 5316.7 5321.5 5322.4 2988.5 2998.0 3012.8 3014.2 3015.6 5780.2 5781.0 5786.5 5796.3 5810.8 5527.4 5745.9 5754.0 5896.6 5898.0 5924.7 5943.8 5944.6 5955.8 5956.2 5500.8 5747.7 5749.2 5772.9 5778.3 5623.6 5719.3 5744.7 5766.3 5767.5 5903.0 5917.4 5920.3 5993.7 5995.9 4007.7 4088.5 4093.8 4103.0 4111.3 5782.2 5789.0 5810.3 5811.4 5826.2 5319.8 5415.2 5536.9 5628.4 5709.9 5617.6 5646.7 5648.7 5659.8 5673.9 5255.4 5506.4 5536.7 5556.7 5559.5 5645.1 5675.3 5694.0 5721.8 5721.9 5445.9 5481.8 5508.1 5525.7 5540.7 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - PROCESS | 7593 | [#5] yui.html Cycles:180 Average:20418.35 Median:4838.04 stddev:29253.97 (604.7%) stddev-sans-first:29298.54 19:52:21 INFO - PROCESS | 7593 | Values: 692.0 753.0 769.7 781.7 791.5 14833.3 16123.6 16143.3 16414.0 16918.8 15953.8 15963.4 16129.1 16141.3 16169.8 676.5 792.6 792.6 801.6 803.7 793.5 796.3 797.6 798.3 800.3 836.3 842.6 843.0 843.3 843.7 705.9 814.0 838.8 841.6 842.0 611.0 616.1 616.4 616.6 616.9 15179.7 15196.8 15253.7 15261.5 15268.8 13650.7 14105.2 14112.3 14124.5 14335.4 13295.7 13308.4 13498.6 13545.5 13569.1 4501.8 4522.3 4528.6 4575.7 4698.8 75780.2 77635.6 77668.2 78064.2 78131.6 11066.4 11242.2 11325.7 11356.8 11373.8 20659.8 20686.3 20691.3 20694.8 20704.2 8482.2 8510.1 8524.7 8667.0 8797.6 4795.8 4834.7 4912.9 5027.4 5261.1 3635.7 3758.6 3769.3 3795.5 3802.4 643.9 647.3 683.6 684.5 686.7 632.1 633.7 739.5 750.4 763.8 9321.7 9440.6 9558.3 9829.3 9950.8 722.5 732.6 735.8 740.5 741.7 4531.2 4827.3 4841.4 4922.7 4957.7 111930.4 113698.0 113950.0 115248.4 117399.4 85147.6 99465.5 99514.0 99569.5 100426.5 83168.6 84496.6 84749.0 85061.6 87070.6 8833.3 9155.9 9205.9 9342.3 9402.4 51164.0 51688.2 52230.5 52775.5 53782.2 43340.0 49127.0 67924.7 74907.6 75864.2 11924.5 12071.6 12075.3 12120.4 12285.7 13481.0 13593.3 13657.7 14075.9 14676.8 12822.7 12969.7 13208.4 13328.6 13656.1 12848.2 12924.5 13399.9 13449.4 13457.8 12861.8 12932.6 12997.3 13013.0 13783.0 10641.4 10947.9 10968.1 11157.4 11168.4 11114.0 11187.0 11252.9 11419.2 11523.7 19:52:21 INFO - PROCESS | 7593 | -------- Summary: end -------- 19:52:21 INFO - PROCESS | 7593 | 19:52:21 INFO - TEST-INFO | 7593: exit 0 19:52:21 INFO - TEST-OK | dromaeo_css | took 1113659ms 19:52:21 INFO - TEST-START | kraken 19:52:21 INFO - operating with platform_type : linux_ 19:52:21 INFO - Initialising browser for kraken test... 19:52:21 INFO - TEST-INFO | started process 7776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGinOkb/profile http://localhost:50871/getInfo.html) 19:52:25 INFO - PROCESS | 7776 | __metrics Screen width/height:1600/1200 19:52:25 INFO - PROCESS | 7776 | colorDepth:24 19:52:25 INFO - PROCESS | 7776 | Browser inner width/height: 1024/697 19:52:25 INFO - PROCESS | 7776 | __metrics 19:52:26 INFO - PROCESS | 7776 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:27 INFO - TEST-INFO | 7776: exit 0 19:52:27 INFO - Browser initialized. 19:52:27 INFO - Running cycle 1/1 for kraken test... 19:52:27 INFO - TEST-INFO | started process 7860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGinOkb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:39 INFO - PROCESS | 7860 | RSS: Main: 157347840 19:52:39 INFO - PROCESS | 7860 | 19:52:41 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50871/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:42 INFO - PROCESS | 7860 | RSS: Main: 214937600 19:52:42 INFO - PROCESS | 7860 | 19:52:45 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50871/tests/kraken/driver.html?testName=audio-dft) 19:52:46 INFO - PROCESS | 7860 | RSS: Main: 202379264 19:52:46 INFO - PROCESS | 7860 | 19:52:49 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50871/tests/kraken/driver.html?testName=audio-fft) 19:52:49 INFO - PROCESS | 7860 | RSS: Main: 268730368 19:52:49 INFO - PROCESS | 7860 | 19:52:51 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50871/tests/kraken/driver.html?testName=audio-oscillator) 19:52:52 INFO - PROCESS | 7860 | RSS: Main: 179363840 19:52:52 INFO - PROCESS | 7860 | 19:52:54 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:55 INFO - PROCESS | 7860 | RSS: Main: 183525376 19:52:55 INFO - PROCESS | 7860 | 19:52:58 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50871/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:58 INFO - PROCESS | 7860 | RSS: Main: 219271168 19:52:58 INFO - PROCESS | 7860 | 19:53:02 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50871/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:02 INFO - PROCESS | 7860 | RSS: Main: 220794880 19:53:02 INFO - PROCESS | 7860 | 19:53:05 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50871/tests/kraken/driver.html?testName=json-parse-financial) 19:53:06 INFO - PROCESS | 7860 | RSS: Main: 220647424 19:53:06 INFO - PROCESS | 7860 | 19:53:07 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:08 INFO - PROCESS | 7860 | RSS: Main: 207921152 19:53:08 INFO - PROCESS | 7860 | 19:53:10 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:10 INFO - PROCESS | 7860 | RSS: Main: 211664896 19:53:10 INFO - PROCESS | 7860 | 19:53:12 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:13 INFO - PROCESS | 7860 | RSS: Main: 219115520 19:53:13 INFO - PROCESS | 7860 | 19:53:16 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:16 INFO - PROCESS | 7860 | RSS: Main: 236302336 19:53:16 INFO - PROCESS | 7860 | 19:53:19 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:20 INFO - PROCESS | 7860 | RSS: Main: 227799040 19:53:20 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | Cycle 1(1): loaded http://localhost:50871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50871/tests/kraken/driver.html?testName=ai-astar) 19:53:21 INFO - PROCESS | 7860 | RSS: Main: 271421440 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | __start_tp_report 19:53:21 INFO - PROCESS | 7860 | _x_x_mozilla_page_load 19:53:21 INFO - PROCESS | 7860 | _x_x_mozilla_page_load_details 19:53:21 INFO - PROCESS | 7860 | |i|pagename|runs| 19:53:21 INFO - PROCESS | 7860 | |0;ai-astar;102;112;110;111;110;110;111;113;110;111 19:53:21 INFO - PROCESS | 7860 | |1;audio-beat-detection;148;127;126;193;127;128;155;124;162;126 19:53:21 INFO - PROCESS | 7860 | |2;audio-dft;160;161;161;159;160;162;160;160;160;160 19:53:21 INFO - PROCESS | 7860 | |3;audio-fft;74;74;75;129;76;77;75;74;98;74 19:53:21 INFO - PROCESS | 7860 | |4;audio-oscillator;85;84;105;85;87;86;123;84;86;122 19:53:21 INFO - PROCESS | 7860 | |5;imaging-gaussian-blur;118;117;117;117;116;116;117;116;117;117 19:53:21 INFO - PROCESS | 7860 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;145;146 19:53:21 INFO - PROCESS | 7860 | |7;imaging-desaturate;95;95;95;95;94;95;96;95;95;95 19:53:21 INFO - PROCESS | 7860 | |8;json-parse-financial;58;58;60;58;58;58;58;59;59;57 19:53:21 INFO - PROCESS | 7860 | |9;json-stringify-tinderbox;60;61;61;60;60;61;61;60;60;61 19:53:21 INFO - PROCESS | 7860 | |10;stanford-crypto-aes;79;84;80;80;81;81;81;81;145;81 19:53:21 INFO - PROCESS | 7860 | |11;stanford-crypto-ccm;132;131;122;118;120;120;125;123;124;121 19:53:21 INFO - PROCESS | 7860 | |12;stanford-crypto-pbkdf2;165;161;169;159;160;168;163;162;161;159 19:53:21 INFO - PROCESS | 7860 | |13;stanford-crypto-sha256-iterative;64;69;66;64;65;63;63;65;62;63 19:53:21 INFO - PROCESS | 7860 | __end_tp_report 19:53:21 INFO - PROCESS | 7860 | __start_cc_report 19:53:21 INFO - PROCESS | 7860 | _x_x_mozilla_cycle_collect,1644 19:53:21 INFO - PROCESS | 7860 | __end_cc_report 19:53:21 INFO - PROCESS | 7860 | __startTimestamp1467082401927__endTimestamp 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | ------- Summary: start ------- 19:53:21 INFO - PROCESS | 7860 | Number of tests: 14 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.98 (2.7%) stddev-sans-first:1.05 19:53:21 INFO - PROCESS | 7860 | Values: 102.0 112.0 110.0 111.0 110.0 110.0 111.0 113.0 110.0 111.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:138.00 stddev:22.82 (16.5%) stddev-sans-first:24.09 19:53:21 INFO - PROCESS | 7860 | Values: 148.0 127.0 126.0 193.0 127.0 128.0 155.0 124.0 162.0 126.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 19:53:21 INFO - PROCESS | 7860 | Values: 160.0 161.0 161.0 159.0 160.0 162.0 160.0 160.0 160.0 160.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.88 (23.8%) stddev-sans-first:18.69 19:53:21 INFO - PROCESS | 7860 | Values: 74.0 74.0 75.0 129.0 76.0 77.0 75.0 74.0 98.0 74.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:85.00 stddev:15.92 (18.7%) stddev-sans-first:16.49 19:53:21 INFO - PROCESS | 7860 | Values: 85.0 84.0 105.0 85.0 87.0 86.0 123.0 84.0 86.0 122.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 19:53:21 INFO - PROCESS | 7860 | Values: 118.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:53:21 INFO - PROCESS | 7860 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:53:21 INFO - PROCESS | 7860 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 19:53:21 INFO - PROCESS | 7860 | Values: 58.0 58.0 60.0 58.0 58.0 58.0 58.0 59.0 59.0 57.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 19:53:21 INFO - PROCESS | 7860 | Values: 60.0 61.0 61.0 60.0 60.0 61.0 61.0 60.0 60.0 61.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:81.00 stddev:20.31 (25.1%) stddev-sans-first:21.32 19:53:21 INFO - PROCESS | 7860 | Values: 79.0 84.0 80.0 80.0 81.0 81.0 81.0 81.0 145.0 81.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.50 stddev:4.65 (3.8%) stddev-sans-first:3.81 19:53:21 INFO - PROCESS | 7860 | Values: 132.0 131.0 122.0 118.0 120.0 120.0 125.0 123.0 124.0 121.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.50 stddev:3.56 (2.2%) stddev-sans-first:3.68 19:53:21 INFO - PROCESS | 7860 | Values: 165.0 161.0 169.0 159.0 160.0 168.0 163.0 162.0 161.0 159.0 19:53:21 INFO - PROCESS | 7860 | 19:53:21 INFO - PROCESS | 7860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:2.01 (3.1%) stddev-sans-first:2.13 19:53:21 INFO - PROCESS | 7860 | Values: 64.0 69.0 66.0 64.0 65.0 63.0 63.0 65.0 62.0 63.0 19:53:21 INFO - PROCESS | 7860 | -------- Summary: end -------- 19:53:21 INFO - PROCESS | 7860 | 19:53:22 INFO - TEST-INFO | 7860: exit 0 19:53:22 INFO - TEST-OK | kraken | took 61020ms 19:53:22 INFO - SUITE-END | took 1174s 19:53:23 INFO - Completed test suite (00:19:34) 19:53:23 INFO - javascript benchmark 19:53:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.8003329783564, 3098.5197294419368, 3108.48709962856, 3131.0, 3147.260393807455, 5221.608379371543, 5231.921521177181, 5236.79052837887, 5416.837494875155, 5448.237246785453, 5333.466653334664, 5357.1696387060065, 5358.410574836775, 5382.784688612461, 5446.046941785192, 4820.614350851933, 4879.9512004880025, 4899.216125419934, 4914.680545764531, 5066.822661206858, 4964.503549645043, 4966.826161084363, 5009.223570346584, 5009.724465154415, 5016.899662006757, 4765.380500534926, 4814.0, 4815.398075240595, 4890.5109489051165, 4901.534354236342, 4888.242322440027, 4897.04507621014, 4897.9224570594415, 4910.050383722012, 4961.9751901240625, 4873.585745211626, 4891.4863939286215, 4893.412790465131, 4935.3090567320605, 4943.258511223309, 5208.5572726318305, 5325.893482130375, 5398.1902714593125, 5398.2982212312545, 5411.107167317388, 5834.095715164156, 5840.941590584082, 5842.065269556893, 5845.123231515264, 5855.326637436707, 5831.883362332772, 5836.9124463133085, 5869.031609784381, 5889.381614930414, 5890.0, 5241.977814326208, 5390.164524498669, 5402.459754024645, 5418.485243901783, 5429.267048948421, 5877.089051196986, 5891.234139561915, 5945.613535120204, 5950.19672344228, 6007.48936340416, 5471.124620060771, 5760.193572899798, 5767.913481297784, 5770.42295770428, 5778.046622307273, 5708.942910570841, 5738.1679656450415, 5745.942540574624, 5751.597388182787, 5773.5958482906635, 5718.313802343662, 5750.079987202028, 5759.136129580596, 5766.798162064308, 5770.538356931435, 5531.751071201725, 5642.351129620064, 5691.26013618227, 5707.743151558107, 5709.400512946164, 4377.627901628397, 4415.116976604628, 4416.183006143874, 4446.688731788809, 4461.286194208976, 3924.136689928211, 3938.6258305460933, 3939.8227079781477, 3945.763254204757, 3982.3429134192534, 5196.714180720021, 5262.684238945675, 5338.599605029638, 5440.183972404171, 5468.398476167618, 5734.369219385864, 5750.511206547407, 5774.82675519735, 5776.42235776419, 5842.094475356326, 5403.054465468527, 5407.053765591006, 5412.269343638637, 5416.052190866582, 5418.214358917935, 4718.646101542398, 4818.253170758538, 4843.467218605951, 4871.95128048715, 4909.091818013679, 5907.586468947133, 5940.673262970578, 5945.613535120204, 5946.345901950782, 5990.4908082813445, 5717.7141142941855, 5737.9139312911175, 5742.799002034909, 5744.253247077853, 5745.683987380734, 5736.971315143398, 5834.03738383179, 5852.473277405054, 5869.941300586939, 5893.9115913260475, 5624.156376543551, 5637.238972738792, 5641.5204707600315, 5650.378458369658, 5658.462446067617, 5707.828765137053, 5708.942910571007, 5736.053551164011, 5742.253507044057, 5759.2512973313205, 5360.946390536044, 5413.052715774645, 5468.125099984142, 5522.282103326542, 5531.778728850801, 5526.834194974157, 5527.917081243704, 5529.060059789926, 5530.364008138955, 5532.30846144232, 5363.436839131835, 5417.620766546304, 5431.646942948696, 5433.293671822637, 5485.533729632866, 5598.720063996702, 5643.802466913638, 5649.71751412436, 5727.799527016535, 5729.627574207663, 5535.418781027934, 5543.113101903676, 5543.584231182758, 5553.805616803393, 5595.412481689526], "value": 5288.667796310179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.5943158652116, 599.4425184578344, 612.8069658057709, 626.7179769103901, 632.6109442692742, 33913.0, 36379.63620363796, 43759.34360984584, 44345.55654443455, 44385.556144438546, 46052.3092153618, 46596.53403465964, 46676.29985550219, 46688.29967550481, 46718.29922551165, 8990.865137022965, 9168.770780730501, 9172.082791720808, 9172.220361269267, 9176.17414432701, 8298.294644955186, 10543.47282635869, 10857.0, 10867.673969780919, 11190.552377904874, 11007.61473348433, 11098.778024439507, 11100.111991040738, 11105.389203593799, 11108.444577771079, 8403.327733781283, 10587.417692026935, 10793.67618971432, 10857.619983300625, 10858.457077146111, 10758.731031724192, 10777.0, 10837.729056773565, 10842.891571084347, 10857.23999320048, 42281.1543769126, 42394.364084538756, 42458.0, 42720.57279427197, 42807.78596107031, 3411.4200585900207, 3505.8071806050657, 3509.543759311299, 3528.823558822074, 3605.891823245307, 32668.183295417566, 32985.505217421756, 33070.00789976305, 33449.33101337984, 34795.65204347975, 4180.728252663597, 4247.915041699149, 4303.548127446636, 4367.475902891641, 4450.198964186445, 336325.0, 340391.0, 340853.0, 341140.0, 342053.0, 60862.391376086554, 60914.390856091755, 61161.0, 61316.38683613196, 61317.69341153266, 64177.67911160507, 64584.677076615255, 64586.677066614364, 64699.35300646933, 64740.0, 17200.569985750208, 17279.65440691179, 17611.471655850346, 17624.735628965576, 17669.11654417274, 13443.529476468473, 13622.659433514242, 13623.114497557626, 13624.591262262147, 13629.0, 20154.899225503777, 20174.89912550428, 20281.188752449736, 20282.0, 20336.966303369543, 7161.427085833121, 7216.855662886713, 7356.301151390609, 7379.520331178456, 7417.258274172539, 831.6382373667474, 926.5413620258015, 976.414151509103, 1131.6984379791718, 1132.9376884271444, 33847.49228761571, 34169.145771355914, 34403.4839477408, 34483.655163448544, 34753.478697819555, 1105.4307031878589, 1121.4785124916789, 1139.783441146196, 1173.5481839491856, 1248.5630029489605, 17459.301627934994, 17799.288028478717, 17872.463826085237, 17899.552511187325, 17900.462986110437, 531289.0, 534802.0, 536888.0, 538576.0, 538869.0, 61858.381416185264, 62617.0, 62717.68641156856, 62742.0, 62766.37233627697, 1229.5081967213187, 1284.9743005140033, 1308.3915979069589, 1363.6522686714825, 1387.840398354202, 31041.534376983913, 35057.47413788744, 35105.64894351024, 35175.296494069466, 35684.821575892995, 51975.0, 52551.0, 52562.0, 52686.736566316926, 52694.47305526896, 411724.0, 413370.0, 415112.0, 415709.0, 416320.0, 26652.0, 27047.594286086118, 27642.170734877986, 27801.860990694917, 29058.27354316159, 49200.26199606937, 49392.75303623603, 50081.24878126758, 50140.247896282315, 51266.48733512617, 41697.79151104225, 41860.0, 42116.578834211265, 42974.355384668626, 44295.335569965835, 42465.36301955411, 42570.0, 42816.0, 43033.354499681904, 44092.33861492016, 41570.258161926926, 42573.78713106415, 42792.144157117305, 43172.78413607912, 43418.13163736771, 35786.284274313846, 37204.627953721196, 37389.0, 38170.23659526849, 38519.614803852724, 28326.858365708038, 28740.42519149647, 28781.85609071941, 28919.421611568072, 29214.415711686073], "value": 20964.011105890942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9962300376996, 383.859891139734, 384.2066133434458, 397.2392867658434, 399.33909379976114, 17258.568535786613, 20526.38420847377, 20786.06462709178, 20795.480112997182, 20799.792002079976, 18657.25370985159, 18766.906165469154, 19140.808591914076, 19514.512137196576, 19559.70660440091, 5461.590380721442, 5508.7521061552325, 5667.744951477193, 5720.685362305072, 5842.0, 5788.71056447178, 5803.390643982384, 5804.303483581976, 5811.0702287633985, 5831.416858314177, 5436.537894278991, 5728.828135155931, 5730.7707691692285, 5821.53427725781, 5830.562707796911, 5748.770049198027, 5784.942150578482, 5806.622569532967, 5812.738426770806, 5821.825345239628, 5428.212909128154, 5536.446355364472, 5537.723113844291, 5540.778368865241, 5544.417836127229, 13545.59363219105, 13761.724765504734, 14469.565913022627, 22820.429489262737, 22864.199753008565, 2166.8266538677026, 2240.8543444676206, 2357.446000189954, 2408.506256217489, 2766.634940725638, 9104.954475227581, 9520.476373799438, 9602.66390676323, 9923.603055877757, 9969.850452243221, 1897.7532920720357, 1960.1767257751778, 2010.7587089549347, 2077.1379877351033, 2174.2172817785586, 77511.61244193799, 77967.61016194883, 80971.5951420245, 83745.0, 84976.15023849744, 10761.623343182951, 10796.190285728602, 10929.398883061349, 11046.226764126433, 11052.778944421227, 14945.925270373578, 15060.623484412758, 15064.34292227854, 15069.321880515403, 15086.245687715571, 7463.0, 7943.721969731032, 8070.798230044178, 8113.066997295268, 8214.876776848352, 7595.696172153052, 7645.655945482466, 7692.615369231516, 7835.0989636191425, 7859.174786647434, 4642.744649044267, 4674.789634466457, 4702.717836929795, 4717.127331443694, 4804.2073057945745, 1883.736276921232, 1897.3548993342054, 1919.3090487424515, 1922.4424916773978, 1966.606678664273, 903.2773780975193, 951.5575257505293, 956.2636769687302, 973.4110862927968, 993.4883534979491, 18651.90674046621, 19269.22923083061, 20141.367485478422, 20208.191672333236, 20550.794492055185, 984.2519685039422, 999.48526508848, 1044.7805960748328, 1049.6903413493037, 1052.563186277686, 10376.584936602603, 11177.49701263445, 11200.663980080612, 11260.887391125983, 11278.7180320491, 393597.0, 395203.0, 421114.0, 428604.0, 432621.0, 67829.0, 87098.0, 89843.10156898478, 92283.0, 92541.0, 914.154407173362, 968.1431932739576, 1019.108280254777, 1054.7415883108688, 1055.2665897201525, 16745.497635070966, 18125.728114078564, 18321.26714931441, 18321.541961451072, 18670.0, 40656.39015414831, 43011.13977720491, 43069.0, 43151.13697726091, 43519.564804351554, 57859.0, 59091.40908590859, 59427.40572594219, 59453.70273148607, 60132.39867601268, 8622.0, 8793.780155496164, 8816.955915220382, 8856.822863542822, 9044.14080662336, 9234.769130771516, 11573.826392604286, 12918.767899000919, 13898.37457314403, 14683.632909177357, 12201.0, 12479.93760031194, 12542.24746515212, 12700.936495317465, 12706.0, 5951.910721339097, 10376.533056012648, 11599.318098875785, 12490.87509124897, 12935.094543382249, 12524.686882828002, 12592.937035314764, 12899.290539020069, 12948.028897832888, 13200.0, 8886.289096872106, 8947.821043579223, 8990.235829954527, 9003.189712925869, 9266.11971862672, 11664.125190610568, 12333.321667308384, 12505.187162834387, 12531.0, 12617.68455788576], "value": 9140.534157235965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.2645002673435, 1410.896028736779, 1469.3461409672695, 1525.5118362124117, 1666.500049985005, 7984.520928744272, 8364.623591938354, 8365.874511882326, 8657.091005444416, 8661.437006594568, 8318.37612179086, 8546.059933407336, 8561.0, 8566.186212309836, 8573.0, 2023.4132101690493, 2099.8530102892805, 2103.5687684024815, 2364.5507353602848, 2398.556267090585, 2346.495503466754, 2423.6485709572103, 2425.4906469641396, 2441.523902838947, 2447.2535876557645, 2324.081987614891, 2360.221127028077, 2377.8454400464, 2381.285614315707, 2394.4971555973266, 2002.2291417804104, 2280.1905323610044, 2321.8839058047115, 2330.93007209784, 2332.4518738096535, 2332.6384410416413, 2373.4659701567184, 2376.524695060995, 2377.5601513719844, 2378.322178179211, 8165.0, 8209.09699933007, 8221.342292616577, 8221.342292616577, 8224.62989165489, 5059.6458247922665, 5192.1692529195525, 5213.0, 5219.660722053092, 5223.190405487156, 3175.5077962915784, 3322.966770332314, 3453.637368076341, 3500.1949551603275, 3514.1566024154017, 1164.615676826645, 1171.3440473334874, 1177.6172743858194, 1197.6826141072622, 1199.8440202773584, 11897.0, 11897.226680265756, 11897.226680265756, 11902.464389102512, 11903.345316007617, 4432.756198409054, 4568.88577785558, 4671.18254305502, 4675.976620116878, 4688.882777930511, 10014.649487268056, 10016.449095299828, 10023.0, 10025.348352357074, 10029.097381235724, 5224.764885580158, 5228.398734145546, 5229.215617657382, 5233.476652334813, 5234.581233501311, 4117.938230926538, 4635.95364046362, 4687.320338550891, 4799.9760001199775, 4802.591779698695, 3895.0, 3923.862664806718, 3997.740146890501, 4019.6382325590253, 4039.6162364575316, 1253.9184952978028, 1257.1200159888115, 1259.924404535731, 1274.471094495774, 1280.9871901281053, 918.7519369770125, 927.5872236854669, 990.1039559198937, 990.5592011554933, 1005.7737009172878, 5888.411158884077, 6024.57827952048, 6087.939120608826, 6118.938810611926, 6257.5932564383165, 934.63082082577, 945.6028468043438, 956.789506308611, 974.3910056214866, 979.9657012004689, 3818.961810381916, 3985.720999530005, 3991.940120898189, 4003.719739618257, 4025.5571887092397, 10313.27807053499, 10446.68659940203, 10675.466226688635, 10715.83926241107, 10731.926807319205, 10545.57817687284, 10620.575176992988, 10679.83980240297, 10698.465076746288, 10700.89299106999, 7545.547267164097, 7933.603319833986, 8081.6363263653275, 8081.757547273592, 8088.0, 6010.278766548042, 6158.815235542941, 6177.0, 6190.290796921261, 6312.842178945563, 9762.170215531476, 9816.65641702537, 9914.553845076845, 9932.155766759906, 9934.0, 9606.711798646053, 9853.901460985586, 10009.099181073738, 10028.24788140907, 10028.548715307974, 6631.204255489372, 7354.0, 7464.925350746423, 7531.623418829146, 7643.044619422572, 8401.03388110375, 8421.831563368822, 8456.492610443393, 8475.915240847513, 8508.74473765788, 7490.775276741707, 7628.351590114902, 7653.387728981556, 7767.184445633353, 7837.843243135219, 7368.410527157922, 7544.849103017799, 7579.355754760907, 7654.8086297843, 7666.769996900102, 6926.480513961373, 6964.79105626832, 6971.5468494547695, 6977.302269772982, 6981.0924579804305, 4690.742009189527, 4874.878128046827, 4878.559881852909, 4974.502549744997, 4984.42679091909, 4900.828471003498, 4978.502149784992, 4993.80024799004, 5027.748612569284, 5089.847304580869], "value": 4574.117087159109, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.86632747918384, 320.6184640278069, 326.83494835108297, 328.412142265345, 331.4034737472549, 5435.347758269003, 5436.72816359182, 5445.48267914548, 5459.3994660587305, 5528.585356098293, 5080.669756465836, 5123.871903202422, 5248.186531087678, 5280.392754833195, 5384.461553844613, 4128.091819799639, 4153.937690934638, 4166.208420400129, 4167.499500299811, 4219.831206751734, 4167.291560434734, 4171.916561668765, 4186.853460128896, 4189.497260328765, 4202.9405591260365, 3860.8803447000478, 3931.6854651627946, 4033.5159780826343, 4078.185207582627, 4146.709730318879, 4115.279826030448, 4121.876343709679, 4135.400366946806, 4145.631941459311, 4182.728122672047, 3630.8366123524506, 3656.8720094796554, 3661.121330880596, 3666.0285024468535, 3682.705383569308, 5076.400933705871, 5093.0, 5172.629253247892, 5201.193814958688, 5202.141646628302, 4698.506656801055, 4704.906316689075, 4705.12955103307, 4741.881452963669, 4745.311929770199, 5525.585581081435, 5528.668279903219, 5543.6396634218645, 5556.91664625031, 5569.498745112959, 3871.2838124946693, 4017.879463616096, 4025.657819085381, 4026.617471340218, 4054.2296963576828, 5693.430656934273, 5713.542916566665, 5738.4835364816945, 5754.223179870748, 5771.769129234825, 4088.5911408858874, 4089.3457046872954, 4095.365218391154, 4119.299719047769, 4124.278251306009, 4045.069633984141, 4085.119990406756, 4144.834206631761, 4169.708120431601, 4173.207090652766, 4709.293605959065, 4716.976415117971, 4725.149473094807, 4731.148393289172, 4738.763061846894, 5539.8892022160135, 5569.136783798518, 5585.854899745624, 5600.327960644668, 5603.187537806995, 1359.8572149924314, 1366.8154799102192, 1410.3723842889815, 1432.1908121911088, 1441.2865631512468, 966.6278482784179, 994.3188915592842, 997.8553109799038, 1004.924630652704, 1009.4700282351678, 5056.0, 5314.591633217201, 5315.468453154654, 5319.707416092152, 5343.812966546152, 5643.802466913638, 5655.915161272585, 5663.235463212496, 5667.886642267132, 5687.544996400278, 5191.532762051434, 5316.0, 5316.7075810830775, 5321.521063104339, 5322.4411436799355, 2988.506896362076, 2998.0, 3012.8493575321145, 3014.216303760994, 3015.62304711911, 5780.248567686258, 5780.971095144498, 5786.508146807484, 5796.348040808433, 5810.767569297265, 5527.44725527444, 5745.942540574624, 5753.993051216021, 5896.557758168069, 5898.0, 5924.703764811742, 5943.791967281211, 5944.5838791284195, 5955.7617695292565, 5956.195913551702, 5500.80747173847, 5747.655140691572, 5749.166370876116, 5772.855678608068, 5778.27771528559, 5623.578231632726, 5719.3136823581435, 5744.741486633028, 5766.3080430346945, 5767.480926716616, 5902.9964905966945, 5917.378675239038, 5920.348761636303, 5993.741314324041, 5995.940040599713, 4007.6793856491995, 4088.529819070845, 4093.7748423836974, 4103.0, 4111.321631930698, 5782.17861373666, 5789.0, 5810.302763668386, 5811.389804070512, 5826.213461182686, 5319.840404787863, 5415.241866138823, 5536.861578460571, 5628.367773345684, 5709.914351284817, 5617.578681598979, 5646.71766411686, 5648.689322087161, 5659.801906933238, 5673.9432605675065, 5255.448177941261, 5506.421825708243, 5536.7231638417115, 5556.694381809039, 5559.471850174227, 5645.092777219817, 5675.318961724454, 5693.975084484832, 5721.768510280911, 5721.885562288814, 5445.863853403696, 5481.808136715196, 5508.14623733322, 5525.668459892419, 5540.667559946416], "value": 4255.28346593539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.9861602767947, 753.0361137743687, 769.6882762481197, 781.7029528779063, 791.5448617045199, 14833.332500037497, 16123.596910077255, 16143.273552690127, 16414.0, 16918.830811691878, 15953.84046159538, 15963.361465541364, 16129.112898790561, 16141.273642686077, 16169.757453638205, 676.5365724478723, 792.6076592086926, 792.627465091409, 801.6472751989136, 803.7267329108131, 793.4921650143883, 796.2913007423398, 797.5573556676071, 798.317438590003, 800.2797482265978, 836.3016880904452, 842.5660784695887, 842.9873551896695, 843.28320927212, 843.6878355008624, 705.9047028651144, 813.9837203255961, 838.786109542069, 841.5707988925661, 842.0148426341165, 610.9816705498843, 616.0820377637333, 616.4236438929615, 616.6146158650844, 616.907463880417, 15179.696406071816, 15196.848031519654, 15253.694926101527, 15261.465848695243, 15268.847311526964, 13650.658733531642, 14105.2242126683, 14112.294385280798, 14124.505642302573, 14335.42658293667, 13295.667608309774, 13308.401121949535, 13498.59504214875, 13545.45818167272, 13569.118007329591, 4501.842435514741, 4522.253828118356, 4528.569785870337, 4575.748333841638, 4698.812047518095, 75780.24219757787, 77635.61182194053, 77668.22331776666, 78064.21935780626, 78131.60934195292, 11066.39134847591, 11242.156838237, 11325.743591790353, 11356.772864542663, 11373.829392559119, 20659.793402066087, 20686.275980340615, 20691.27580534674, 20694.793052069286, 20704.171833126507, 8482.151784821468, 8510.148985101565, 8524.70163544273, 8667.046624871258, 8797.604107815163, 4795.808167673324, 4834.685745426606, 4912.937801330813, 5027.396712394463, 5261.105612045885, 3635.7454978151804, 3758.628100743209, 3769.264993326275, 3795.4876091727265, 3802.372608519563, 643.9066335381438, 647.3138473218404, 683.6205905722372, 684.5003147702205, 686.6532401137393, 632.1006217139867, 633.6831584207896, 739.4786675393834, 750.3734381791265, 763.7823220382276, 9321.72034838956, 9440.622375105057, 9558.28312876537, 9829.31194816356, 9950.80098398028, 722.4762047515615, 732.5641243460133, 735.7719107076823, 740.489062546841, 741.7478057460489, 4531.229690952546, 4827.348307978448, 4841.392360938256, 4922.704637721748, 4957.702537847741, 111930.44034779775, 113698.0, 113950.0, 115248.42375788068, 117399.41300293444, 85147.5742621283, 99465.50267248762, 99514.0, 99569.50215249023, 100426.49786751166, 83168.58415707883, 84496.57751711326, 84749.0, 85061.57469212738, 87070.56464717763, 8833.29333653319, 9155.86266205994, 9205.86191207119, 9342.299327550325, 9402.38884472507, 51164.0, 51688.22467662913, 52230.47769522256, 52775.47224527706, 53782.19326710181, 43340.0, 49127.0, 67924.6603766978, 74907.62546187235, 75864.24135758572, 11924.463399147233, 12071.614802772025, 12075.335856527623, 12120.393980300772, 12285.69285767863, 13480.988925830407, 13593.320333983063, 13657.726845463234, 14075.859241407865, 14676.77984830207, 12822.679433013876, 12969.740605188032, 13208.405621747237, 13328.600141995756, 13656.112352697042, 12848.164869283466, 12924.462061719081, 13399.933000335326, 13449.394777234853, 13457.798133027816, 12861.807072894102, 12932.55422402679, 12997.338276769335, 13013.0, 13783.0, 10641.414722190353, 10947.890521094687, 10968.122550195805, 11157.386343750846, 11168.385738784445, 11114.0, 11187.0, 11252.943735281271, 11419.200655954335, 11523.654290371302], "value": 7557.461058770792, "unit": "score"}], "name": "dromaeo_css", "value": 7281.851473699617, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0, 113.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 126.0, 193.0, 127.0, 128.0, 155.0, 124.0, 162.0, 126.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 162.0, 160.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 129.0, 76.0, 77.0, 75.0, 74.0, 98.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 85.0, 87.0, 86.0, 123.0, 84.0, 86.0, 122.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 80.0, 80.0, 81.0, 81.0, 81.0, 81.0, 145.0, 81.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 122.0, 118.0, 120.0, 120.0, 125.0, 123.0, 124.0, 121.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 169.0, 159.0, 160.0, 168.0, 163.0, 162.0, 161.0, 159.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 66.0, 64.0, 65.0, 63.0, 63.0, 65.0, 62.0, 63.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1503.6, "alertThreshold": 2.0}]} 19:53:23 INFO - Return code: 0 19:53:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:23 INFO - # TBPL SUCCESS # 19:53:23 INFO - Running post-action listener: _resource_record_post_action 19:53:23 INFO - ##### 19:53:23 INFO - ##### Finished run-tests step (success) 19:53:23 INFO - ##### 19:53:23 INFO - Running post-run listener: _resource_record_post_run 19:53:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 554627072; Read time: 0; Write time: 449236 19:53:23 INFO - TinderboxPrint: CPU usage
13.1% 19:53:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:53:23 INFO - TinderboxPrint: I/O write bytes / time
554,627,072 / 449,236 19:53:23 INFO - TinderboxPrint: CPU idle
8,270.7 (86.9%) 19:53:23 INFO - TinderboxPrint: CPU user
1,207.8 (12.7%) 19:53:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245792768; Read time: 0; Write time: 225592 19:53:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290983936; Read time: 0; Write time: 221420 19:53:23 INFO - Running post-run listener: _upload_blobber_files 19:53:23 INFO - Blob upload gear active. 19:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:23 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:53:23 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:53:23 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:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:25 INFO - (blobuploader) - INFO - Done attempting. 19:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:25 INFO - (blobuploader) - INFO - Done attempting. 19:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:29 INFO - (blobuploader) - INFO - Done attempting. 19:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:29 INFO - Return code: 0 19:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ef18df33db92bca72b5caf180793bf64f7c93217fd5e84ea2f1cff51f926aebc3a83582d135bbb1c9189905c0a511942d944d04887b2d40f9baf2e39ec6c270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bae1775227d781e482941ba5c5b94bc0e32b6f902baab318d0c5c09408b1e7c239acd26359e88504d7a90d3f8789236efd54f6af74714f80cb98e767cb7e3c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02be7881f54f8ba16b022b9acf4d7843b3ea616a72bf4541ef9ef1cee95bdd5dca9edaaf2084358871a6e56033d8c503d3c7724e53282a00e648ed95b7c338a6"} 19:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:29 INFO - Contents: 19:53:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ef18df33db92bca72b5caf180793bf64f7c93217fd5e84ea2f1cff51f926aebc3a83582d135bbb1c9189905c0a511942d944d04887b2d40f9baf2e39ec6c270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bae1775227d781e482941ba5c5b94bc0e32b6f902baab318d0c5c09408b1e7c239acd26359e88504d7a90d3f8789236efd54f6af74714f80cb98e767cb7e3c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02be7881f54f8ba16b022b9acf4d7843b3ea616a72bf4541ef9ef1cee95bdd5dca9edaaf2084358871a6e56033d8c503d3c7724e53282a00e648ed95b7c338a6"} 19:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:29 INFO - Copying logs to upload dir... 19:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.735960 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 19:53:29.234353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:53:29.237470) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ef18df33db92bca72b5caf180793bf64f7c93217fd5e84ea2f1cff51f926aebc3a83582d135bbb1c9189905c0a511942d944d04887b2d40f9baf2e39ec6c270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bae1775227d781e482941ba5c5b94bc0e32b6f902baab318d0c5c09408b1e7c239acd26359e88504d7a90d3f8789236efd54f6af74714f80cb98e767cb7e3c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02be7881f54f8ba16b022b9acf4d7843b3ea616a72bf4541ef9ef1cee95bdd5dca9edaaf2084358871a6e56033d8c503d3c7724e53282a00e648ed95b7c338a6"} build_url:https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ef18df33db92bca72b5caf180793bf64f7c93217fd5e84ea2f1cff51f926aebc3a83582d135bbb1c9189905c0a511942d944d04887b2d40f9baf2e39ec6c270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bae1775227d781e482941ba5c5b94bc0e32b6f902baab318d0c5c09408b1e7c239acd26359e88504d7a90d3f8789236efd54f6af74714f80cb98e767cb7e3c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02be7881f54f8ba16b022b9acf4d7843b3ea616a72bf4541ef9ef1cee95bdd5dca9edaaf2084358871a6e56033d8c503d3c7724e53282a00e648ed95b7c338a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:53:29.263595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:53:29.263906) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467081163.823179-1175526168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:53:29.316094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:53:29.316412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:53:29.316702) ========= ========= Total master_lag: 0.63 =========