builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1466518110.81 results: success (0) buildid: 20160621043056 builduid: c2a104d8394c4e4ca2ee0a4e30175ddd revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:30.810416) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:30.810849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:30.811126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:30.876310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:30.876597) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 07:08:31-- 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% 38.0M=0s 2016-06-21 07:08:31 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.005795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.006075) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.054851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.055167) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --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=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 07:08:31,217 truncating revision to first 12 chars 2016-06-21 07:08:31,217 Setting DEBUG logging. 2016-06-21 07:08:31,217 attempt 1/10 2016-06-21 07:08:31,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ffa18cfc8b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 07:08:31,538 unpacking tar archive at: mozilla-central-0ffa18cfc8b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656204 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.724354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.724653) ========= script_repo_revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.725034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.725321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:08:31.770532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 07:08:31.770898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:32 INFO - MultiFileLogger online at 20160621 07:08:32 in /builds/slave/test 07:08:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:32 INFO - {'append_to_log': False, 07:08:32 INFO - 'base_work_dir': '/builds/slave/test', 07:08:32 INFO - 'blob_upload_branch': 'Firefox', 07:08:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:32 INFO - 'branch': 'Firefox', 07:08:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:32 INFO - 'config_files': ('talos/linux_config.py',), 07:08:32 INFO - 'default_actions': ('clobber', 07:08:32 INFO - 'read-buildbot-config', 07:08:32 INFO - 'download-and-extract', 07:08:32 INFO - 'populate-webroot', 07:08:32 INFO - 'create-virtualenv', 07:08:32 INFO - 'install', 07:08:32 INFO - 'run-tests'), 07:08:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:32 INFO - 'download_minidump_stackwalk': True, 07:08:32 INFO - 'download_symbols': 'ondemand', 07:08:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:32 INFO - 'installer_path': 'installer.exe', 07:08:32 INFO - 'log_level': 'info', 07:08:32 INFO - 'log_name': 'talos', 07:08:32 INFO - 'log_to_console': True, 07:08:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:32 INFO - 'opt_config_files': (), 07:08:32 INFO - 'pip_index': False, 07:08:32 INFO - 'sps_profile': False, 07:08:32 INFO - 'sps_profile_interval': 0, 07:08:32 INFO - 'suite': 'dromaeojs', 07:08:32 INFO - 'system_bits': '32', 07:08:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:32 INFO - 'title': 'talos-linux64-ix-015', 07:08:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:32 INFO - 'use_talos_json': True, 07:08:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:32 INFO - 'work_dir': 'build'} 07:08:32 INFO - ##### 07:08:32 INFO - ##### Running clobber step. 07:08:32 INFO - ##### 07:08:32 INFO - Running pre-action listener: _resource_record_pre_action 07:08:32 INFO - Running main action method: clobber 07:08:32 INFO - rmtree: /builds/slave/test/build 07:08:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:33 INFO - Running post-action listener: _resource_record_post_action 07:08:33 INFO - ##### 07:08:33 INFO - ##### Finished clobber step (success) 07:08:33 INFO - ##### 07:08:33 INFO - ##### 07:08:33 INFO - ##### Running read-buildbot-config step. 07:08:33 INFO - ##### 07:08:33 INFO - Running pre-action listener: _resource_record_pre_action 07:08:33 INFO - Running main action method: read_buildbot_config 07:08:33 INFO - Using buildbot properties: 07:08:33 INFO - { 07:08:33 INFO - "project": "", 07:08:33 INFO - "product": "firefox", 07:08:33 INFO - "script_repo_revision": "production", 07:08:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:08:33 INFO - "repository": "", 07:08:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:08:33 INFO - "buildid": "20160621043056", 07:08:33 INFO - "pgo_build": "True", 07:08:33 INFO - "basedir": "/builds/slave/test", 07:08:33 INFO - "buildnumber": 788, 07:08:33 INFO - "slavename": "talos-linux64-ix-015", 07:08:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:08:33 INFO - "platform": "ubuntu64_hw", 07:08:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:33 INFO - "branch": "mozilla-central", 07:08:33 INFO - "repo_path": "mozilla-central", 07:08:33 INFO - "revision": "0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1", 07:08:33 INFO - "stage_platform": "linux64-pgo", 07:08:33 INFO - "builduid": "c2a104d8394c4e4ca2ee0a4e30175ddd", 07:08:33 INFO - "slavebuilddir": "test" 07:08:33 INFO - } 07:08:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:08:33 INFO - Running post-action listener: _resource_record_post_action 07:08:33 INFO - ##### 07:08:33 INFO - ##### Finished read-buildbot-config step (success) 07:08:33 INFO - ##### 07:08:33 INFO - ##### 07:08:33 INFO - ##### Running download-and-extract step. 07:08:33 INFO - ##### 07:08:33 INFO - Running pre-action listener: _resource_record_pre_action 07:08:33 INFO - Running main action method: download_and_extract 07:08:33 INFO - mkdir: /builds/slave/test/build/tests 07:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:33 INFO - https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:34 INFO - Downloaded 1361 bytes. 07:08:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:34 INFO - Using the following test package requirements: 07:08:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'jsshell-linux-x86_64.zip'], 07:08:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:34 INFO - https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:35 INFO - Downloaded 24225379 bytes. 07:08:35 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'] 07:08:35 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 07:08:36 INFO - Return code: 0 07:08:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:44 INFO - Downloaded 24225379 bytes. 07:08:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:45 INFO - Return code: 0 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:46 INFO - Downloaded 14405384 bytes. 07:08:46 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'] 07:08:46 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 07:08:46 INFO - Return code: 0 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJs5gvUOQhShHVBysDJJZg/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 07:08:49 INFO - Downloaded 60115881 bytes. 07:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:49 INFO - mkdir: /builds/slave/test/properties 07:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:49 INFO - Contents: 07:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:49 INFO - Running post-action listener: _resource_record_post_action 07:08:49 INFO - Running post-action listener: set_extra_try_arguments 07:08:49 INFO - ##### 07:08:49 INFO - ##### Finished download-and-extract step (success) 07:08:49 INFO - ##### 07:08:49 INFO - ##### 07:08:49 INFO - ##### Running populate-webroot step. 07:08:49 INFO - ##### 07:08:49 INFO - Running pre-action listener: _resource_record_pre_action 07:08:49 INFO - Running main action method: populate_webroot 07:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:49 INFO - '--tppagecycles', 07:08:49 INFO - '7'], 07:08:49 INFO - 'tests': ['tsvgm']}}, 07:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['damp', 'tps']}, 07:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['damp', 'tps']}, 07:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['dromaeo_dom']}, 07:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['basic_compositor_video']}, 07:08:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore', 07:08:49 INFO - 'tabpaint']}, 07:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['tsvgx', 07:08:49 INFO - 'tsvgr_opacity', 07:08:49 INFO - 'tart', 07:08:49 INFO - 'tscrollx', 07:08:49 INFO - 'cart']}, 07:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:49 INFO - 'tsvgr_opacity', 07:08:49 INFO - 'tart', 07:08:49 INFO - 'tscrollx', 07:08:49 INFO - 'cart']}, 07:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--disable-e10s'], 07:08:49 INFO - 'tests': ['tp5o']}, 07:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['tp5o']}, 07:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--disable-e10s', 07:08:49 INFO - '--xperf_path', 07:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:49 INFO - 'tests': ['tp5n']}, 07:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--xperf_path', 07:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:49 INFO - 'tests': ['tp5n']}}, 07:08:49 INFO - 'talos.zip': {'path': '', 07:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:49 INFO - Running post-action listener: _resource_record_post_action 07:08:49 INFO - ##### 07:08:49 INFO - ##### Finished populate-webroot step (success) 07:08:49 INFO - ##### 07:08:49 INFO - ##### 07:08:49 INFO - ##### Running create-virtualenv step. 07:08:49 INFO - ##### 07:08:49 INFO - Running pre-action listener: _resource_record_pre_action 07:08:49 INFO - Running main action method: create_virtualenv 07:08:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:50 INFO - Using real prefix '/usr' 07:08:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:52 INFO - Installing pip.................done. 07:08:52 INFO - Return code: 0 07:08:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:08:52 INFO - Using env: {'DISPLAY': ':0', 07:08:52 INFO - 'HOME': '/home/cltbld', 07:08:52 INFO - 'LANG': 'en_US.UTF-8', 07:08:52 INFO - 'LANGUAGE': 'en_US:en', 07:08:52 INFO - 'LOGNAME': 'cltbld', 07:08:52 INFO - 'MAIL': '/var/mail/cltbld', 07:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:52 INFO - 'MOZ_NO_REMOTE': '1', 07:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:52 INFO - 'NO_EM_RESTART': '1', 07:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:52 INFO - 'PWD': '/builds/slave/test', 07:08:52 INFO - 'SHELL': '/bin/bash', 07:08:52 INFO - 'SHLVL': '1', 07:08:52 INFO - 'TERM': 'linux', 07:08:52 INFO - 'TMOUT': '86400', 07:08:52 INFO - 'USER': 'cltbld', 07:08:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:52 INFO - '_': '/tools/buildbot/bin/python'} 07:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 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 07:08:52 INFO - Cleaning up... 07:08:52 INFO - Return code: 0 07:08:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:08:52 INFO - Using env: {'DISPLAY': ':0', 07:08:52 INFO - 'HOME': '/home/cltbld', 07:08:52 INFO - 'LANG': 'en_US.UTF-8', 07:08:52 INFO - 'LANGUAGE': 'en_US:en', 07:08:52 INFO - 'LOGNAME': 'cltbld', 07:08:52 INFO - 'MAIL': '/var/mail/cltbld', 07:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:52 INFO - 'MOZ_NO_REMOTE': '1', 07:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:52 INFO - 'NO_EM_RESTART': '1', 07:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:52 INFO - 'PWD': '/builds/slave/test', 07:08:52 INFO - 'SHELL': '/bin/bash', 07:08:52 INFO - 'SHLVL': '1', 07:08:52 INFO - 'TERM': 'linux', 07:08:52 INFO - 'TMOUT': '86400', 07:08:52 INFO - 'USER': 'cltbld', 07:08:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:52 INFO - '_': '/tools/buildbot/bin/python'} 07:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 INFO - Downloading/unpacking psutil>=3.1.1 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:52 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 07:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:54 INFO - Installing collected packages: psutil 07:08:54 INFO - Running setup.py install for psutil 07:08:54 INFO - building 'psutil._psutil_linux' extension 07:08:54 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 07:08:55 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 07:08:55 INFO - building 'psutil._psutil_posix' extension 07:08:55 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 07:08:55 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 07:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:55 INFO - Successfully installed psutil 07:08:55 INFO - Cleaning up... 07:08:55 INFO - Return code: 0 07:08:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:55 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:08:55 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 07:08:55 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 07:08:55 INFO - Using env: {'DISPLAY': ':0', 07:08:55 INFO - 'HOME': '/home/cltbld', 07:08:55 INFO - 'LANG': 'en_US.UTF-8', 07:08:55 INFO - 'LANGUAGE': 'en_US:en', 07:08:55 INFO - 'LOGNAME': 'cltbld', 07:08:55 INFO - 'MAIL': '/var/mail/cltbld', 07:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:55 INFO - 'MOZ_NO_REMOTE': '1', 07:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:55 INFO - 'NO_EM_RESTART': '1', 07:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:55 INFO - 'PWD': '/builds/slave/test', 07:08:55 INFO - 'SHELL': '/bin/bash', 07:08:55 INFO - 'SHLVL': '1', 07:08:55 INFO - 'TERM': 'linux', 07:08:55 INFO - 'TMOUT': '86400', 07:08:55 INFO - 'USER': 'cltbld', 07:08:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:55 INFO - '_': '/tools/buildbot/bin/python'} 07:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:08:57 INFO - Installing collected packages: mozsystemmonitor 07:08:57 INFO - Running setup.py install for mozsystemmonitor 07:08:57 INFO - Successfully installed mozsystemmonitor 07:08:57 INFO - Cleaning up... 07:08:57 INFO - Return code: 0 07:08:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:08:57 INFO - Using env: {'DISPLAY': ':0', 07:08:57 INFO - 'HOME': '/home/cltbld', 07:08:57 INFO - 'LANG': 'en_US.UTF-8', 07:08:57 INFO - 'LANGUAGE': 'en_US:en', 07:08:57 INFO - 'LOGNAME': 'cltbld', 07:08:57 INFO - 'MAIL': '/var/mail/cltbld', 07:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:57 INFO - 'MOZ_NO_REMOTE': '1', 07:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:57 INFO - 'NO_EM_RESTART': '1', 07:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:57 INFO - 'PWD': '/builds/slave/test', 07:08:57 INFO - 'SHELL': '/bin/bash', 07:08:57 INFO - 'SHLVL': '1', 07:08:57 INFO - 'TERM': 'linux', 07:08:57 INFO - 'TMOUT': '86400', 07:08:57 INFO - 'USER': 'cltbld', 07:08:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:57 INFO - '_': '/tools/buildbot/bin/python'} 07:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:00 INFO - warning: no files found matching '*.txt' 07:09:00 INFO - no previously-included directories found matching 'build' 07:09:00 INFO - no previously-included directories found matching 'dist' 07:09:00 INFO - no previously-included directories found matching '.git*' 07:09:00 INFO - Installing collected packages: jsonschema, functools32 07:09:00 INFO - Running setup.py install for functools32 07:09:00 INFO - warning: no files found matching '*.txt' 07:09:00 INFO - no previously-included directories found matching 'build' 07:09:00 INFO - no previously-included directories found matching 'dist' 07:09:00 INFO - no previously-included directories found matching '.git*' 07:09:00 INFO - Successfully installed jsonschema functools32 07:09:00 INFO - Cleaning up... 07:09:00 INFO - Return code: 0 07:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:00 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:00 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 07:09:00 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 07:09:00 INFO - Using env: {'DISPLAY': ':0', 07:09:00 INFO - 'HOME': '/home/cltbld', 07:09:00 INFO - 'LANG': 'en_US.UTF-8', 07:09:00 INFO - 'LANGUAGE': 'en_US:en', 07:09:00 INFO - 'LOGNAME': 'cltbld', 07:09:00 INFO - 'MAIL': '/var/mail/cltbld', 07:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:00 INFO - 'MOZ_NO_REMOTE': '1', 07:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:00 INFO - 'NO_EM_RESTART': '1', 07:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:00 INFO - 'PWD': '/builds/slave/test', 07:09:00 INFO - 'SHELL': '/bin/bash', 07:09:00 INFO - 'SHLVL': '1', 07:09:00 INFO - 'TERM': 'linux', 07:09:00 INFO - 'TMOUT': '86400', 07:09:00 INFO - 'USER': 'cltbld', 07:09:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:00 INFO - '_': '/tools/buildbot/bin/python'} 07:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:03 INFO - Downloading docopt-0.6.1.tar.gz 07:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:03 INFO - Running setup.py install for blobuploader 07:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:03 INFO - Running setup.py install for requests 07:09:03 INFO - Running setup.py install for docopt 07:09:03 INFO - Successfully installed blobuploader requests docopt 07:09:03 INFO - Cleaning up... 07:09:03 INFO - Return code: 0 07:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:03 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:03 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 07:09:03 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 07:09:03 INFO - Using env: {'DISPLAY': ':0', 07:09:03 INFO - 'HOME': '/home/cltbld', 07:09:03 INFO - 'LANG': 'en_US.UTF-8', 07:09:03 INFO - 'LANGUAGE': 'en_US:en', 07:09:03 INFO - 'LOGNAME': 'cltbld', 07:09:03 INFO - 'MAIL': '/var/mail/cltbld', 07:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:03 INFO - 'MOZ_NO_REMOTE': '1', 07:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:03 INFO - 'NO_EM_RESTART': '1', 07:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:03 INFO - 'PWD': '/builds/slave/test', 07:09:03 INFO - 'SHELL': '/bin/bash', 07:09:03 INFO - 'SHLVL': '1', 07:09:03 INFO - 'TERM': 'linux', 07:09:03 INFO - 'TMOUT': '86400', 07:09:03 INFO - 'USER': 'cltbld', 07:09:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:03 INFO - '_': '/tools/buildbot/bin/python'} 07:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:04 INFO - Running setup.py (path:/tmp/pip-3OI5Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:04 INFO - Running setup.py (path:/tmp/pip-pQAaNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:04 INFO - Running setup.py (path:/tmp/pip-j85TPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:04 INFO - Running setup.py (path:/tmp/pip-rj_dZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:04 INFO - Running setup.py (path:/tmp/pip-ChqU2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:04 INFO - Running setup.py (path:/tmp/pip-gZ9O_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:04 INFO - Running setup.py (path:/tmp/pip-jovVXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:04 INFO - Running setup.py (path:/tmp/pip-fdO2op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:04 INFO - Running setup.py (path:/tmp/pip-krmgxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:04 INFO - Running setup.py (path:/tmp/pip-e3PuEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:04 INFO - Running setup.py (path:/tmp/pip-TSBNol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:04 INFO - Running setup.py (path:/tmp/pip-MdvAke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:04 INFO - Running setup.py (path:/tmp/pip-SBg8nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:04 INFO - Running setup.py (path:/tmp/pip-ZUwa6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:05 INFO - Running setup.py (path:/tmp/pip-mdCi0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:05 INFO - Running setup.py (path:/tmp/pip-flUBmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:05 INFO - Running setup.py (path:/tmp/pip-vrdoyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:05 INFO - Running setup.py install for manifestparser 07:09:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:05 INFO - Running setup.py install for mozcrash 07:09:05 INFO - Running setup.py install for mozdebug 07:09:05 INFO - Running setup.py install for mozdevice 07:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:05 INFO - Running setup.py install for mozfile 07:09:05 INFO - Running setup.py install for mozhttpd 07:09:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:05 INFO - Running setup.py install for mozinfo 07:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:05 INFO - Running setup.py install for mozInstall 07:09:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Running setup.py install for mozleak 07:09:06 INFO - Running setup.py install for mozlog 07:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Running setup.py install for moznetwork 07:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Running setup.py install for mozprocess 07:09:06 INFO - Running setup.py install for mozprofile 07:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Running setup.py install for mozrunner 07:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:06 INFO - Running setup.py install for mozscreenshot 07:09:06 INFO - Running setup.py install for moztest 07:09:06 INFO - Running setup.py install for mozversion 07:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:07 INFO - Cleaning up... 07:09:07 INFO - Return code: 0 07:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:07 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 07:09:07 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 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:07 INFO - Running setup.py (path:/tmp/pip-Z1xqmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:07 INFO - Running setup.py (path:/tmp/pip-gMLcjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:07 INFO - Running setup.py (path:/tmp/pip-Rliies-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:07 INFO - Running setup.py (path:/tmp/pip-oo0NrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:07 INFO - Running setup.py (path:/tmp/pip-IuAoCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:07 INFO - Running setup.py (path:/tmp/pip-4Zz9rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:07 INFO - Running setup.py (path:/tmp/pip-BTIkSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:07 INFO - Running setup.py (path:/tmp/pip-GXHBhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:07 INFO - Running setup.py (path:/tmp/pip-e29rJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:07 INFO - Running setup.py (path:/tmp/pip-4QsX_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:08 INFO - Running setup.py (path:/tmp/pip-NTVySr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:08 INFO - Running setup.py (path:/tmp/pip-r5Qdl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:08 INFO - Running setup.py (path:/tmp/pip-Iqjr6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:08 INFO - Running setup.py (path:/tmp/pip-NvEmXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:08 INFO - Running setup.py (path:/tmp/pip-HMW1d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:08 INFO - Running setup.py (path:/tmp/pip-UJu8P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:08 INFO - Running setup.py (path:/tmp/pip-aFExYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:10 INFO - Downloading blessings-1.6.tar.gz 07:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:10 INFO - Installing collected packages: blessings 07:09:10 INFO - Running setup.py install for blessings 07:09:10 INFO - Successfully installed blessings 07:09:10 INFO - Cleaning up... 07:09:10 INFO - Return code: 0 07:09:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:10 INFO - Reading from file tmpfile_stdout 07:09:10 INFO - Current package versions: 07:09:10 INFO - argparse == 1.2.1 07:09:10 INFO - blessings == 1.6 07:09:10 INFO - blobuploader == 1.2.4 07:09:10 INFO - docopt == 0.6.1 07:09:10 INFO - functools32 == 3.2.3-2 07:09:10 INFO - jsonschema == 2.5.1 07:09:10 INFO - manifestparser == 1.1 07:09:10 INFO - mozInstall == 1.12 07:09:10 INFO - mozcrash == 0.17 07:09:10 INFO - mozdebug == 0.1 07:09:10 INFO - mozdevice == 0.48 07:09:10 INFO - mozfile == 1.2 07:09:10 INFO - mozhttpd == 0.7 07:09:10 INFO - mozinfo == 0.9 07:09:10 INFO - mozleak == 0.1 07:09:10 INFO - mozlog == 3.2 07:09:10 INFO - moznetwork == 0.27 07:09:10 INFO - mozprocess == 0.22 07:09:10 INFO - mozprofile == 0.28 07:09:10 INFO - mozrunner == 6.11 07:09:10 INFO - mozscreenshot == 0.1 07:09:10 INFO - mozsystemmonitor == 0.3 07:09:10 INFO - moztest == 0.7 07:09:10 INFO - mozversion == 1.4 07:09:10 INFO - psutil == 3.1.1 07:09:10 INFO - requests == 1.2.3 07:09:10 INFO - wsgiref == 0.1.2 07:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:10 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 07:09:10 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 07:09:10 INFO - Using env: {'DISPLAY': ':0', 07:09:10 INFO - 'HOME': '/home/cltbld', 07:09:10 INFO - 'LANG': 'en_US.UTF-8', 07:09:10 INFO - 'LANGUAGE': 'en_US:en', 07:09:10 INFO - 'LOGNAME': 'cltbld', 07:09:10 INFO - 'MAIL': '/var/mail/cltbld', 07:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:10 INFO - 'MOZ_NO_REMOTE': '1', 07:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:10 INFO - 'NO_EM_RESTART': '1', 07:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:10 INFO - 'PWD': '/builds/slave/test', 07:09:10 INFO - 'SHELL': '/bin/bash', 07:09:10 INFO - 'SHLVL': '1', 07:09:10 INFO - 'TERM': 'linux', 07:09:10 INFO - 'TMOUT': '86400', 07:09:10 INFO - 'USER': 'cltbld', 07:09:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:10 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 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)) 07:09:11 INFO - Cleaning up... 07:09:11 INFO - Return code: 0 07:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:11 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')]} 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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')]} 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:11 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 07:09:11 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 07:09:11 INFO - Using env: {'DISPLAY': ':0', 07:09:11 INFO - 'HOME': '/home/cltbld', 07:09:11 INFO - 'LANG': 'en_US.UTF-8', 07:09:11 INFO - 'LANGUAGE': 'en_US:en', 07:09:11 INFO - 'LOGNAME': 'cltbld', 07:09:11 INFO - 'MAIL': '/var/mail/cltbld', 07:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:11 INFO - 'MOZ_NO_REMOTE': '1', 07:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:11 INFO - 'NO_EM_RESTART': '1', 07:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:11 INFO - 'PWD': '/builds/slave/test', 07:09:11 INFO - 'SHELL': '/bin/bash', 07:09:11 INFO - 'SHLVL': '1', 07:09:11 INFO - 'TERM': 'linux', 07:09:11 INFO - 'TMOUT': '86400', 07:09:11 INFO - 'USER': 'cltbld', 07:09:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:11 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:11 INFO - Cleaning up... 07:09:11 INFO - Return code: 0 07:09:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09:11 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')]} 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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')]} 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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 0x7f0b285fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', '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 07:09:11 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 07:09:11 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 07:09:11 INFO - Using env: {'DISPLAY': ':0', 07:09:11 INFO - 'HOME': '/home/cltbld', 07:09:11 INFO - 'LANG': 'en_US.UTF-8', 07:09:11 INFO - 'LANGUAGE': 'en_US:en', 07:09:11 INFO - 'LOGNAME': 'cltbld', 07:09:11 INFO - 'MAIL': '/var/mail/cltbld', 07:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:11 INFO - 'MOZ_NO_REMOTE': '1', 07:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:11 INFO - 'NO_EM_RESTART': '1', 07:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:11 INFO - 'PWD': '/builds/slave/test', 07:09:11 INFO - 'SHELL': '/bin/bash', 07:09:11 INFO - 'SHLVL': '1', 07:09:11 INFO - 'TERM': 'linux', 07:09:11 INFO - 'TMOUT': '86400', 07:09:11 INFO - 'USER': 'cltbld', 07:09:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:11 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 INFO - Downloading/unpacking flake8 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:14 INFO - no previously-included directories found matching 'docs/_build' 07:09:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:14 INFO - Running setup.py install for pep8 07:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:14 INFO - no previously-included directories found matching 'docs/_build' 07:09:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:14 INFO - Cleaning up... 07:09:14 INFO - Return code: 0 07:09:14 INFO - Running post-action listener: _resource_record_post_action 07:09:14 INFO - Running post-action listener: _start_resource_monitoring 07:09:14 INFO - Starting resource monitoring. 07:09:14 INFO - ##### 07:09:14 INFO - ##### Finished create-virtualenv step (success) 07:09:14 INFO - ##### 07:09:14 INFO - ##### 07:09:14 INFO - ##### Running install step. 07:09:14 INFO - ##### 07:09:14 INFO - Running pre-action listener: _resource_record_pre_action 07:09:14 INFO - Running main action method: install 07:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:14 INFO - Reading from file tmpfile_stdout 07:09:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:14 INFO - Reading from file tmpfile_stdout 07:09:14 INFO - Output received: 07:09:14 INFO - Usage: mozinstall [options] installer 07:09:14 INFO - Options: 07:09:14 INFO - -h, --help show this help message and exit 07:09:14 INFO - -d DEST, --destination=DEST 07:09:14 INFO - Directory to install application into. [default: 07:09:14 INFO - "/builds/slave/test"] 07:09:14 INFO - --app=APP Application being installed. [default: firefox] 07:09:14 INFO - mkdir: /builds/slave/test/build/application 07:09:14 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'] 07:09:14 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 07:09:31 INFO - Reading from file tmpfile_stdout 07:09:31 INFO - Output received: 07:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:31 INFO - Running post-action listener: _resource_record_post_action 07:09:31 INFO - ##### 07:09:31 INFO - ##### Finished install step (success) 07:09:31 INFO - ##### 07:09:31 INFO - ##### 07:09:31 INFO - ##### Running run-tests step. 07:09:31 INFO - ##### 07:09:31 INFO - Running pre-action listener: _resource_record_pre_action 07:09:31 INFO - Running main action method: run_tests 07:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:31 INFO - Python 2.7.3 07:09:31 INFO - Return code: 0 07:09:31 INFO - grabbing minidump binary from tooltool 07:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:31 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 0x2cf31c0>, '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 0x2cf40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:31 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 07:09:31 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 07:09:31 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 07:09:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:31 INFO - Return code: 0 07:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:32 INFO - Return code: 0 07:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 07:09:32 INFO - Using env: {'DISPLAY': ':0', 07:09:32 INFO - 'HOME': '/home/cltbld', 07:09:32 INFO - 'LANG': 'en_US.UTF-8', 07:09:32 INFO - 'LANGUAGE': 'en_US:en', 07:09:32 INFO - 'LOGNAME': 'cltbld', 07:09:32 INFO - 'MAIL': '/var/mail/cltbld', 07:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:32 INFO - 'MOZ_NO_REMOTE': '1', 07:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:32 INFO - 'NO_EM_RESTART': '1', 07:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:32 INFO - 'PWD': '/builds/slave/test', 07:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:32 INFO - 'SHELL': '/bin/bash', 07:09:32 INFO - 'SHLVL': '1', 07:09:32 INFO - 'TERM': 'linux', 07:09:32 INFO - 'TMOUT': '86400', 07:09:32 INFO - 'USER': 'cltbld', 07:09:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553', 07:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:32 INFO - '_': '/tools/buildbot/bin/python'} 07:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:09:32 INFO - mozversion application_buildid: 20160621043056 07:09:32 INFO - mozversion application_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 07:09:32 INFO - mozversion application_display_name: Nightly 07:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:32 INFO - mozversion application_name: Firefox 07:09:32 INFO - mozversion application_remotingname: firefox 07:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:32 INFO - mozversion application_vendor: Mozilla 07:09:32 INFO - mozversion application_version: 50.0a1 07:09:32 INFO - mozversion platform_buildid: 20160621043056 07:09:32 INFO - mozversion platform_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 07:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:32 INFO - mozversion platform_version: 50.0a1 07:09:32 INFO - using testdate: 1466518172 07:09:32 INFO - actual date: 1466518172 07:09:32 INFO - starting webserver on 'localhost:41532' 07:09:32 INFO - SUITE-START | Running 2 tests 07:09:32 INFO - TEST-START | dromaeo_css 07:09:32 INFO - operating with platform_type : linux_ 07:09:32 INFO - Initialising browser for dromaeo_css test... 07:09:33 INFO - TEST-INFO | started process 5543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoFle4x/profile http://localhost:41532/getInfo.html) 07:09:37 INFO - PROCESS | 5543 | __metrics Screen width/height:1600/1200 07:09:37 INFO - PROCESS | 5543 | colorDepth:24 07:09:37 INFO - PROCESS | 5543 | Browser inner width/height: 1024/697 07:09:37 INFO - PROCESS | 5543 | __metrics 07:09:38 INFO - PROCESS | 5543 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:38 INFO - PROCESS | 5543 | console.error: PushService: 07:09:38 INFO - PROCESS | 5543 | stateChangeProcessEnqueue: Error transitioning state 07:09:38 INFO - PROCESS | 5543 | UnknownError 07:09:39 INFO - TEST-INFO | 5543: exit 0 07:09:39 INFO - Browser initialized. 07:09:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:39 INFO - TEST-INFO | started process 5626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoFle4x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:51 INFO - PROCESS | 5626 | RSS: Main: 173854720 07:09:51 INFO - PROCESS | 5626 | 07:10:42 INFO - PROCESS | 5626 | 1466518242735 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] 07:12:50 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41532/tests/dromaeo/cssquery-ext.html) 07:12:51 INFO - PROCESS | 5626 | RSS: Main: 266756096 07:12:51 INFO - PROCESS | 5626 | 07:15:53 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-ext.html (next: http://localhost:41532/tests/dromaeo/cssquery-jquery.html) 07:15:54 INFO - PROCESS | 5626 | RSS: Main: 258609152 07:15:54 INFO - PROCESS | 5626 | 07:18:56 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41532/tests/dromaeo/cssquery-mootools.html) 07:18:57 INFO - PROCESS | 5626 | RSS: Main: 259424256 07:18:57 INFO - PROCESS | 5626 | 07:21:59 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41532/tests/dromaeo/cssquery-prototype.html) 07:21:59 INFO - PROCESS | 5626 | RSS: Main: 257339392 07:21:59 INFO - PROCESS | 5626 | 07:25:02 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41532/tests/dromaeo/cssquery-yui.html) 07:25:02 INFO - PROCESS | 5626 | RSS: Main: 237420544 07:25:02 INFO - PROCESS | 5626 | 07:28:05 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-yui.html (next: http://localhost:41532/tests/dromaeo/cssquery-dojo.html) 07:28:06 INFO - PROCESS | 5626 | RSS: Main: 293638144 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | __start_tp_report 07:28:06 INFO - PROCESS | 5626 | _x_x_mozilla_page_load 07:28:06 INFO - PROCESS | 5626 | _x_x_mozilla_page_load_details 07:28:06 INFO - PROCESS | 5626 | |i|pagename|runs| 07:28:06 INFO - PROCESS | 5626 | |0;dojo.html;3070.6008218931534;3085.475469170241;3090.088423914945;3103.8292893890857;3128.7184153426188;5078.822241221558;5167.483251674831;5217.817376391822;5275.1296036154035;5323.494268044535;5202.817901373443;5223.947760522394;5252.606054545905;5264.6051546134;5324.866878328034;4705.458872229695;4725.291206319045;4774.140654682155;4785.1147537705465;4899.828506002291;4812.903741925159;4848.345473361086;4862.63530235232;4865.951340486586;4889.804407823683;4718.952810471886;4750.453697824742;4790.137775200463;4805.231163013901;4879.438864530571;4809.6392770542;4826.903461930777;4827.25177597473;4828.782704778258;4927.852164435073;4821.662483626147;4830.661853670244;4864.708117512925;4865.6594038417325;4899.657024008321;5163.767630456601;5171.7672704728375;5201.713905735183;5208.973955130238;5366.6779993200535;5541.612087153861;5601.943980560183;5602.1596760485845;5632.183333416672;5638.379778224433;5621.241132447109;5648.265725455664;5681.460261275172;5692.316921969349;5710.200571919934;5092.9236061459105;5262.92105618416;5263.315768950012;5268.789248430058;5324.094903866352;5878;5888.998870191992;5894.32215295238;5904.911426328608;5910.881782364415;5340.279062326536;5623.718814059281;5642.605017648725;5647.971760141173;5652.830415087472;5558.194061861008;5628.155776633538;5637.154426835926;5637.3235211774845;5637.548996080303;5632.464915832989;5633.464820842013;5634.154876768517;5643.1535269709875;5643.266375371176;5550.139728342114;5556.888862222733;5653.689047102449;5656.519195868397;5663.546916246691;4350.195213885378;4351.238533256667;4352.151330490524;4369.890752731207;4389.297712366006;3867.207222519377;3879.7672139671145;3888.6500214980224;3891.5135608048995;3911.765294082364;5191.714455704897;5246.029484545371;5270.7628156733035;5370;5408.4050754416985;5599.356074051536;5602.327720673464;5605.691686957257;5624.409437009055;5627.915581266284;5264.868378290496;5274.472552744694;5282.445343238905;5287.180487024518;5348.197770334403;4768.546988036131;4827.42070951488;4849.345338379344;4850.466448690641;4895.6083513318845;5787.479126878601;5817.069268916868;5821.592488525763;5834.124881267844;5835.94164058354;5651.915221271602;5659.943400565941;5660.688662123623;5662.377138514842;5663.405342438985;5678.290213723285;5743.511801496919;5804.21643078179;5815.06958886593;5862.355140934579;5529.032419326521;5536.280283563111;5541.418151094077;5545.667259964415;5545.916811247754;5398.4871437213405;5629.071203251581;5639.7744090237575;5647.774089036392;5648.15277708347;5471.6169868108855;5509.889802204014;5525.972370138124;5530.115181570929;5549.556035517229;5523.861903452445;5526.47498487643;5527.695976721158;5529.944700553104;5539.169124631338;5256.658317209369;5276.551493123127;5371.221172929982;5431.2667789847865;5486.451354864482;5424.213489044146;5557.194206839905;5560.054790685674;5562.16567514876;5565.415631358649;5369.382521010134;5393.946060539344;5395.163749618815;5403.83788486346;5407.729613519387 07:28:06 INFO - PROCESS | 5626 | |1;ext.html;566.5609152906497;603.4900509069836;611.4558043341425;614.4623454477332;627.9544558310413;32268;34712.82643586781;43358.78320608393;43827.78086109565;44104.77947610265;44298.33552496715;44797.328040079425;44848;44914.63140264485;44939.55060449395;8627.396082274243;8732.432391894537;8754.168354006359;8838.867416988718;8844.33667474942;8547.273481754059;8687.695930642429;8687.914010748656;8690.435121717068;8695.434796738191;8712.869306960401;8786.209241168293;8795;8795.428297160664;8795.912040879573;8630.439021463584;8686.3050955924;8702.260307873838;8710.346723995694;8747.475151490898;8671.739847804576;8734.257588105018;8735.43219690718;8740.606672699743;8751.737447876574;40138.79930600357;40772.59227407718;40824.387634185216;40824.79587602043;40852;3367.2928684976187;3467.219875528011;3482.1642805726697;3500.4924285978645;3513.350030244413;28372.432551349062;28471.430571388457;28511.144665660064;28713.425731485462;28980.710192898223;3853.0305739316805;3902.687784977195;3914.4715463412645;3977.920441591181;3991.3613821788663;326721;327084.9999999976;328339.5081172148;328751;329266;33941;54792;54910.72544637251;54918;54982.17526737022;34593.13517162041;35140.715853469446;35141.472877906854;35177.296454070776;35178.47232291518;13692.31538423075;13939;13954.372053257628;13971;13972.790408143886;11454.541818327174;11520.078393728481;11523.135764817673;11533.538658453735;11534.884651153548;8033.919660803317;8149.307308878693;8174.591270436455;8226.383021273428;8235.95882020586;3119.2513796689086;3126.2965832687464;3131.6960606560297;3159.462891308437;3166.4142133705336;968.9321747477609;998.5306905754429;1049.223574554824;1155.5782139519183;1172.3200543684643;31594.210144746106;32446.83776581102;32538.186545336557;32858.50712239318;33255.50116748251;1014.7818219082933;1053.089077947585;1131.4964840645835;1169.5964892112208;1189.7323102301914;16261.674766504604;16646.50060498187;16663.50009499717;16700.916495417445;16787.2445739942;538152;547675;548152;549190;549896;53492.73253633707;54724.726376367864;54785.452145478834;54864.177037344474;54887.45112548823;1194.5699548162654;1274.5284244829472;1323.5698398020681;1329.5147271245926;1346.8653134686454;30934.69065309318;32767;32810.343793124484;33370;33474.66525334716;47853;48117.518824811305;48174.5182548184;48445;48476;380859;382203;382626;385429;385954;25475;26124;27262;27776.305592360353;28351;46393.07213855637;46637;46742.532574673816;47547.76226118847;48004.279935800296;40085.59914400936;40573.39139912845;40658.1868362637;40681.79659101686;41594.37608435936;39393.56182748748;39450.40824387694;40371;40554.39168412535;41340;41228.79385603053;41268.587314126475;41453.79273103615;41638.791806040776;41735.373969389875;34607.30785384329;35579.04269982655;36086.482812390925;36398.8180059098;36773.63226367702;27439.725602743718;28146.36585522837;28269.57595636026;28270.574679389392;28513.144605661862 07:28:06 INFO - PROCESS | 5626 | |2;jquery.html;391.1160776644782;395.73485764537764;399.23944884994097;406.2869663740136;411.2556273145607;14353.641158971031;17960.371387001458;18350.63298734026;19850.106745196448;19954.600907981832;14666.12003279804;18356.35752748654;18762.43712688618;19027.716673999104;19197.712034319495;5585.553155747541;5768.134779783024;5786.942130578704;5804.82585522435;5818.301803783552;4190.937135942963;5746.25298711169;5875.148103524986;6198.101275315076;6524.673766311689;6457.838554036163;6509.2839787623325;6565.934340656604;6576.145101136845;6593.703283352237;6269.090981807635;6453.645049522274;6460.709268082924;6471.805845824632;6484.61092334459;5602.299712535933;5667.093265077568;5676.290463692038;5680;5709.400512946164;21831.672524912137;22222.66666000011;22711.318660440214;22805.31584052481;23001.654975175385;2482.4786794773117;2790.246633408968;3071.078676397094;3086.6758990306143;3097.1792474994145;13188.340582970908;13950.511732089328;14381.928090359586;14389.13665180082;14875.77686334695;1896.868330934543;2018.919243230269;2034.104993802722;2044.2640649366217;2089.39407571804;76187;78805;78924;79559.20440795575;79964.60017699875;10124.443155626364;10430.530626121843;10765.192610554239;10959.671209863716;11235.932586404278;14784.11295322284;14863.851361486246;14941;14945.775813362809;14956.177410242324;7712;7798.571078590732;7819.296263336327;7889.842203155905;7902.130765615778;6869.793906182823;7306.853862922711;7365.852682946418;7425.517341372793;7470.626468676544;6161.784337548164;6630.612979327439;6635.900461493082;6656.434203092791;6718.328167183243;1866.5426970392068;1900.6483800496953;1934.1393080079229;1945.134415185229;1968.7834338222783;992.6128809764198;1016.6936131803186;1060.3372891942536;1091.650671785037;1095.446799366315;18826.05869706509;19260.133294001804;19412.708809367872;19569.315073972626;19775.30786422497;993.9254555908336;1013.6502906497246;1027.7379268286688;1035.3839465518004;1044.185535282481;10776.730581735519;11187.664370068911;11188.832167517494;11342.886571134348;11395.316281023164;474291;477260;479831;494847;500462;78724;80905.59547202344;81387;82126;82201;1015.0914931136591;1017.577705252312;1045.6915210013065;1045.7385653586603;1064.4784055812595;17280;17415.912920435316;17597.208125634632;17633.559161021076;17730.645387092445;30661.386772263984;34120.65879341175;38933.2213355737;39124.21751564896;40854.387184192856;51320;51939;53066;54318;54757.45242547523;8738.388312818295;8825.69110081144;8859.51272679983;8896.733098007071;9062.184403403726;13238;13279.535216267384;13370.398332075274;13621.455141794217;13797.655058623615;11574.594889178838;11789.646310610695;11897.226680265756;12029.518819247482;12205.145639805483;11450.37022963745;11784.76430471403;12064.819027714415;12116.939415302868;12177.391130443619;7781.5331080135375;12217.572384966483;12248.69378265515;12275.93862030684;12294.139410241554;8280.58597070156;8723.258523025614;8959.328050396116;8963.596638151168;9089;11223.831642525205;11271.380074096003;11876.406179690808;11967.820482692592;12312.630621081023 07:28:06 INFO - PROCESS | 5626 | |3;mootools.html;1301.8763217494334;1330.8003799430085;1333.3466601365321;1400.2298735695367;1505.57843803735;8569.357298202629;8973.23727483164;9003.369764116514;9179.357444978854;9188.264938804896;8998;9124.680636177734;9156.633734650623;9160.35877488576;9194.816103677922;2289.473421113145;2311.653252012203;2312.8612283262974;2315.3517015235675;2318.3740390094663;2283.303592404316;2308.8268379871492;2310.214527060799;2310.549442858643;2315.6642286868396;2243.0354947372625;2246.8764217968005;2270.579942710604;2313.0169677886915;2316.027268547206;2197.3517812245427;2220.7224096987875;2235.776422357759;2237.9888100559474;2238.708967834187;2202.6916231727573;2205.8235341172667;2210.4473881529616;2211.237123192496;2212.6459766437456;8545.658173673046;8788.8681669775;9126.17864392208;9182.632694692204;9199.862002069975;5157.174852023696;5277;5281.603879709037;5283.577313814885;5283.788648454057;3334.3831391192707;3338.115399419156;3371.5954085509898;3401.7958922464486;3408.7784294020807;1137.113051819582;1174.3834486894448;1175.8118701007797;1175.8471398718198;1177.1171621284036;12364.938175309066;12473.875261247362;12514.12401131921;12520.874791252061;12524.436400362005;4415.425994620743;4453.131639330364;4553.54464553542;4562.771861406916;4567.246404343313;9550.856737148948;9552.283578731623;9569.904300957041;9570.712878613653;9572.808543829224;5030.044291584587;5036.496350364934;5037.571806396424;5038.118329292359;5038.3198268234055;4113.25961326964;4237.406763053175;4280.079782846703;4373.431453911035;4604.447466303998;3870.7290489666016;3914.8434062637743;3916.7258291919293;4019.577944315863;4044.0698639313123;1175.1832476428972;1206.6199147268583;1211.3277131192096;1215.7386161975041;1226.7669142862828;823.9711610093618;981.906718861707;985.4826216236534;986.921046316293;990.6978371596588;6139.96930015356;6170.969145154246;6176.258848938066;6197.845053873689;6261.092141639528;428.1821720513866;429.9978500107479;439.0910814613719;440.7333563194221;443.7892001299422;4060.1067765091634;4206.768627725443;4252.255855225323;4319.848805291863;4365.563443655609;11217.383043932661;11655.067594592412;11720.70698232551;11749.177557571058;11757.235779674294;11272.380019098864;11565.363904985306;11628;11629.59296424621;11666.300021998708;8548.230659240699;8555.144485551395;8626.48241105523;8651.653933842701;8652.8702069469;6037.154798328325;6118.571699981137;6149.41580549847;6149.96925015372;6292.811215663537;10186.134178594903;10315.690529284133;10579.576816927545;10684.038436540748;10736.89263107359;10195.235357348376;10569.947150264199;10580.576776929145;10704.89295107039;10984;7310.159331676712;7981.48120372174;8165.550894700848;8196.959015204886;8220.219079187467;9100.863487047833;9111.407758495676;9112.088791120836;9140.451572905647;9182.770430739285;7475.588842613708;7787.4548781584745;7910.802229944067;8013.959930200312;8181.836363272821;7639.503432276884;7717.228277172462;7885.250901164381;7926.643301051582;8061.072976607531;7390.29792169743;7423.703051877865;7467.365273951775;7496.58768767723;7556.055493063367;5266.683998960075;5294.385212510221;5394.595405344693;5424.07790675594;5481.780728770805;5343.599230057684;5445.59158063139;5498.1752737089755;5529.115341545334;5589.217509548585 07:28:06 INFO - PROCESS | 5626 | |4;prototype.html;311.565366313992;313.53909752663577;318.01098583405604;319.16856588586734;322.73696936996356;5168.534831865131;5220.399654039787;5220.634555581111;5226.24219488174;5280.128778751511;5140.280360749489;5185.144451165563;5219.817306394277;5225.660332078422;5235.214717792333;3874.2638898609175;4002.8198731057028;4013.4782478277784;4039.8182081806244;4044.251813414513;4094.686502126304;4099.856505022325;4137.586241375869;4151.937720934188;4180.038591124044;4031.5968403159595;4070.3487442009286;4074.9388759168637;4095.7133000689964;4110.07523307255;4003.8598649047144;4019.2363450944517;4053.250148722481;4082.2243773683203;4111.7944102794745;3544.4860495228304;3550.982245088758;3567.965290065878;3587.4260118380935;3595.7842529448317;5057.976809276282;5098.847034588968;5100.285959965608;5141.4832624375895;5165.7158856262895;4460.397846290742;4618.330342100377;4623.722576645412;4627.305904114376;4643.953560464386;5409.540189083893;5414.160805075219;5445.646033007842;5451.609839490904;5468.4611772228955;3923.0580862473257;3935.6457918787446;3942.64516193544;3947.3684210526176;3953.446517487554;5485.9725701371635;5694.9715251423895;5705.800296989627;5719.456651618089;5731.681713205986;4039.636432721069;4046.7976601169826;4048.3725022621543;4057.7159598827798;4084.7957602119777;4135.669146468275;4137.937930931039;4141.4409054777825;4144.3990621359735;4146.647534959562;4616.676832621752;4619.838305659286;4686.7656617169005;4702.88242793926;4741.739204343725;5217.869553261199;5459.50864422196;5477;5479;5491.917621235684;1350.783874580082;1373.3862711314166;1388.3127851713466;1391.8329800424015;1394.42828440341;881.8985816631041;896.9820603587891;899.6086702284397;904.3488688144525;907.6414816147717;5090.694558326438;5190.143626301693;5279.630425870152;5308.601854860901;5358.598105142052;5606.6636001840025;5609.270794796732;5623.184638227516;5640.407757185437;5667;5089.262057001788;5289.814856480005;5320.334958130234;5343.465653434625;5355.892882142335;2942.3379739558427;2961.7926745128066;2975.1966968918273;2987.760979121665;2995.9214682714205;5715.399883012307;5765.567582431335;5779.046457334577;5782.537397008229;5824.796132135355;5467.917981230285;5661.830145095571;5729.312482502043;5758.913616295759;5762.337331206881;5791.971040144772;5824.796132135355;5828.388019258002;5868.4424979626865;5887.587868849139;5313.9468605315;5625.609116125712;5640.661560306395;5648.406917273627;5672.801451949162;5637.46444087811;5640.85897852557;5646.689432081275;5655.208270842003;5680.176374425768;5824.660328124471;5855.209546711139;5878.764849406147;5917.674527900835;5927.140564618193;3920.2159568085926;3990.383894522723;4091.427200192035;4093.6111069448357;4095.7542547447247;5678.119891416837;5738.397468265772;5743.368229494836;5769;5773.8556536086935;5543.750531226024;5654.575906806924;5665.263515742927;5670.971645141748;5691.430856914276;5506.714713393897;5562.443755624405;5566.666000040011;5570.192322113352;5594.552435805044;5261.684298942076;5432.864178395572;5448.427915069019;5451.64564303319;5461.563074954073;5442.537384322377;5506.256655351636;5563.721813909369;5600.467955544217;5626.746796394254;5379.4351593082165;5380.300560927054;5380.865478363072;5384.326959130109;5419.34967803866 07:28:06 INFO - PROCESS | 5626 | |5;yui.html;752.1312883619418;758.0562200060925;815.2947700239295;822.7819627798633;846.9322454203663;13846.169229846204;15113.622159446018;15410.537683869474;15421.460248891291;15465.690686186284;13834.930825345884;14196.929015354935;14210.28948552571;14225.430982760678;14225.857741422582;665.5773583774289;681.2029924987752;782.6243403166484;809.5021561739517;810.5379933437943;809.6558962440969;812.3298278919915;812.5246730662569;815.7919730468752;816.0859836982588;686.3445409633788;869.5130726792985;870.2646263906988;871.3508436215029;872.3718922375879;838.7986883148031;861.9698310559163;862.3532350736916;862.7368652560966;863.5380071661693;629.238621268266;629.4209327418786;629.5813284166024;629.804760524239;629.8929182039019;14582.562523124323;14632.487862924747;14666.413343466249;14667.413303467849;14668.70662586753;13835.79246311306;13920;13982.58052258434;14192.148471091768;14391.280435978264;12400.503979840796;12951.87048129516;12965.675858103528;13003.804942925864;13059.085863989525;4422.867313980586;4444.755538445384;4461.821527138943;4495.190865644183;4697.459792123916;66399.66800166016;66832.33167668262;66978.33021669819;72461.91307130398;72574.63712681456;10905.781884362426;11515.53937842477;11906.404679765978;11943.880561194277;12141.878581214252;18321.90839045823;19262.614747705247;19282;19292;19337.323193688153;8255.298299644477;8445.619947102396;8467.449615774955;8520.488770673779;8672.913270867211;4189.643880270211;4882.170031094723;4931.827386041471;5071.340725705709;5115.820946266937;3549.219171782204;3664.2854643344826;3719.9814000929823;3734.477173195755;3734.477173195755;606.3178923710825;627.2222444169197;634.4607083978674;682.4267615203253;685.9295237151172;651.2640715990995;700.3836623771049;724.0189543169035;770.5107256891802;778.4473024152802;9325.953370233241;9772.31593788428;9936.155426788804;9999.800003999879;10073.546690398949;537.1888448442801;587.4771453406472;641.7304732012566;708.9680964356617;788.8501184774874;4541.613962813198;4563.361129441814;4598.908021839545;4617.2612382018715;4651.697639653412;114087;114470;114854;119475;119788;60451.395486044574;60811.69594152001;62068;99128;99465;92293.5385323069;92550.53724731333;92971;93100;94061;9221.723348299562;9224.400413973339;9303.72088837336;9391.906080939103;9487.529432937905;48121.75939120422;49822.25266621076;50106.49893501018;50647;51641.708957276365;67405.66297168483;74193.62903185449;74478;74799;74921.25078749143;12153.878461215274;12982.610521684364;13010.089293749725;13112;13358;14467.49363772263;15492.380304787683;15801.36794528206;15957;15996.120213388376;12410.193337433038;12758.68103297425;12784.87215127874;13976.091554048955;14347.35436905321;14838.332275047433;14931.402743890558;15121.621959451102;15161.241937903282;15653.765193522335;13815.309234538434;13982.860171398155;14347.713045738818;14826.258687065389;14875.702485950003;11029.172812038969;11204.215704900578;11257.268277561932;11340.432978351215;11968.880311196777;11409.345794392524;11857.881421185677;11866.525338986345;11970.461329240032;12093.697657558632 07:28:06 INFO - PROCESS | 5626 | __end_tp_report 07:28:06 INFO - PROCESS | 5626 | __start_cc_report 07:28:06 INFO - PROCESS | 5626 | _x_x_mozilla_cycle_collect,823 07:28:06 INFO - PROCESS | 5626 | __end_cc_report 07:28:06 INFO - PROCESS | 5626 | __startTimestamp1466519286007__endTimestamp 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | ------- Summary: start ------- 07:28:06 INFO - PROCESS | 5626 | Number of tests: 6 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#0] dojo.html Cycles:165 Average:5236.20 Median:5403.84 stddev:580.95 (10.8%) stddev-sans-first:557.34 07:28:06 INFO - PROCESS | 5626 | Values: 3070.6 3085.5 3090.1 3103.8 3128.7 5078.8 5167.5 5217.8 5275.1 5323.5 5202.8 5223.9 5252.6 5264.6 5324.9 4705.5 4725.3 4774.1 4785.1 4899.8 4812.9 4848.3 4862.6 4866.0 4889.8 4719.0 4750.5 4790.1 4805.2 4879.4 4809.6 4826.9 4827.3 4828.8 4927.9 4821.7 4830.7 4864.7 4865.7 4899.7 5163.8 5171.8 5201.7 5209.0 5366.7 5541.6 5601.9 5602.2 5632.2 5638.4 5621.2 5648.3 5681.5 5692.3 5710.2 5092.9 5262.9 5263.3 5268.8 5324.1 5878.0 5889.0 5894.3 5904.9 5910.9 5340.3 5623.7 5642.6 5648.0 5652.8 5558.2 5628.2 5637.2 5637.3 5637.5 5632.5 5633.5 5634.2 5643.2 5643.3 5550.1 5556.9 5653.7 5656.5 5663.5 4350.2 4351.2 4352.2 4369.9 4389.3 3867.2 3879.8 3888.7 3891.5 3911.8 5191.7 5246.0 5270.8 5370.0 5408.4 5599.4 5602.3 5605.7 5624.4 5627.9 5264.9 5274.5 5282.4 5287.2 5348.2 4768.5 4827.4 4849.3 4850.5 4895.6 5787.5 5817.1 5821.6 5834.1 5835.9 5651.9 5659.9 5660.7 5662.4 5663.4 5678.3 5743.5 5804.2 5815.1 5862.4 5529.0 5536.3 5541.4 5545.7 5545.9 5398.5 5629.1 5639.8 5647.8 5648.2 5471.6 5509.9 5526.0 5530.1 5549.6 5523.9 5526.5 5527.7 5529.9 5539.2 5256.7 5276.6 5371.2 5431.3 5486.5 5424.2 5557.2 5560.1 5562.2 5565.4 5369.4 5393.9 5395.2 5403.8 5407.7 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#1] ext.html Cycles:180 Average:56511.38 Median:21714.16 stddev:114205.95 (526.0%) stddev-sans-first:114449.08 07:28:06 INFO - PROCESS | 5626 | Values: 566.6 603.5 611.5 614.5 628.0 32268.0 34712.8 43358.8 43827.8 44104.8 44298.3 44797.3 44848.0 44914.6 44939.6 8627.4 8732.4 8754.2 8838.9 8844.3 8547.3 8687.7 8687.9 8690.4 8695.4 8712.9 8786.2 8795.0 8795.4 8795.9 8630.4 8686.3 8702.3 8710.3 8747.5 8671.7 8734.3 8735.4 8740.6 8751.7 40138.8 40772.6 40824.4 40824.8 40852.0 3367.3 3467.2 3482.2 3500.5 3513.4 28372.4 28471.4 28511.1 28713.4 28980.7 3853.0 3902.7 3914.5 3977.9 3991.4 326721.0 327085.0 328339.5 328751.0 329266.0 33941.0 54792.0 54910.7 54918.0 54982.2 34593.1 35140.7 35141.5 35177.3 35178.5 13692.3 13939.0 13954.4 13971.0 13972.8 11454.5 11520.1 11523.1 11533.5 11534.9 8033.9 8149.3 8174.6 8226.4 8236.0 3119.3 3126.3 3131.7 3159.5 3166.4 968.9 998.5 1049.2 1155.6 1172.3 31594.2 32446.8 32538.2 32858.5 33255.5 1014.8 1053.1 1131.5 1169.6 1189.7 16261.7 16646.5 16663.5 16700.9 16787.2 538152.0 547675.0 548152.0 549190.0 549896.0 53492.7 54724.7 54785.5 54864.2 54887.5 1194.6 1274.5 1323.6 1329.5 1346.9 30934.7 32767.0 32810.3 33370.0 33474.7 47853.0 48117.5 48174.5 48445.0 48476.0 380859.0 382203.0 382626.0 385429.0 385954.0 25475.0 26124.0 27262.0 27776.3 28351.0 46393.1 46637.0 46742.5 47547.8 48004.3 40085.6 40573.4 40658.2 40681.8 41594.4 39393.6 39450.4 40371.0 40554.4 41340.0 41228.8 41268.6 41453.8 41638.8 41735.4 34607.3 35579.0 36086.5 36398.8 36773.6 27439.7 28146.4 28269.6 28270.6 28513.1 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#2] jquery.html Cycles:180 Average:28376.12 Median:22903.49 stddev:79696.61 (348.0%) stddev-sans-first:79892.47 07:28:06 INFO - PROCESS | 5626 | Values: 391.1 395.7 399.2 406.3 411.3 14353.6 17960.4 18350.6 19850.1 19954.6 14666.1 18356.4 18762.4 19027.7 19197.7 5585.6 5768.1 5786.9 5804.8 5818.3 4190.9 5746.3 5875.1 6198.1 6524.7 6457.8 6509.3 6565.9 6576.1 6593.7 6269.1 6453.6 6460.7 6471.8 6484.6 5602.3 5667.1 5676.3 5680.0 5709.4 21831.7 22222.7 22711.3 22805.3 23001.7 2482.5 2790.2 3071.1 3086.7 3097.2 13188.3 13950.5 14381.9 14389.1 14875.8 1896.9 2018.9 2034.1 2044.3 2089.4 76187.0 78805.0 78924.0 79559.2 79964.6 10124.4 10430.5 10765.2 10959.7 11235.9 14784.1 14863.9 14941.0 14945.8 14956.2 7712.0 7798.6 7819.3 7889.8 7902.1 6869.8 7306.9 7365.9 7425.5 7470.6 6161.8 6630.6 6635.9 6656.4 6718.3 1866.5 1900.6 1934.1 1945.1 1968.8 992.6 1016.7 1060.3 1091.7 1095.4 18826.1 19260.1 19412.7 19569.3 19775.3 993.9 1013.7 1027.7 1035.4 1044.2 10776.7 11187.7 11188.8 11342.9 11395.3 474291.0 477260.0 479831.0 494847.0 500462.0 78724.0 80905.6 81387.0 82126.0 82201.0 1015.1 1017.6 1045.7 1045.7 1064.5 17280.0 17415.9 17597.2 17633.6 17730.6 30661.4 34120.7 38933.2 39124.2 40854.4 51320.0 51939.0 53066.0 54318.0 54757.5 8738.4 8825.7 8859.5 8896.7 9062.2 13238.0 13279.5 13370.4 13621.5 13797.7 11574.6 11789.6 11897.2 12029.5 12205.1 11450.4 11784.8 12064.8 12116.9 12177.4 7781.5 12217.6 12248.7 12275.9 12294.1 8280.6 8723.3 8959.3 8963.6 9089.0 11223.8 11271.4 11876.4 11967.8 12312.6 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#3] mootools.html Cycles:180 Average:5906.90 Median:4503.34 stddev:3470.55 (77.1%) stddev-sans-first:3463.03 07:28:06 INFO - PROCESS | 5626 | Values: 1301.9 1330.8 1333.3 1400.2 1505.6 8569.4 8973.2 9003.4 9179.4 9188.3 8998.0 9124.7 9156.6 9160.4 9194.8 2289.5 2311.7 2312.9 2315.4 2318.4 2283.3 2308.8 2310.2 2310.5 2315.7 2243.0 2246.9 2270.6 2313.0 2316.0 2197.4 2220.7 2235.8 2238.0 2238.7 2202.7 2205.8 2210.4 2211.2 2212.6 8545.7 8788.9 9126.2 9182.6 9199.9 5157.2 5277.0 5281.6 5283.6 5283.8 3334.4 3338.1 3371.6 3401.8 3408.8 1137.1 1174.4 1175.8 1175.8 1177.1 12364.9 12473.9 12514.1 12520.9 12524.4 4415.4 4453.1 4553.5 4562.8 4567.2 9550.9 9552.3 9569.9 9570.7 9572.8 5030.0 5036.5 5037.6 5038.1 5038.3 4113.3 4237.4 4280.1 4373.4 4604.4 3870.7 3914.8 3916.7 4019.6 4044.1 1175.2 1206.6 1211.3 1215.7 1226.8 824.0 981.9 985.5 986.9 990.7 6140.0 6171.0 6176.3 6197.8 6261.1 428.2 430.0 439.1 440.7 443.8 4060.1 4206.8 4252.3 4319.8 4365.6 11217.4 11655.1 11720.7 11749.2 11757.2 11272.4 11565.4 11628.0 11629.6 11666.3 8548.2 8555.1 8626.5 8651.7 8652.9 6037.2 6118.6 6149.4 6150.0 6292.8 10186.1 10315.7 10579.6 10684.0 10736.9 10195.2 10569.9 10580.6 10704.9 10984.0 7310.2 7981.5 8165.6 8197.0 8220.2 9100.9 9111.4 9112.1 9140.5 9182.8 7475.6 7787.5 7910.8 8014.0 8181.8 7639.5 7717.2 7885.3 7926.6 8061.1 7390.3 7423.7 7467.4 7496.6 7556.1 5266.7 5294.4 5394.6 5424.1 5481.8 5343.6 5445.6 5498.2 5529.1 5589.2 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#4] prototype.html Cycles:180 Average:4632.17 Median:5284.97 stddev:1371.83 (26.0%) stddev-sans-first:1336.80 07:28:06 INFO - PROCESS | 5626 | Values: 311.6 313.5 318.0 319.2 322.7 5168.5 5220.4 5220.6 5226.2 5280.1 5140.3 5185.1 5219.8 5225.7 5235.2 3874.3 4002.8 4013.5 4039.8 4044.3 4094.7 4099.9 4137.6 4151.9 4180.0 4031.6 4070.3 4074.9 4095.7 4110.1 4003.9 4019.2 4053.3 4082.2 4111.8 3544.5 3551.0 3568.0 3587.4 3595.8 5058.0 5098.8 5100.3 5141.5 5165.7 4460.4 4618.3 4623.7 4627.3 4644.0 5409.5 5414.2 5445.6 5451.6 5468.5 3923.1 3935.6 3942.6 3947.4 3953.4 5486.0 5695.0 5705.8 5719.5 5731.7 4039.6 4046.8 4048.4 4057.7 4084.8 4135.7 4137.9 4141.4 4144.4 4146.6 4616.7 4619.8 4686.8 4702.9 4741.7 5217.9 5459.5 5477.0 5479.0 5491.9 1350.8 1373.4 1388.3 1391.8 1394.4 881.9 897.0 899.6 904.3 907.6 5090.7 5190.1 5279.6 5308.6 5358.6 5606.7 5609.3 5623.2 5640.4 5667.0 5089.3 5289.8 5320.3 5343.5 5355.9 2942.3 2961.8 2975.2 2987.8 2995.9 5715.4 5765.6 5779.0 5782.5 5824.8 5467.9 5661.8 5729.3 5758.9 5762.3 5792.0 5824.8 5828.4 5868.4 5887.6 5313.9 5625.6 5640.7 5648.4 5672.8 5637.5 5640.9 5646.7 5655.2 5680.2 5824.7 5855.2 5878.8 5917.7 5927.1 3920.2 3990.4 4091.4 4093.6 4095.8 5678.1 5738.4 5743.4 5769.0 5773.9 5543.8 5654.6 5665.3 5671.0 5691.4 5506.7 5562.4 5566.7 5570.2 5594.6 5261.7 5432.9 5448.4 5451.6 5461.6 5442.5 5506.3 5563.7 5600.5 5626.7 5379.4 5380.3 5380.9 5384.3 5419.3 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - PROCESS | 5626 | [#5] yui.html Cycles:180 Average:20170.16 Median:4674.58 stddev:28732.54 (614.7%) stddev-sans-first:28776.15 07:28:06 INFO - PROCESS | 5626 | Values: 752.1 758.1 815.3 822.8 846.9 13846.2 15113.6 15410.5 15421.5 15465.7 13834.9 14196.9 14210.3 14225.4 14225.9 665.6 681.2 782.6 809.5 810.5 809.7 812.3 812.5 815.8 816.1 686.3 869.5 870.3 871.4 872.4 838.8 862.0 862.4 862.7 863.5 629.2 629.4 629.6 629.8 629.9 14582.6 14632.5 14666.4 14667.4 14668.7 13835.8 13920.0 13982.6 14192.1 14391.3 12400.5 12951.9 12965.7 13003.8 13059.1 4422.9 4444.8 4461.8 4495.2 4697.5 66399.7 66832.3 66978.3 72461.9 72574.6 10905.8 11515.5 11906.4 11943.9 12141.9 18321.9 19262.6 19282.0 19292.0 19337.3 8255.3 8445.6 8467.4 8520.5 8672.9 4189.6 4882.2 4931.8 5071.3 5115.8 3549.2 3664.3 3720.0 3734.5 3734.5 606.3 627.2 634.5 682.4 685.9 651.3 700.4 724.0 770.5 778.4 9326.0 9772.3 9936.2 9999.8 10073.5 537.2 587.5 641.7 709.0 788.9 4541.6 4563.4 4598.9 4617.3 4651.7 114087.0 114470.0 114854.0 119475.0 119788.0 60451.4 60811.7 62068.0 99128.0 99465.0 92293.5 92550.5 92971.0 93100.0 94061.0 9221.7 9224.4 9303.7 9391.9 9487.5 48121.8 49822.3 50106.5 50647.0 51641.7 67405.7 74193.6 74478.0 74799.0 74921.3 12153.9 12982.6 13010.1 13112.0 13358.0 14467.5 15492.4 15801.4 15957.0 15996.1 12410.2 12758.7 12784.9 13976.1 14347.4 14838.3 14931.4 15121.6 15161.2 15653.8 13815.3 13982.9 14347.7 14826.3 14875.7 11029.2 11204.2 11257.3 11340.4 11968.9 11409.3 11857.9 11866.5 11970.5 12093.7 07:28:06 INFO - PROCESS | 5626 | -------- Summary: end -------- 07:28:06 INFO - PROCESS | 5626 | 07:28:06 INFO - TEST-INFO | 5626: exit 0 07:28:06 INFO - TEST-OK | dromaeo_css | took 1113722ms 07:28:06 INFO - TEST-START | kraken 07:28:06 INFO - operating with platform_type : linux_ 07:28:06 INFO - Initialising browser for kraken test... 07:28:06 INFO - TEST-INFO | started process 5807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6w0npa/profile http://localhost:41532/getInfo.html) 07:28:10 INFO - PROCESS | 5807 | __metrics Screen width/height:1600/1200 07:28:10 INFO - PROCESS | 5807 | colorDepth:24 07:28:10 INFO - PROCESS | 5807 | Browser inner width/height: 1024/697 07:28:10 INFO - PROCESS | 5807 | __metrics 07:28:11 INFO - PROCESS | 5807 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:12 INFO - TEST-INFO | 5807: exit 0 07:28:12 INFO - Browser initialized. 07:28:12 INFO - Running cycle 1/1 for kraken test... 07:28:12 INFO - TEST-INFO | started process 5887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6w0npa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:24 INFO - PROCESS | 5887 | RSS: Main: 174034944 07:28:24 INFO - PROCESS | 5887 | 07:28:27 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:28 INFO - PROCESS | 5887 | RSS: Main: 233205760 07:28:28 INFO - PROCESS | 5887 | 07:28:30 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-dft) 07:28:31 INFO - PROCESS | 5887 | RSS: Main: 222355456 07:28:31 INFO - PROCESS | 5887 | 07:28:34 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-fft) 07:28:35 INFO - PROCESS | 5887 | RSS: Main: 286371840 07:28:35 INFO - PROCESS | 5887 | 07:28:37 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-oscillator) 07:28:37 INFO - PROCESS | 5887 | RSS: Main: 198184960 07:28:37 INFO - PROCESS | 5887 | 07:28:40 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:40 INFO - PROCESS | 5887 | RSS: Main: 201699328 07:28:40 INFO - PROCESS | 5887 | 07:28:43 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:44 INFO - PROCESS | 5887 | RSS: Main: 237948928 07:28:44 INFO - PROCESS | 5887 | 07:28:47 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:48 INFO - PROCESS | 5887 | RSS: Main: 238989312 07:28:48 INFO - PROCESS | 5887 | 07:28:51 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41532/tests/kraken/driver.html?testName=json-parse-financial) 07:28:51 INFO - PROCESS | 5887 | RSS: Main: 238563328 07:28:51 INFO - PROCESS | 5887 | 07:28:53 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:53 INFO - PROCESS | 5887 | RSS: Main: 227074048 07:28:53 INFO - PROCESS | 5887 | 07:28:55 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:56 INFO - PROCESS | 5887 | RSS: Main: 229740544 07:28:56 INFO - PROCESS | 5887 | 07:28:58 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:59 INFO - PROCESS | 5887 | RSS: Main: 238305280 07:28:59 INFO - PROCESS | 5887 | 07:29:01 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:02 INFO - PROCESS | 5887 | RSS: Main: 239665152 07:29:02 INFO - PROCESS | 5887 | 07:29:04 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:05 INFO - PROCESS | 5887 | RSS: Main: 237301760 07:29:05 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41532/tests/kraken/driver.html?testName=ai-astar) 07:29:07 INFO - PROCESS | 5887 | RSS: Main: 279384064 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | __start_tp_report 07:29:07 INFO - PROCESS | 5887 | _x_x_mozilla_page_load 07:29:07 INFO - PROCESS | 5887 | _x_x_mozilla_page_load_details 07:29:07 INFO - PROCESS | 5887 | |i|pagename|runs| 07:29:07 INFO - PROCESS | 5887 | |0;ai-astar;111;107;109;109;111;110;110;109;109;109 07:29:07 INFO - PROCESS | 5887 | |1;audio-beat-detection;158;126;128;185;133;128;148;125;159;124 07:29:07 INFO - PROCESS | 5887 | |2;audio-dft;162;161;161;161;162;161;162;162;159;161 07:29:07 INFO - PROCESS | 5887 | |3;audio-fft;75;76;76;130;75;75;75;74;100;76 07:29:07 INFO - PROCESS | 5887 | |4;audio-oscillator;85;85;115;85;85;86;125;85;85;136 07:29:07 INFO - PROCESS | 5887 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;117;117;116 07:29:07 INFO - PROCESS | 5887 | |6;imaging-darkroom;146;145;146;145;146;146;146;146;145;146 07:29:07 INFO - PROCESS | 5887 | |7;imaging-desaturate;96;95;95;94;95;95;95;96;94;96 07:29:07 INFO - PROCESS | 5887 | |8;json-parse-financial;56;56;58;55;55;55;56;56;56;56 07:29:07 INFO - PROCESS | 5887 | |9;json-stringify-tinderbox;62;63;63;62;61;62;61;62;64;62 07:29:07 INFO - PROCESS | 5887 | |10;stanford-crypto-aes;81;80;85;82;86;85;80;81;108;81 07:29:07 INFO - PROCESS | 5887 | |11;stanford-crypto-ccm;123;122;127;140;118;130;126;129;133;122 07:29:07 INFO - PROCESS | 5887 | |12;stanford-crypto-pbkdf2;167;162;166;166;165;162;161;166;161;169 07:29:07 INFO - PROCESS | 5887 | |13;stanford-crypto-sha256-iterative;64;63;67;63;64;62;63;62;64;65 07:29:07 INFO - PROCESS | 5887 | __end_tp_report 07:29:07 INFO - PROCESS | 5887 | __start_cc_report 07:29:07 INFO - PROCESS | 5887 | _x_x_mozilla_cycle_collect,1644 07:29:07 INFO - PROCESS | 5887 | __end_cc_report 07:29:07 INFO - PROCESS | 5887 | __startTimestamp1466519347419__endTimestamp 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | ------- Summary: start ------- 07:29:07 INFO - PROCESS | 5887 | Number of tests: 14 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:1.17 (1.1%) stddev-sans-first:1.09 07:29:07 INFO - PROCESS | 5887 | Values: 111.0 107.0 109.0 109.0 111.0 110.0 110.0 109.0 109.0 109.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:140.50 stddev:20.46 (14.6%) stddev-sans-first:20.80 07:29:07 INFO - PROCESS | 5887 | Values: 158.0 126.0 128.0 185.0 133.0 128.0 148.0 125.0 159.0 124.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.92 (0.6%) stddev-sans-first:0.93 07:29:07 INFO - PROCESS | 5887 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 162.0 162.0 159.0 161.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:18.20 (24.3%) stddev-sans-first:19.06 07:29:07 INFO - PROCESS | 5887 | Values: 75.0 76.0 76.0 130.0 75.0 75.0 75.0 74.0 100.0 76.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.00 stddev:20.04 (23.6%) stddev-sans-first:20.76 07:29:07 INFO - PROCESS | 5887 | Values: 85.0 85.0 115.0 85.0 85.0 86.0 125.0 85.0 85.0 136.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:29:07 INFO - PROCESS | 5887 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:29:07 INFO - PROCESS | 5887 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 07:29:07 INFO - PROCESS | 5887 | Values: 96.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 94.0 96.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 07:29:07 INFO - PROCESS | 5887 | Values: 56.0 56.0 58.0 55.0 55.0 55.0 56.0 56.0 56.0 56.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 07:29:07 INFO - PROCESS | 5887 | Values: 62.0 63.0 63.0 62.0 61.0 62.0 61.0 62.0 64.0 62.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:81.50 stddev:8.41 (10.3%) stddev-sans-first:8.80 07:29:07 INFO - PROCESS | 5887 | Values: 81.0 80.0 85.0 82.0 86.0 85.0 80.0 81.0 108.0 81.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:6.38 (5.0%) stddev-sans-first:6.60 07:29:07 INFO - PROCESS | 5887 | Values: 123.0 122.0 127.0 140.0 118.0 130.0 126.0 129.0 133.0 122.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:166.00 stddev:2.80 (1.7%) stddev-sans-first:2.82 07:29:07 INFO - PROCESS | 5887 | Values: 167.0 162.0 166.0 166.0 165.0 162.0 161.0 166.0 161.0 169.0 07:29:07 INFO - PROCESS | 5887 | 07:29:07 INFO - PROCESS | 5887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 07:29:07 INFO - PROCESS | 5887 | Values: 64.0 63.0 67.0 63.0 64.0 62.0 63.0 62.0 64.0 65.0 07:29:07 INFO - PROCESS | 5887 | -------- Summary: end -------- 07:29:07 INFO - PROCESS | 5887 | 07:29:08 INFO - TEST-INFO | 5887: exit 0 07:29:08 INFO - TEST-OK | kraken | took 61742ms 07:29:08 INFO - SUITE-END | took 1175s 07:29:08 INFO - Completed test suite (00:19:35) 07:29:08 INFO - javascript benchmark 07:29:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.6008218931534, 3085.475469170241, 3090.088423914945, 3103.8292893890857, 3128.7184153426188, 5078.822241221558, 5167.483251674831, 5217.817376391822, 5275.1296036154035, 5323.494268044535, 5202.817901373443, 5223.947760522394, 5252.606054545905, 5264.6051546134, 5324.866878328034, 4705.458872229695, 4725.291206319045, 4774.140654682155, 4785.1147537705465, 4899.828506002291, 4812.903741925159, 4848.345473361086, 4862.63530235232, 4865.951340486586, 4889.804407823683, 4718.952810471886, 4750.453697824742, 4790.137775200463, 4805.231163013901, 4879.438864530571, 4809.6392770542, 4826.903461930777, 4827.25177597473, 4828.782704778258, 4927.852164435073, 4821.662483626147, 4830.661853670244, 4864.708117512925, 4865.6594038417325, 4899.657024008321, 5163.767630456601, 5171.7672704728375, 5201.713905735183, 5208.973955130238, 5366.6779993200535, 5541.612087153861, 5601.943980560183, 5602.1596760485845, 5632.183333416672, 5638.379778224433, 5621.241132447109, 5648.265725455664, 5681.460261275172, 5692.316921969349, 5710.200571919934, 5092.9236061459105, 5262.92105618416, 5263.315768950012, 5268.789248430058, 5324.094903866352, 5878.0, 5888.998870191992, 5894.32215295238, 5904.911426328608, 5910.881782364415, 5340.279062326536, 5623.718814059281, 5642.605017648725, 5647.971760141173, 5652.830415087472, 5558.194061861008, 5628.155776633538, 5637.154426835926, 5637.3235211774845, 5637.548996080303, 5632.464915832989, 5633.464820842013, 5634.154876768517, 5643.1535269709875, 5643.266375371176, 5550.139728342114, 5556.888862222733, 5653.689047102449, 5656.519195868397, 5663.546916246691, 4350.195213885378, 4351.238533256667, 4352.151330490524, 4369.890752731207, 4389.297712366006, 3867.207222519377, 3879.7672139671145, 3888.6500214980224, 3891.5135608048995, 3911.765294082364, 5191.714455704897, 5246.029484545371, 5270.7628156733035, 5370.0, 5408.4050754416985, 5599.356074051536, 5602.327720673464, 5605.691686957257, 5624.409437009055, 5627.915581266284, 5264.868378290496, 5274.472552744694, 5282.445343238905, 5287.180487024518, 5348.197770334403, 4768.546988036131, 4827.42070951488, 4849.345338379344, 4850.466448690641, 4895.6083513318845, 5787.479126878601, 5817.069268916868, 5821.592488525763, 5834.124881267844, 5835.94164058354, 5651.915221271602, 5659.943400565941, 5660.688662123623, 5662.377138514842, 5663.405342438985, 5678.290213723285, 5743.511801496919, 5804.21643078179, 5815.06958886593, 5862.355140934579, 5529.032419326521, 5536.280283563111, 5541.418151094077, 5545.667259964415, 5545.916811247754, 5398.4871437213405, 5629.071203251581, 5639.7744090237575, 5647.774089036392, 5648.15277708347, 5471.6169868108855, 5509.889802204014, 5525.972370138124, 5530.115181570929, 5549.556035517229, 5523.861903452445, 5526.47498487643, 5527.695976721158, 5529.944700553104, 5539.169124631338, 5256.658317209369, 5276.551493123127, 5371.221172929982, 5431.2667789847865, 5486.451354864482, 5424.213489044146, 5557.194206839905, 5560.054790685674, 5562.16567514876, 5565.415631358649, 5369.382521010134, 5393.946060539344, 5395.163749618815, 5403.83788486346, 5407.729613519387], "value": 5198.169300484316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.5609152906497, 603.4900509069836, 611.4558043341425, 614.4623454477332, 627.9544558310413, 32268.0, 34712.82643586781, 43358.78320608393, 43827.78086109565, 44104.77947610265, 44298.33552496715, 44797.328040079425, 44848.0, 44914.63140264485, 44939.55060449395, 8627.396082274243, 8732.432391894537, 8754.168354006359, 8838.867416988718, 8844.33667474942, 8547.273481754059, 8687.695930642429, 8687.914010748656, 8690.435121717068, 8695.434796738191, 8712.869306960401, 8786.209241168293, 8795.0, 8795.428297160664, 8795.912040879573, 8630.439021463584, 8686.3050955924, 8702.260307873838, 8710.346723995694, 8747.475151490898, 8671.739847804576, 8734.257588105018, 8735.43219690718, 8740.606672699743, 8751.737447876574, 40138.79930600357, 40772.59227407718, 40824.387634185216, 40824.79587602043, 40852.0, 3367.2928684976187, 3467.219875528011, 3482.1642805726697, 3500.4924285978645, 3513.350030244413, 28372.432551349062, 28471.430571388457, 28511.144665660064, 28713.425731485462, 28980.710192898223, 3853.0305739316805, 3902.687784977195, 3914.4715463412645, 3977.920441591181, 3991.3613821788663, 326721.0, 327084.9999999976, 328339.5081172148, 328751.0, 329266.0, 33941.0, 54792.0, 54910.72544637251, 54918.0, 54982.17526737022, 34593.13517162041, 35140.715853469446, 35141.472877906854, 35177.296454070776, 35178.47232291518, 13692.31538423075, 13939.0, 13954.372053257628, 13971.0, 13972.790408143886, 11454.541818327174, 11520.078393728481, 11523.135764817673, 11533.538658453735, 11534.884651153548, 8033.919660803317, 8149.307308878693, 8174.591270436455, 8226.383021273428, 8235.95882020586, 3119.2513796689086, 3126.2965832687464, 3131.6960606560297, 3159.462891308437, 3166.4142133705336, 968.9321747477609, 998.5306905754429, 1049.223574554824, 1155.5782139519183, 1172.3200543684643, 31594.210144746106, 32446.83776581102, 32538.186545336557, 32858.50712239318, 33255.50116748251, 1014.7818219082933, 1053.089077947585, 1131.4964840645835, 1169.5964892112208, 1189.7323102301914, 16261.674766504604, 16646.50060498187, 16663.50009499717, 16700.916495417445, 16787.2445739942, 538152.0, 547675.0, 548152.0, 549190.0, 549896.0, 53492.73253633707, 54724.726376367864, 54785.452145478834, 54864.177037344474, 54887.45112548823, 1194.5699548162654, 1274.5284244829472, 1323.5698398020681, 1329.5147271245926, 1346.8653134686454, 30934.69065309318, 32767.0, 32810.343793124484, 33370.0, 33474.66525334716, 47853.0, 48117.518824811305, 48174.5182548184, 48445.0, 48476.0, 380859.0, 382203.0, 382626.0, 385429.0, 385954.0, 25475.0, 26124.0, 27262.0, 27776.305592360353, 28351.0, 46393.07213855637, 46637.0, 46742.532574673816, 47547.76226118847, 48004.279935800296, 40085.59914400936, 40573.39139912845, 40658.1868362637, 40681.79659101686, 41594.37608435936, 39393.56182748748, 39450.40824387694, 40371.0, 40554.39168412535, 41340.0, 41228.79385603053, 41268.587314126475, 41453.79273103615, 41638.791806040776, 41735.373969389875, 34607.30785384329, 35579.04269982655, 36086.482812390925, 36398.8180059098, 36773.63226367702, 27439.725602743718, 28146.36585522837, 28269.57595636026, 28270.574679389392, 28513.144605661862], "value": 18279.10860707994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1160776644782, 395.73485764537764, 399.23944884994097, 406.2869663740136, 411.2556273145607, 14353.641158971031, 17960.371387001458, 18350.63298734026, 19850.106745196448, 19954.600907981832, 14666.12003279804, 18356.35752748654, 18762.43712688618, 19027.716673999104, 19197.712034319495, 5585.553155747541, 5768.134779783024, 5786.942130578704, 5804.82585522435, 5818.301803783552, 4190.937135942963, 5746.25298711169, 5875.148103524986, 6198.101275315076, 6524.673766311689, 6457.838554036163, 6509.2839787623325, 6565.934340656604, 6576.145101136845, 6593.703283352237, 6269.090981807635, 6453.645049522274, 6460.709268082924, 6471.805845824632, 6484.61092334459, 5602.299712535933, 5667.093265077568, 5676.290463692038, 5680.0, 5709.400512946164, 21831.672524912137, 22222.66666000011, 22711.318660440214, 22805.31584052481, 23001.654975175385, 2482.4786794773117, 2790.246633408968, 3071.078676397094, 3086.6758990306143, 3097.1792474994145, 13188.340582970908, 13950.511732089328, 14381.928090359586, 14389.13665180082, 14875.77686334695, 1896.868330934543, 2018.919243230269, 2034.104993802722, 2044.2640649366217, 2089.39407571804, 76187.0, 78805.0, 78924.0, 79559.20440795575, 79964.60017699875, 10124.443155626364, 10430.530626121843, 10765.192610554239, 10959.671209863716, 11235.932586404278, 14784.11295322284, 14863.851361486246, 14941.0, 14945.775813362809, 14956.177410242324, 7712.0, 7798.571078590732, 7819.296263336327, 7889.842203155905, 7902.130765615778, 6869.793906182823, 7306.853862922711, 7365.852682946418, 7425.517341372793, 7470.626468676544, 6161.784337548164, 6630.612979327439, 6635.900461493082, 6656.434203092791, 6718.328167183243, 1866.5426970392068, 1900.6483800496953, 1934.1393080079229, 1945.134415185229, 1968.7834338222783, 992.6128809764198, 1016.6936131803186, 1060.3372891942536, 1091.650671785037, 1095.446799366315, 18826.05869706509, 19260.133294001804, 19412.708809367872, 19569.315073972626, 19775.30786422497, 993.9254555908336, 1013.6502906497246, 1027.7379268286688, 1035.3839465518004, 1044.185535282481, 10776.730581735519, 11187.664370068911, 11188.832167517494, 11342.886571134348, 11395.316281023164, 474291.0, 477260.0, 479831.0, 494847.0, 500462.0, 78724.0, 80905.59547202344, 81387.0, 82126.0, 82201.0, 1015.0914931136591, 1017.577705252312, 1045.6915210013065, 1045.7385653586603, 1064.4784055812595, 17280.0, 17415.912920435316, 17597.208125634632, 17633.559161021076, 17730.645387092445, 30661.386772263984, 34120.65879341175, 38933.2213355737, 39124.21751564896, 40854.387184192856, 51320.0, 51939.0, 53066.0, 54318.0, 54757.45242547523, 8738.388312818295, 8825.69110081144, 8859.51272679983, 8896.733098007071, 9062.184403403726, 13238.0, 13279.535216267384, 13370.398332075274, 13621.455141794217, 13797.655058623615, 11574.594889178838, 11789.646310610695, 11897.226680265756, 12029.518819247482, 12205.145639805483, 11450.37022963745, 11784.76430471403, 12064.819027714415, 12116.939415302868, 12177.391130443619, 7781.5331080135375, 12217.572384966483, 12248.69378265515, 12275.93862030684, 12294.139410241554, 8280.58597070156, 8723.258523025614, 8959.328050396116, 8963.596638151168, 9089.0, 11223.831642525205, 11271.380074096003, 11876.406179690808, 11967.820482692592, 12312.630621081023], "value": 9409.70426355687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.8763217494334, 1330.8003799430085, 1333.3466601365321, 1400.2298735695367, 1505.57843803735, 8569.357298202629, 8973.23727483164, 9003.369764116514, 9179.357444978854, 9188.264938804896, 8998.0, 9124.680636177734, 9156.633734650623, 9160.35877488576, 9194.816103677922, 2289.473421113145, 2311.653252012203, 2312.8612283262974, 2315.3517015235675, 2318.3740390094663, 2283.303592404316, 2308.8268379871492, 2310.214527060799, 2310.549442858643, 2315.6642286868396, 2243.0354947372625, 2246.8764217968005, 2270.579942710604, 2313.0169677886915, 2316.027268547206, 2197.3517812245427, 2220.7224096987875, 2235.776422357759, 2237.9888100559474, 2238.708967834187, 2202.6916231727573, 2205.8235341172667, 2210.4473881529616, 2211.237123192496, 2212.6459766437456, 8545.658173673046, 8788.8681669775, 9126.17864392208, 9182.632694692204, 9199.862002069975, 5157.174852023696, 5277.0, 5281.603879709037, 5283.577313814885, 5283.788648454057, 3334.3831391192707, 3338.115399419156, 3371.5954085509898, 3401.7958922464486, 3408.7784294020807, 1137.113051819582, 1174.3834486894448, 1175.8118701007797, 1175.8471398718198, 1177.1171621284036, 12364.938175309066, 12473.875261247362, 12514.12401131921, 12520.874791252061, 12524.436400362005, 4415.425994620743, 4453.131639330364, 4553.54464553542, 4562.771861406916, 4567.246404343313, 9550.856737148948, 9552.283578731623, 9569.904300957041, 9570.712878613653, 9572.808543829224, 5030.044291584587, 5036.496350364934, 5037.571806396424, 5038.118329292359, 5038.3198268234055, 4113.25961326964, 4237.406763053175, 4280.079782846703, 4373.431453911035, 4604.447466303998, 3870.7290489666016, 3914.8434062637743, 3916.7258291919293, 4019.577944315863, 4044.0698639313123, 1175.1832476428972, 1206.6199147268583, 1211.3277131192096, 1215.7386161975041, 1226.7669142862828, 823.9711610093618, 981.906718861707, 985.4826216236534, 986.921046316293, 990.6978371596588, 6139.96930015356, 6170.969145154246, 6176.258848938066, 6197.845053873689, 6261.092141639528, 428.1821720513866, 429.9978500107479, 439.0910814613719, 440.7333563194221, 443.7892001299422, 4060.1067765091634, 4206.768627725443, 4252.255855225323, 4319.848805291863, 4365.563443655609, 11217.383043932661, 11655.067594592412, 11720.70698232551, 11749.177557571058, 11757.235779674294, 11272.380019098864, 11565.363904985306, 11628.0, 11629.59296424621, 11666.300021998708, 8548.230659240699, 8555.144485551395, 8626.48241105523, 8651.653933842701, 8652.8702069469, 6037.154798328325, 6118.571699981137, 6149.41580549847, 6149.96925015372, 6292.811215663537, 10186.134178594903, 10315.690529284133, 10579.576816927545, 10684.038436540748, 10736.89263107359, 10195.235357348376, 10569.947150264199, 10580.576776929145, 10704.89295107039, 10984.0, 7310.159331676712, 7981.48120372174, 8165.550894700848, 8196.959015204886, 8220.219079187467, 9100.863487047833, 9111.407758495676, 9112.088791120836, 9140.451572905647, 9182.770430739285, 7475.588842613708, 7787.4548781584745, 7910.802229944067, 8013.959930200312, 8181.836363272821, 7639.503432276884, 7717.228277172462, 7885.250901164381, 7926.643301051582, 8061.072976607531, 7390.29792169743, 7423.703051877865, 7467.365273951775, 7496.58768767723, 7556.055493063367, 5266.683998960075, 5294.385212510221, 5394.595405344693, 5424.07790675594, 5481.780728770805, 5343.599230057684, 5445.59158063139, 5498.1752737089755, 5529.115341545334, 5589.217509548585], "value": 4575.903297539184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.565366313992, 313.53909752663577, 318.01098583405604, 319.16856588586734, 322.73696936996356, 5168.534831865131, 5220.399654039787, 5220.634555581111, 5226.24219488174, 5280.128778751511, 5140.280360749489, 5185.144451165563, 5219.817306394277, 5225.660332078422, 5235.214717792333, 3874.2638898609175, 4002.8198731057028, 4013.4782478277784, 4039.8182081806244, 4044.251813414513, 4094.686502126304, 4099.856505022325, 4137.586241375869, 4151.937720934188, 4180.038591124044, 4031.5968403159595, 4070.3487442009286, 4074.9388759168637, 4095.7133000689964, 4110.07523307255, 4003.8598649047144, 4019.2363450944517, 4053.250148722481, 4082.2243773683203, 4111.7944102794745, 3544.4860495228304, 3550.982245088758, 3567.965290065878, 3587.4260118380935, 3595.7842529448317, 5057.976809276282, 5098.847034588968, 5100.285959965608, 5141.4832624375895, 5165.7158856262895, 4460.397846290742, 4618.330342100377, 4623.722576645412, 4627.305904114376, 4643.953560464386, 5409.540189083893, 5414.160805075219, 5445.646033007842, 5451.609839490904, 5468.4611772228955, 3923.0580862473257, 3935.6457918787446, 3942.64516193544, 3947.3684210526176, 3953.446517487554, 5485.9725701371635, 5694.9715251423895, 5705.800296989627, 5719.456651618089, 5731.681713205986, 4039.636432721069, 4046.7976601169826, 4048.3725022621543, 4057.7159598827798, 4084.7957602119777, 4135.669146468275, 4137.937930931039, 4141.4409054777825, 4144.3990621359735, 4146.647534959562, 4616.676832621752, 4619.838305659286, 4686.7656617169005, 4702.88242793926, 4741.739204343725, 5217.869553261199, 5459.50864422196, 5477.0, 5479.0, 5491.917621235684, 1350.783874580082, 1373.3862711314166, 1388.3127851713466, 1391.8329800424015, 1394.42828440341, 881.8985816631041, 896.9820603587891, 899.6086702284397, 904.3488688144525, 907.6414816147717, 5090.694558326438, 5190.143626301693, 5279.630425870152, 5308.601854860901, 5358.598105142052, 5606.6636001840025, 5609.270794796732, 5623.184638227516, 5640.407757185437, 5667.0, 5089.262057001788, 5289.814856480005, 5320.334958130234, 5343.465653434625, 5355.892882142335, 2942.3379739558427, 2961.7926745128066, 2975.1966968918273, 2987.760979121665, 2995.9214682714205, 5715.399883012307, 5765.567582431335, 5779.046457334577, 5782.537397008229, 5824.796132135355, 5467.917981230285, 5661.830145095571, 5729.312482502043, 5758.913616295759, 5762.337331206881, 5791.971040144772, 5824.796132135355, 5828.388019258002, 5868.4424979626865, 5887.587868849139, 5313.9468605315, 5625.609116125712, 5640.661560306395, 5648.406917273627, 5672.801451949162, 5637.46444087811, 5640.85897852557, 5646.689432081275, 5655.208270842003, 5680.176374425768, 5824.660328124471, 5855.209546711139, 5878.764849406147, 5917.674527900835, 5927.140564618193, 3920.2159568085926, 3990.383894522723, 4091.427200192035, 4093.6111069448357, 4095.7542547447247, 5678.119891416837, 5738.397468265772, 5743.368229494836, 5769.0, 5773.8556536086935, 5543.750531226024, 5654.575906806924, 5665.263515742927, 5670.971645141748, 5691.430856914276, 5506.714713393897, 5562.443755624405, 5566.666000040011, 5570.192322113352, 5594.552435805044, 5261.684298942076, 5432.864178395572, 5448.427915069019, 5451.64564303319, 5461.563074954073, 5442.537384322377, 5506.256655351636, 5563.721813909369, 5600.467955544217, 5626.746796394254, 5379.4351593082165, 5380.300560927054, 5380.865478363072, 5384.326959130109, 5419.34967803866], "value": 4187.322951029898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1312883619418, 758.0562200060925, 815.2947700239295, 822.7819627798633, 846.9322454203663, 13846.169229846204, 15113.622159446018, 15410.537683869474, 15421.460248891291, 15465.690686186284, 13834.930825345884, 14196.929015354935, 14210.28948552571, 14225.430982760678, 14225.857741422582, 665.5773583774289, 681.2029924987752, 782.6243403166484, 809.5021561739517, 810.5379933437943, 809.6558962440969, 812.3298278919915, 812.5246730662569, 815.7919730468752, 816.0859836982588, 686.3445409633788, 869.5130726792985, 870.2646263906988, 871.3508436215029, 872.3718922375879, 838.7986883148031, 861.9698310559163, 862.3532350736916, 862.7368652560966, 863.5380071661693, 629.238621268266, 629.4209327418786, 629.5813284166024, 629.804760524239, 629.8929182039019, 14582.562523124323, 14632.487862924747, 14666.413343466249, 14667.413303467849, 14668.70662586753, 13835.79246311306, 13920.0, 13982.58052258434, 14192.148471091768, 14391.280435978264, 12400.503979840796, 12951.87048129516, 12965.675858103528, 13003.804942925864, 13059.085863989525, 4422.867313980586, 4444.755538445384, 4461.821527138943, 4495.190865644183, 4697.459792123916, 66399.66800166016, 66832.33167668262, 66978.33021669819, 72461.91307130398, 72574.63712681456, 10905.781884362426, 11515.53937842477, 11906.404679765978, 11943.880561194277, 12141.878581214252, 18321.90839045823, 19262.614747705247, 19282.0, 19292.0, 19337.323193688153, 8255.298299644477, 8445.619947102396, 8467.449615774955, 8520.488770673779, 8672.913270867211, 4189.643880270211, 4882.170031094723, 4931.827386041471, 5071.340725705709, 5115.820946266937, 3549.219171782204, 3664.2854643344826, 3719.9814000929823, 3734.477173195755, 3734.477173195755, 606.3178923710825, 627.2222444169197, 634.4607083978674, 682.4267615203253, 685.9295237151172, 651.2640715990995, 700.3836623771049, 724.0189543169035, 770.5107256891802, 778.4473024152802, 9325.953370233241, 9772.31593788428, 9936.155426788804, 9999.800003999879, 10073.546690398949, 537.1888448442801, 587.4771453406472, 641.7304732012566, 708.9680964356617, 788.8501184774874, 4541.613962813198, 4563.361129441814, 4598.908021839545, 4617.2612382018715, 4651.697639653412, 114087.0, 114470.0, 114854.0, 119475.0, 119788.0, 60451.395486044574, 60811.69594152001, 62068.0, 99128.0, 99465.0, 92293.5385323069, 92550.53724731333, 92971.0, 93100.0, 94061.0, 9221.723348299562, 9224.400413973339, 9303.72088837336, 9391.906080939103, 9487.529432937905, 48121.75939120422, 49822.25266621076, 50106.49893501018, 50647.0, 51641.708957276365, 67405.66297168483, 74193.62903185449, 74478.0, 74799.0, 74921.25078749143, 12153.878461215274, 12982.610521684364, 13010.089293749725, 13112.0, 13358.0, 14467.49363772263, 15492.380304787683, 15801.36794528206, 15957.0, 15996.120213388376, 12410.193337433038, 12758.68103297425, 12784.87215127874, 13976.091554048955, 14347.35436905321, 14838.332275047433, 14931.402743890558, 15121.621959451102, 15161.241937903282, 15653.765193522335, 13815.309234538434, 13982.860171398155, 14347.713045738818, 14826.258687065389, 14875.702485950003, 11029.172812038969, 11204.215704900578, 11257.268277561932, 11340.432978351215, 11968.880311196777, 11409.345794392524, 11857.881421185677, 11866.525338986345, 11970.461329240032, 12093.697657558632], "value": 7547.46974096231, "unit": "score"}], "name": "dromaeo_css", "value": 7111.1506221324225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 128.0, 185.0, 133.0, 128.0, 148.0, 125.0, 159.0, 124.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 159.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 130.0, 75.0, 75.0, 75.0, 74.0, 100.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 85.0, 86.0, 125.0, 85.0, 85.0, 136.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 61.0, 62.0, 61.0, 62.0, 64.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 85.0, 82.0, 86.0, 85.0, 80.0, 81.0, 108.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 127.0, 140.0, 118.0, 130.0, 126.0, 129.0, 133.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 166.0, 166.0, 165.0, 162.0, 161.0, 166.0, 161.0, 169.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 67.0, 63.0, 64.0, 62.0, 63.0, 62.0, 64.0, 65.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1508.0000000000002, "alertThreshold": 2.0}]} 07:29:08 INFO - Return code: 0 07:29:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:08 INFO - # TBPL SUCCESS # 07:29:08 INFO - Running post-action listener: _resource_record_post_action 07:29:08 INFO - ##### 07:29:08 INFO - ##### Finished run-tests step (success) 07:29:08 INFO - ##### 07:29:08 INFO - Running post-run listener: _resource_record_post_run 07:29:08 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551030784; Read time: 20; Write time: 633240 07:29:08 INFO - TinderboxPrint: CPU usage
13.1% 07:29:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:29:08 INFO - TinderboxPrint: I/O write bytes / time
551,030,784 / 633,240 07:29:08 INFO - TinderboxPrint: CPU idle
8,277.6 (86.9%) 07:29:08 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 07:29:08 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256212992; Read time: 0; Write time: 289336 07:29:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294072320; Read time: 20; Write time: 343880 07:29:09 INFO - Running post-run listener: _upload_blobber_files 07:29:09 INFO - Blob upload gear active. 07:29:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:09 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 07:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:14 INFO - (blobuploader) - INFO - Done attempting. 07:29:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:29:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:29:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:15 INFO - (blobuploader) - INFO - Done attempting. 07:29:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:29:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:16 INFO - (blobuploader) - INFO - Done attempting. 07:29:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:16 INFO - Return code: 0 07:29:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f5dcbbc75f54b73b0e79f8939cc1c2b2d7b093add613fc45036ab78c9c11d25b9c39f4f8f43f1ab8242632be763b427d11d974fbae262b55d496f03b35805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146d84cd7d5942c43328cc4e2191d9ade74a5bcfc0b67219a52b78e01037665ad56f874200d8c4fe9a354e0395b550922e36980ac6b0dea8d734f945a51dab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850fc8f492be084d1d252edf3f5ef3298de1b99c4ae3e1be9afee2030e678432674ada307a599238986d96ac40c854d0f7edb729b4d6a1681ef69c28f36e7af2"} 07:29:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:16 INFO - Contents: 07:29:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f5dcbbc75f54b73b0e79f8939cc1c2b2d7b093add613fc45036ab78c9c11d25b9c39f4f8f43f1ab8242632be763b427d11d974fbae262b55d496f03b35805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146d84cd7d5942c43328cc4e2191d9ade74a5bcfc0b67219a52b78e01037665ad56f874200d8c4fe9a354e0395b550922e36980ac6b0dea8d734f945a51dab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850fc8f492be084d1d252edf3f5ef3298de1b99c4ae3e1be9afee2030e678432674ada307a599238986d96ac40c854d0f7edb729b4d6a1681ef69c28f36e7af2"} 07:29:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:16 INFO - Copying logs to upload dir... 07:29:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.491722 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 07:29:16.153765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 07:29:16.156903) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f5dcbbc75f54b73b0e79f8939cc1c2b2d7b093add613fc45036ab78c9c11d25b9c39f4f8f43f1ab8242632be763b427d11d974fbae262b55d496f03b35805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146d84cd7d5942c43328cc4e2191d9ade74a5bcfc0b67219a52b78e01037665ad56f874200d8c4fe9a354e0395b550922e36980ac6b0dea8d734f945a51dab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850fc8f492be084d1d252edf3f5ef3298de1b99c4ae3e1be9afee2030e678432674ada307a599238986d96ac40c854d0f7edb729b4d6a1681ef69c28f36e7af2"} build_url:https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/XJs5gvUOQhShHVBysDJJZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f5dcbbc75f54b73b0e79f8939cc1c2b2d7b093add613fc45036ab78c9c11d25b9c39f4f8f43f1ab8242632be763b427d11d974fbae262b55d496f03b35805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4146d84cd7d5942c43328cc4e2191d9ade74a5bcfc0b67219a52b78e01037665ad56f874200d8c4fe9a354e0395b550922e36980ac6b0dea8d734f945a51dab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850fc8f492be084d1d252edf3f5ef3298de1b99c4ae3e1be9afee2030e678432674ada307a599238986d96ac40c854d0f7edb729b4d6a1681ef69c28f36e7af2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 07:29:16.186166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:29:16.186876) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466517763.936405-2035249553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:29:16.270911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 07:29:16.271660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 07:29:16.272312) ========= ========= Total master_lag: 0.05 =========