builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1465059677.86 results: success (0) buildid: 20160604073132 builduid: 89936be38e294413b5af9017be76da6d revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.864458) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.864871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.865160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.911871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.912228) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 10:01:18-- 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% 23.1M=0.001s 2016-06-04 10:01:18 (23.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.056587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.056882) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.105954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.106268) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e8ee3599a67edd971770af4982ad4b0fe77f073 --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 3e8ee3599a67edd971770af4982ad4b0fe77f073 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 10:01:18,658 truncating revision to first 12 chars 2016-06-04 10:01:18,658 Setting DEBUG logging. 2016-06-04 10:01:18,658 attempt 1/10 2016-06-04 10:01:18,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e8ee3599a67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 10:01:19,117 unpacking tar archive at: mozilla-central-3e8ee3599a67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.905780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.906063) ========= script_repo_revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.906468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.906781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.922730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-04 10:01:18.923052) ========= /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=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:19 INFO - MultiFileLogger online at 20160604 10:01:19 in /builds/slave/test 10:01:19 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 10:01:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:19 INFO - {'append_to_log': False, 10:01:19 INFO - 'base_work_dir': '/builds/slave/test', 10:01:19 INFO - 'blob_upload_branch': 'Firefox', 10:01:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:19 INFO - 'branch': 'Firefox', 10:01:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:19 INFO - 'config_files': ('talos/linux_config.py',), 10:01:19 INFO - 'default_actions': ('clobber', 10:01:19 INFO - 'read-buildbot-config', 10:01:19 INFO - 'download-and-extract', 10:01:19 INFO - 'populate-webroot', 10:01:19 INFO - 'create-virtualenv', 10:01:19 INFO - 'install', 10:01:19 INFO - 'run-tests'), 10:01:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:19 INFO - 'download_minidump_stackwalk': True, 10:01:19 INFO - 'download_symbols': 'ondemand', 10:01:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:19 INFO - 'installer_path': 'installer.exe', 10:01:19 INFO - 'log_level': 'info', 10:01:19 INFO - 'log_name': 'talos', 10:01:19 INFO - 'log_to_console': True, 10:01:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:19 INFO - 'opt_config_files': (), 10:01:19 INFO - 'pip_index': False, 10:01:19 INFO - 'sps_profile': False, 10:01:19 INFO - 'sps_profile_interval': 0, 10:01:19 INFO - 'suite': 'dromaeojs', 10:01:19 INFO - 'system_bits': '32', 10:01:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:19 INFO - 'title': 'talos-linux64-ix-025', 10:01:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:19 INFO - 'use_talos_json': True, 10:01:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:19 INFO - 'work_dir': 'build'} 10:01:19 INFO - ##### 10:01:19 INFO - ##### Running clobber step. 10:01:19 INFO - ##### 10:01:19 INFO - Running pre-action listener: _resource_record_pre_action 10:01:19 INFO - Running main action method: clobber 10:01:19 INFO - rmtree: /builds/slave/test/build 10:01:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:20 INFO - Running post-action listener: _resource_record_post_action 10:01:20 INFO - ##### 10:01:20 INFO - ##### Finished clobber step (success) 10:01:20 INFO - ##### 10:01:20 INFO - ##### 10:01:20 INFO - ##### Running read-buildbot-config step. 10:01:20 INFO - ##### 10:01:20 INFO - Running pre-action listener: _resource_record_pre_action 10:01:20 INFO - Running main action method: read_buildbot_config 10:01:20 INFO - Using buildbot properties: 10:01:20 INFO - { 10:01:20 INFO - "project": "", 10:01:20 INFO - "product": "firefox", 10:01:20 INFO - "script_repo_revision": "production", 10:01:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:01:20 INFO - "repository": "", 10:01:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:01:20 INFO - "buildid": "20160604073132", 10:01:20 INFO - "pgo_build": "True", 10:01:20 INFO - "basedir": "/builds/slave/test", 10:01:20 INFO - "buildnumber": 322, 10:01:20 INFO - "slavename": "talos-linux64-ix-025", 10:01:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:01:20 INFO - "platform": "ubuntu64_hw", 10:01:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:01:20 INFO - "branch": "mozilla-central", 10:01:20 INFO - "repo_path": "mozilla-central", 10:01:20 INFO - "revision": "3e8ee3599a67edd971770af4982ad4b0fe77f073", 10:01:20 INFO - "stage_platform": "linux64-pgo", 10:01:20 INFO - "builduid": "89936be38e294413b5af9017be76da6d", 10:01:20 INFO - "slavebuilddir": "test" 10:01:20 INFO - } 10:01:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:01:20 INFO - Running post-action listener: _resource_record_post_action 10:01:20 INFO - ##### 10:01:20 INFO - ##### Finished read-buildbot-config step (success) 10:01:20 INFO - ##### 10:01:20 INFO - ##### 10:01:20 INFO - ##### Running download-and-extract step. 10:01:20 INFO - ##### 10:01:20 INFO - Running pre-action listener: _resource_record_pre_action 10:01:20 INFO - Running main action method: download_and_extract 10:01:20 INFO - mkdir: /builds/slave/test/build/tests 10:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:20 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:01:30 INFO - Downloaded 1361 bytes. 10:01:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:30 INFO - Using the following test package requirements: 10:01:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'jsshell-linux-x86_64.zip'], 10:01:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:30 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')]} 10:01:30 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:34 INFO - Downloaded 24440437 bytes. 10:01:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:36 INFO - Return code: 0 10:01:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:01: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')]} 10:01:36 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:37 INFO - Downloaded 24440437 bytes. 10:01:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:38 INFO - Return code: 0 10:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:38 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:40 INFO - Downloaded 10833369 bytes. 10:01:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:01:40 INFO - Return code: 0 10:01:40 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')]} 10:01:40 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:01:41 INFO - Downloaded 59162600 bytes. 10:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:41 INFO - mkdir: /builds/slave/test/properties 10:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:41 INFO - Contents: 10:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:43 INFO - Running post-action listener: _resource_record_post_action 10:01:43 INFO - Running post-action listener: set_extra_try_arguments 10:01:43 INFO - ##### 10:01:43 INFO - ##### Finished download-and-extract step (success) 10:01:43 INFO - ##### 10:01:43 INFO - ##### 10:01:43 INFO - ##### Running populate-webroot step. 10:01:43 INFO - ##### 10:01:43 INFO - Running pre-action listener: _resource_record_pre_action 10:01:43 INFO - Running main action method: populate_webroot 10:01:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:43 INFO - '--tppagecycles', 10:01:43 INFO - '7'], 10:01:43 INFO - 'tests': ['tsvgm']}}, 10:01:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['damp', 'tps']}, 10:01:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'tests': ['damp', 'tps']}, 10:01:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['dromaeo_dom']}, 10:01:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['a11yr', 10:01:43 INFO - 'ts_paint', 10:01:43 INFO - 'tpaint', 10:01:43 INFO - 'sessionrestore', 10:01:43 INFO - 'sessionrestore_no_auto_restore', 10:01:43 INFO - 'tabpaint']}, 10:01:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['tsvgx', 10:01:43 INFO - 'tsvgr_opacity', 10:01:43 INFO - 'tart', 10:01:43 INFO - 'tscrollx', 10:01:43 INFO - 'cart']}, 10:01:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:43 INFO - 'tsvgr_opacity', 10:01:43 INFO - 'tart', 10:01:43 INFO - 'tscrollx', 10:01:43 INFO - 'cart']}, 10:01:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'talos_options': ['--disable-e10s'], 10:01:43 INFO - 'tests': ['tp5o']}, 10:01:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'tests': ['tp5o']}, 10:01:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'talos_options': ['--disable-e10s', 10:01:43 INFO - '--xperf_path', 10:01:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:43 INFO - 'tests': ['tp5n']}, 10:01:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:43 INFO - 'talos_options': ['--xperf_path', 10:01:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:43 INFO - 'tests': ['tp5n']}}, 10:01:43 INFO - 'talos.zip': {'path': '', 10:01:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:43 INFO - Running post-action listener: _resource_record_post_action 10:01:43 INFO - ##### 10:01:43 INFO - ##### Finished populate-webroot step (success) 10:01:43 INFO - ##### 10:01:43 INFO - ##### 10:01:43 INFO - ##### Running create-virtualenv step. 10:01:43 INFO - ##### 10:01:43 INFO - Running pre-action listener: _resource_record_pre_action 10:01:43 INFO - Running main action method: create_virtualenv 10:01:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:43 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 10:01:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:43 INFO - Using real prefix '/usr' 10:01:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:45 INFO - Installing pip.................done. 10:01:45 INFO - Return code: 0 10:01:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:45 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:45 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 10:01:45 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 10:01:45 INFO - Using env: {'DISPLAY': ':0', 10:01:45 INFO - 'HOME': '/home/cltbld', 10:01:45 INFO - 'LANG': 'en_US.UTF-8', 10:01:45 INFO - 'LANGUAGE': 'en_US:en', 10:01:45 INFO - 'LOGNAME': 'cltbld', 10:01:45 INFO - 'MAIL': '/var/mail/cltbld', 10:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:45 INFO - 'MOZ_NO_REMOTE': '1', 10:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:45 INFO - 'NO_EM_RESTART': '1', 10:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:45 INFO - 'PWD': '/builds/slave/test', 10:01:45 INFO - 'SHELL': '/bin/bash', 10:01:45 INFO - 'SHLVL': '1', 10:01:45 INFO - 'TERM': 'linux', 10:01:45 INFO - 'TMOUT': '86400', 10:01:45 INFO - 'USER': 'cltbld', 10:01:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:45 INFO - '_': '/tools/buildbot/bin/python'} 10:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:45 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 10:01:45 INFO - Cleaning up... 10:01:45 INFO - Return code: 0 10:01:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:45 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:45 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 10:01:45 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 10:01:45 INFO - Using env: {'DISPLAY': ':0', 10:01:45 INFO - 'HOME': '/home/cltbld', 10:01:45 INFO - 'LANG': 'en_US.UTF-8', 10:01:45 INFO - 'LANGUAGE': 'en_US:en', 10:01:45 INFO - 'LOGNAME': 'cltbld', 10:01:45 INFO - 'MAIL': '/var/mail/cltbld', 10:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:45 INFO - 'MOZ_NO_REMOTE': '1', 10:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:45 INFO - 'NO_EM_RESTART': '1', 10:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:45 INFO - 'PWD': '/builds/slave/test', 10:01:45 INFO - 'SHELL': '/bin/bash', 10:01:45 INFO - 'SHLVL': '1', 10:01:45 INFO - 'TERM': 'linux', 10:01:45 INFO - 'TMOUT': '86400', 10:01:45 INFO - 'USER': 'cltbld', 10:01:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:45 INFO - '_': '/tools/buildbot/bin/python'} 10:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:46 INFO - Downloading/unpacking psutil>=3.1.1 10:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:48 INFO - Installing collected packages: psutil 10:01:48 INFO - Running setup.py install for psutil 10:01:48 INFO - building 'psutil._psutil_linux' extension 10:01:48 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 10:01:48 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 10:01:48 INFO - building 'psutil._psutil_posix' extension 10:01:48 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 10:01:48 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 10:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:48 INFO - Successfully installed psutil 10:01:48 INFO - Cleaning up... 10:01:48 INFO - Return code: 0 10:01:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01:48 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')]} 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:48 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')]} 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:48 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:48 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 10:01:48 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 10:01:48 INFO - Using env: {'DISPLAY': ':0', 10:01:48 INFO - 'HOME': '/home/cltbld', 10:01:48 INFO - 'LANG': 'en_US.UTF-8', 10:01:48 INFO - 'LANGUAGE': 'en_US:en', 10:01:48 INFO - 'LOGNAME': 'cltbld', 10:01:48 INFO - 'MAIL': '/var/mail/cltbld', 10:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:48 INFO - 'MOZ_NO_REMOTE': '1', 10:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:48 INFO - 'NO_EM_RESTART': '1', 10:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:48 INFO - 'PWD': '/builds/slave/test', 10:01:48 INFO - 'SHELL': '/bin/bash', 10:01:48 INFO - 'SHLVL': '1', 10:01:48 INFO - 'TERM': 'linux', 10:01:48 INFO - 'TMOUT': '86400', 10:01:48 INFO - 'USER': 'cltbld', 10:01:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:48 INFO - '_': '/tools/buildbot/bin/python'} 10:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:50 INFO - Installing collected packages: mozsystemmonitor 10:01:50 INFO - Running setup.py install for mozsystemmonitor 10:01:50 INFO - Successfully installed mozsystemmonitor 10:01:50 INFO - Cleaning up... 10:01:50 INFO - Return code: 0 10:01:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:50 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')]} 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 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')]} 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:50 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 10:01:50 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 10:01:50 INFO - Using env: {'DISPLAY': ':0', 10:01:50 INFO - 'HOME': '/home/cltbld', 10:01:50 INFO - 'LANG': 'en_US.UTF-8', 10:01:50 INFO - 'LANGUAGE': 'en_US:en', 10:01:50 INFO - 'LOGNAME': 'cltbld', 10:01:50 INFO - 'MAIL': '/var/mail/cltbld', 10:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:50 INFO - 'MOZ_NO_REMOTE': '1', 10:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:50 INFO - 'NO_EM_RESTART': '1', 10:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:50 INFO - 'PWD': '/builds/slave/test', 10:01:50 INFO - 'SHELL': '/bin/bash', 10:01:50 INFO - 'SHLVL': '1', 10:01:50 INFO - 'TERM': 'linux', 10:01:50 INFO - 'TMOUT': '86400', 10:01:50 INFO - 'USER': 'cltbld', 10:01:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:50 INFO - '_': '/tools/buildbot/bin/python'} 10:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:51 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:51 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 10:01:51 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 10:01:51 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 10:01:51 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 10:01:51 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 10:01:51 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 10:01:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:53 INFO - warning: no files found matching '*.txt' 10:01:53 INFO - no previously-included directories found matching 'build' 10:01:53 INFO - no previously-included directories found matching 'dist' 10:01:53 INFO - no previously-included directories found matching '.git*' 10:01:53 INFO - Installing collected packages: jsonschema, functools32 10:01:53 INFO - Running setup.py install for functools32 10:01:53 INFO - warning: no files found matching '*.txt' 10:01:53 INFO - no previously-included directories found matching 'build' 10:01:53 INFO - no previously-included directories found matching 'dist' 10:01:53 INFO - no previously-included directories found matching '.git*' 10:01:53 INFO - Successfully installed jsonschema functools32 10:01:53 INFO - Cleaning up... 10:01:53 INFO - Return code: 0 10:01:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:01:53 INFO - Using env: {'DISPLAY': ':0', 10:01:53 INFO - 'HOME': '/home/cltbld', 10:01:53 INFO - 'LANG': 'en_US.UTF-8', 10:01:53 INFO - 'LANGUAGE': 'en_US:en', 10:01:53 INFO - 'LOGNAME': 'cltbld', 10:01:53 INFO - 'MAIL': '/var/mail/cltbld', 10:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:53 INFO - 'MOZ_NO_REMOTE': '1', 10:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:53 INFO - 'NO_EM_RESTART': '1', 10:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:53 INFO - 'PWD': '/builds/slave/test', 10:01:53 INFO - 'SHELL': '/bin/bash', 10:01:53 INFO - 'SHLVL': '1', 10:01:53 INFO - 'TERM': 'linux', 10:01:53 INFO - 'TMOUT': '86400', 10:01:53 INFO - 'USER': 'cltbld', 10:01:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:53 INFO - '_': '/tools/buildbot/bin/python'} 10:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:53 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:56 INFO - Downloading docopt-0.6.1.tar.gz 10:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:56 INFO - Running setup.py install for blobuploader 10:01:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:56 INFO - Running setup.py install for requests 10:01:56 INFO - Running setup.py install for docopt 10:01:56 INFO - Successfully installed blobuploader requests docopt 10:01:56 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:01:56 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 10:01:56 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 10:01:56 INFO - Using env: {'DISPLAY': ':0', 10:01:56 INFO - 'HOME': '/home/cltbld', 10:01:56 INFO - 'LANG': 'en_US.UTF-8', 10:01:56 INFO - 'LANGUAGE': 'en_US:en', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MAIL': '/var/mail/cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SHLVL': '1', 10:01:56 INFO - 'TERM': 'linux', 10:01:56 INFO - 'TMOUT': '86400', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - '_': '/tools/buildbot/bin/python'} 10:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:57 INFO - Running setup.py (path:/tmp/pip-_Er2vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:57 INFO - Running setup.py (path:/tmp/pip-Y0vTbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:57 INFO - Running setup.py (path:/tmp/pip-E4u5HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:57 INFO - Running setup.py (path:/tmp/pip-QZz1Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:57 INFO - Running setup.py (path:/tmp/pip-azGzv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:57 INFO - Running setup.py (path:/tmp/pip-zBGPEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:57 INFO - Running setup.py (path:/tmp/pip-JPQnuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:57 INFO - Running setup.py (path:/tmp/pip-A5TXen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:57 INFO - Running setup.py (path:/tmp/pip-FxFsCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:57 INFO - Running setup.py (path:/tmp/pip-z2fXbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:57 INFO - Running setup.py (path:/tmp/pip-iCWfNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:57 INFO - Running setup.py (path:/tmp/pip-crolmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:57 INFO - Running setup.py (path:/tmp/pip-HMdh8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:58 INFO - Running setup.py (path:/tmp/pip-fWPiXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:58 INFO - Running setup.py (path:/tmp/pip-v6n8Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:58 INFO - Running setup.py (path:/tmp/pip-xTTzZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:58 INFO - Running setup.py (path:/tmp/pip-3gvHRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:58 INFO - Running setup.py install for manifestparser 10:01:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:58 INFO - Running setup.py install for mozcrash 10:01:58 INFO - Running setup.py install for mozdebug 10:01:58 INFO - Running setup.py install for mozdevice 10:01:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:58 INFO - Running setup.py install for mozfile 10:01:58 INFO - Running setup.py install for mozhttpd 10:01:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:58 INFO - Running setup.py install for mozinfo 10:01:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for mozInstall 10:01:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for mozleak 10:01:59 INFO - Running setup.py install for mozlog 10:01:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for moznetwork 10:01:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for mozprocess 10:01:59 INFO - Running setup.py install for mozprofile 10:01:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for mozrunner 10:01:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:59 INFO - Running setup.py install for mozscreenshot 10:01:59 INFO - Running setup.py install for moztest 10:02:00 INFO - Running setup.py install for mozversion 10:02:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:00 INFO - Cleaning up... 10:02:00 INFO - Return code: 0 10:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:02:00 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 10:02:00 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 10:02:00 INFO - Using env: {'DISPLAY': ':0', 10:02:00 INFO - 'HOME': '/home/cltbld', 10:02:00 INFO - 'LANG': 'en_US.UTF-8', 10:02:00 INFO - 'LANGUAGE': 'en_US:en', 10:02:00 INFO - 'LOGNAME': 'cltbld', 10:02:00 INFO - 'MAIL': '/var/mail/cltbld', 10:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:00 INFO - 'MOZ_NO_REMOTE': '1', 10:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:00 INFO - 'NO_EM_RESTART': '1', 10:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:00 INFO - 'PWD': '/builds/slave/test', 10:02:00 INFO - 'SHELL': '/bin/bash', 10:02:00 INFO - 'SHLVL': '1', 10:02:00 INFO - 'TERM': 'linux', 10:02:00 INFO - 'TMOUT': '86400', 10:02:00 INFO - 'USER': 'cltbld', 10:02:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:00 INFO - '_': '/tools/buildbot/bin/python'} 10:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:00 INFO - Running setup.py (path:/tmp/pip-iQ3bGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:00 INFO - Running setup.py (path:/tmp/pip-Lu9kLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:00 INFO - Running setup.py (path:/tmp/pip-iCEkqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:00 INFO - Running setup.py (path:/tmp/pip-ra5LDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:00 INFO - Running setup.py (path:/tmp/pip-mE0kZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:00 INFO - Running setup.py (path:/tmp/pip-t_TKxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:00 INFO - Running setup.py (path:/tmp/pip-bwfXuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:00 INFO - Running setup.py (path:/tmp/pip-9ZLTWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:00 INFO - Running setup.py (path:/tmp/pip-YLOXoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:00 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)) 10:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:00 INFO - Running setup.py (path:/tmp/pip-UoBg97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:01 INFO - Running setup.py (path:/tmp/pip-yUzM6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:01 INFO - Running setup.py (path:/tmp/pip-AHF2fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:01 INFO - Running setup.py (path:/tmp/pip-8FBuhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:01 INFO - Running setup.py (path:/tmp/pip-PFSaet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:01 INFO - Running setup.py (path:/tmp/pip-udrWnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:01 INFO - Running setup.py (path:/tmp/pip-ewmPsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:01 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)) 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:01 INFO - Running setup.py (path:/tmp/pip-HDjKUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:03 INFO - Downloading blessings-1.6.tar.gz 10:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:03 INFO - Installing collected packages: blessings 10:02:03 INFO - Running setup.py install for blessings 10:02:03 INFO - Successfully installed blessings 10:02:03 INFO - Cleaning up... 10:02:03 INFO - Return code: 0 10:02:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:03 INFO - Reading from file tmpfile_stdout 10:02:03 INFO - Current package versions: 10:02:03 INFO - argparse == 1.2.1 10:02:03 INFO - blessings == 1.6 10:02:03 INFO - blobuploader == 1.2.4 10:02:03 INFO - docopt == 0.6.1 10:02:03 INFO - functools32 == 3.2.3-2 10:02:03 INFO - jsonschema == 2.5.1 10:02:03 INFO - manifestparser == 1.1 10:02:03 INFO - mozInstall == 1.12 10:02:03 INFO - mozcrash == 0.17 10:02:03 INFO - mozdebug == 0.1 10:02:03 INFO - mozdevice == 0.48 10:02:03 INFO - mozfile == 1.2 10:02:03 INFO - mozhttpd == 0.7 10:02:03 INFO - mozinfo == 0.9 10:02:03 INFO - mozleak == 0.1 10:02:03 INFO - mozlog == 3.2 10:02:03 INFO - moznetwork == 0.27 10:02:03 INFO - mozprocess == 0.22 10:02:03 INFO - mozprofile == 0.28 10:02:03 INFO - mozrunner == 6.11 10:02:03 INFO - mozscreenshot == 0.1 10:02:03 INFO - mozsystemmonitor == 0.3 10:02:03 INFO - moztest == 0.7 10:02:03 INFO - mozversion == 1.4 10:02:03 INFO - psutil == 3.1.1 10:02:03 INFO - requests == 1.2.3 10:02:03 INFO - wsgiref == 0.1.2 10:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:03 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:02:03 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 10:02:03 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 10:02:03 INFO - Using env: {'DISPLAY': ':0', 10:02:03 INFO - 'HOME': '/home/cltbld', 10:02:03 INFO - 'LANG': 'en_US.UTF-8', 10:02:03 INFO - 'LANGUAGE': 'en_US:en', 10:02:03 INFO - 'LOGNAME': 'cltbld', 10:02:03 INFO - 'MAIL': '/var/mail/cltbld', 10:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:03 INFO - 'MOZ_NO_REMOTE': '1', 10:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:03 INFO - 'NO_EM_RESTART': '1', 10:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:03 INFO - 'PWD': '/builds/slave/test', 10:02:03 INFO - 'SHELL': '/bin/bash', 10:02:03 INFO - 'SHLVL': '1', 10:02:03 INFO - 'TERM': 'linux', 10:02:03 INFO - 'TMOUT': '86400', 10:02:03 INFO - 'USER': 'cltbld', 10:02:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:03 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 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)) 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:04 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')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 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')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:02:04 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 10:02:04 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 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:02:04 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')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 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')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 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 0x7f7b7774ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', '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 10:02:04 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 10:02:04 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 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 INFO - Downloading/unpacking flake8 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:02:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:02:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:06 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 10:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:07 INFO - no previously-included directories found matching 'docs/_build' 10:02:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:02:07 INFO - Running setup.py install for pep8 10:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:07 INFO - no previously-included directories found matching 'docs/_build' 10:02:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:02:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:02:07 INFO - Cleaning up... 10:02:07 INFO - Return code: 0 10:02:07 INFO - Running post-action listener: _resource_record_post_action 10:02:07 INFO - Running post-action listener: _start_resource_monitoring 10:02:07 INFO - Starting resource monitoring. 10:02:07 INFO - ##### 10:02:07 INFO - ##### Finished create-virtualenv step (success) 10:02:07 INFO - ##### 10:02:07 INFO - ##### 10:02:07 INFO - ##### Running install step. 10:02:07 INFO - ##### 10:02:07 INFO - Running pre-action listener: _resource_record_pre_action 10:02:07 INFO - Running main action method: install 10:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:07 INFO - Reading from file tmpfile_stdout 10:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:07 INFO - Reading from file tmpfile_stdout 10:02:07 INFO - Output received: 10:02:07 INFO - Usage: mozinstall [options] installer 10:02:07 INFO - Options: 10:02:07 INFO - -h, --help show this help message and exit 10:02:07 INFO - -d DEST, --destination=DEST 10:02:07 INFO - Directory to install application into. [default: 10:02:07 INFO - "/builds/slave/test"] 10:02:07 INFO - --app=APP Application being installed. [default: firefox] 10:02:07 INFO - mkdir: /builds/slave/test/build/application 10:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:02:24 INFO - Reading from file tmpfile_stdout 10:02:24 INFO - Output received: 10:02:24 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:24 INFO - Running post-action listener: _resource_record_post_action 10:02:24 INFO - ##### 10:02:24 INFO - ##### Finished install step (success) 10:02:24 INFO - ##### 10:02:24 INFO - ##### 10:02:24 INFO - ##### Running run-tests step. 10:02:24 INFO - ##### 10:02:24 INFO - Running pre-action listener: _resource_record_pre_action 10:02:24 INFO - Running main action method: run_tests 10:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:24 INFO - Python 2.7.3 10:02:24 INFO - Return code: 0 10:02:24 INFO - grabbing minidump binary from tooltool 10:02:24 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')]} 10:02:24 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 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:24 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 10:02:24 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 10:02:24 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 10:02:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:24 INFO - Return code: 0 10:02:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:02:25 INFO - Return code: 0 10:02:25 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/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:02:25 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/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:02:25 INFO - Using env: {'DISPLAY': ':0', 10:02:25 INFO - 'HOME': '/home/cltbld', 10:02:25 INFO - 'LANG': 'en_US.UTF-8', 10:02:25 INFO - 'LANGUAGE': 'en_US:en', 10:02:25 INFO - 'LOGNAME': 'cltbld', 10:02:25 INFO - 'MAIL': '/var/mail/cltbld', 10:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:25 INFO - 'MOZ_NO_REMOTE': '1', 10:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:25 INFO - 'NO_EM_RESTART': '1', 10:02:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:25 INFO - 'PWD': '/builds/slave/test', 10:02:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:25 INFO - 'SHELL': '/bin/bash', 10:02:25 INFO - 'SHLVL': '1', 10:02:25 INFO - 'TERM': 'linux', 10:02:25 INFO - 'TMOUT': '86400', 10:02:25 INFO - 'USER': 'cltbld', 10:02:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465058842.572061-589619413', 10:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:25 INFO - '_': '/tools/buildbot/bin/python'} 10:02:25 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/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:02:25 INFO - mozversion application_buildid: 20160604073132 10:02:25 INFO - mozversion application_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 10:02:25 INFO - mozversion application_display_name: Nightly 10:02:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:25 INFO - mozversion application_name: Firefox 10:02:25 INFO - mozversion application_remotingname: firefox 10:02:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:25 INFO - mozversion application_vendor: Mozilla 10:02:25 INFO - mozversion application_version: 49.0a1 10:02:25 INFO - mozversion platform_buildid: 20160604073132 10:02:25 INFO - mozversion platform_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 10:02:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:25 INFO - mozversion platform_version: 49.0a1 10:02:25 INFO - using testdate: 1465059745 10:02:25 INFO - actual date: 1465059745 10:02:25 INFO - starting webserver on 'localhost:46606' 10:02:25 INFO - SUITE-START | Running 2 tests 10:02:25 INFO - TEST-START | dromaeo_css 10:02:25 INFO - operating with platform_type : linux_ 10:02:25 INFO - Initialising browser for dromaeo_css test... 10:02:25 INFO - TEST-INFO | started process 26393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5saVy/profile http://localhost:46606/getInfo.html) 10:02:29 INFO - PROCESS | 26393 | __metrics Screen width/height:1600/1200 10:02:29 INFO - PROCESS | 26393 | colorDepth:24 10:02:29 INFO - PROCESS | 26393 | Browser inner width/height: 1024/697 10:02:29 INFO - PROCESS | 26393 | __metrics 10:02:30 ERROR - PROCESS | 26393 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:02:31 INFO - TEST-INFO | 26393: exit 0 10:02:31 INFO - Browser initialized. 10:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:31 INFO - TEST-INFO | started process 26475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5saVy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:43 INFO - PROCESS | 26475 | RSS: Main: 156463104 10:02:43 INFO - PROCESS | 26475 | 10:03:34 INFO - PROCESS | 26475 | 1465059814301 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] 10:05:42 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46606/tests/dromaeo/cssquery-ext.html) 10:05:43 INFO - PROCESS | 26475 | RSS: Main: 278249472 10:05:43 INFO - PROCESS | 26475 | 10:08:45 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-ext.html (next: http://localhost:46606/tests/dromaeo/cssquery-jquery.html) 10:08:46 INFO - PROCESS | 26475 | RSS: Main: 240173056 10:08:46 INFO - PROCESS | 26475 | 10:11:48 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46606/tests/dromaeo/cssquery-mootools.html) 10:11:48 INFO - PROCESS | 26475 | RSS: Main: 235290624 10:11:48 INFO - PROCESS | 26475 | 10:14:50 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46606/tests/dromaeo/cssquery-prototype.html) 10:14:51 INFO - PROCESS | 26475 | RSS: Main: 230985728 10:14:51 INFO - PROCESS | 26475 | 10:17:54 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46606/tests/dromaeo/cssquery-yui.html) 10:17:54 INFO - PROCESS | 26475 | RSS: Main: 229511168 10:17:54 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | Cycle 1(1): loaded http://localhost:46606/tests/dromaeo/cssquery-yui.html (next: http://localhost:46606/tests/dromaeo/cssquery-dojo.html) 10:20:57 INFO - PROCESS | 26475 | RSS: Main: 309735424 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | __start_tp_report 10:20:57 INFO - PROCESS | 26475 | _x_x_mozilla_page_load 10:20:57 INFO - PROCESS | 26475 | _x_x_mozilla_page_load_details 10:20:57 INFO - PROCESS | 26475 | |i|pagename|runs| 10:20:57 INFO - PROCESS | 26475 | |0;dojo.html;3075.1850759548715;3101.348716769477;3114.7663925205616;3131.4989601663738;3159.4628913084775;5241.42344342122;5272.420033796284;5303.257543943851;5352.170413585895;5438.99378614956;5298.20526920962;5322.8137015204475;5332.200169974506;5349.037173308803;5418.783248670048;4866.221404575269;4940.382452193476;4942.579880710144;4976.309220720338;4986.301917731521;4944.33251511045;4995.625328100389;5000.19996800512;5000.4749501302385;5037.395512538501;4830.299606557047;4861.222204447289;4873.561379475864;4877.122118018773;4878.02439512099;4733.786979585927;4858.295547145644;4932;4935.5804756595735;4938.987507560942;4884.13600409662;4898.681585696954;4899.779509922062;4903.534164254425;4968.0312339093525;5335.1730481775;5358.437364076754;5376.946230537684;5384.542313903323;5388.030154572176;5575.609707320489;5616.775328986836;5637.238972738669;5639.943600563983;5724.713764311768;5694.572907031989;5765.1640512125505;5766.509846662997;5767.509761670263;5767.913481297784;5291.841244762663;5364.651297665679;5365.651232669903;5366.4096949335935;5374.543163831118;5700.97149514258;5819.098039803837;5845.766169353264;5881.5882888198275;5892.6759028253855;5658.547316214693;5677.318721753416;5709.600327977002;5710.885782284414;5717.113847353667;5594.021046316879;5716.914246286309;5763.423657634287;5808.419158084158;5826.766929322865;5688.715564221772;5738.225339579187;5738.655680659173;5777.422257774189;5778.162166485836;5730.713464326767;5777.45114214149;5778.133280008033;5783.681897495678;5785.421457854265;4241.448611680524;4281.05816720321;4394.1651086293505;4396.384506169139;4450.755208463565;3839.9040023999623;3872.5159355080614;3885.378339465672;3892.844286228519;3917.118648304109;5401.405845357008;5406.783728650888;5407.242985981966;5407.486288802557;5410.026195284808;5665.631733937281;5677.261955945701;5749;5757.337906140764;5814.040683287295;5325.467453254643;5327.334083239595;5350.6254562180275;5373.35519737634;5395.3525576931015;4960.454350021495;4974.0797952378925;4976.328195693607;4976.800927962841;5019.598432125421;5854.2389489366105;5869.647821130746;5926.851828704317;5931.3178984417345;5937.2578427696535;5741.3971532988435;5753.424657534213;5762.078067509178;5763.106718458645;5774.249347584871;5953.613015154001;5963.165156878127;5971.193888824953;5972.701364931823;5984.311804142405;5464.3442786865835;5615.410381910004;5631.0427227372265;5685.857853553529;5700.515456186271;5794.681292528951;5798.159266906359;5798.94201057984;5799.217105690846;5801.361850196559;5631.493165615114;5669.376368599368;5683.261176047087;5687.317521897234;5691.971540142273;5465.6447330923365;5530.668159910419;5559.833205003856;5582.720863956704;5630.549556035426;5481.369642491165;5504.422035686195;5506.669599824023;5511.311086114236;5512.4211957743855;5487.725613719378;5625.718714064362;5650.717464126695;5666.405027472056;5674.716264186856;5398.7300634967305;5469.042917489344;5478.205660179331;5527.419620939904;5537.667739935617 10:20:57 INFO - PROCESS | 26475 | |1;ext.html;583.1427801132334;629.2637613991631;633.5628416392692;648.7664440801314;649.6654223075116;42629.78685106574;43761.56238437615;43992.3401148983;44119.55880441194;46853.297200541936;45469;46063.76968115155;46069.76965115178;46097.7695111524;46161.30758038632;8629.482231066124;8776.69281575145;8800.119988001212;8801.031886492481;8804.383693141483;8669.826603467927;8767.079456657022;8776.341774366916;8779.165979231962;8783.121687831197;8797.648094076229;8833.646654133827;8845.469271843709;8854.468731876075;8858.645654173826;8757.2994160467;8810.118988101203;8812.471251724854;8814;8824.867626985568;8638.827223455559;8725.607347669371;8730.69442569507;8731.825363492695;8737.825243495094;42744.3588346172;42987.57012429867;43204.78397608023;43209.35185972213;43276.350854737204;3465.8093804840723;3705.74059815813;3758.0604848787802;3953.2291203215386;4306.246406878784;32741.6725832741;33048.173795655064;33176.67763256573;33242.83378583116;33371.83314083414;4098.549159592472;4136.462259906223;4147.564505726886;4148.8133034013545;4220.662347012231;368195;370089;370511;370897;372417.99999999726;56904.71547642235;57576.42423575794;57655.71172144113;57741;57826.7108664454;36122.63877361245;37121.62878371236;37140;38358;53769.73115134399;16382.590435238975;16441.342346306254;16444;16515.091669958267;16903.154842257838;12602.81095783564;12892.677683057811;12966.286854223108;12975.740485190243;13000.219986800823;19361.284424751197;19564.315248966217;19612.901935490518;19628.803711962984;19633.116509757096;7016.649167541603;7110.800489229484;7193.172785129673;7230.349268565749;7330.193678695339;1015.2892974917587;1072.3619446429361;1154.3565235610527;1225.4485481533345;1236.3200239868036;29814.403711926076;30017;30623;30652.233694157378;31095.68904310973;1161.7386088130104;1174.442139983501;1180.9527618895147;1212.7695737809963;1225.081189108169;16081.758773618405;16115;16270.43053493122;16281.91859040721;16529.421470248482;540579;540901;543383;545001;546432;57891;58393.70803145957;58420.12369814456;58472.12291815626;58566;1300.648824817294;1357.0771875124813;1383.0526089628636;1389.673426744714;1405.4940221520244;31830.6816931837;31981.200469988435;33410.832945835115;34465.65534344625;35542.64457355393;56382.7180864093;56969;57561;57616;57700.422995769506;472788;475429;477977;478938;479539;39199.8440085798;44216.33675494806;45581;45853;46681;47870.76064619655;51144.74427627838;51577.48422515877;51713;52230.738846305525;42365.152696945275;42810;42932.35601466043;43102.137957241306;43899.78050109729;41917.79041104897;42851.14297714091;42885.5711442894;43544.782276088416;43894.780526097165;42455.575444245165;43308.566914330455;43578.78210608927;43708.34437483504;43818.56181438145;36140;37716;38055.61944380632;38303;38626.80686596549;28940.42119157647;29188.27029324284;29269.268268293465;29272.70727292785;29475.410491790473 10:20:57 INFO - PROCESS | 26475 | |2;jquery.html;388.85417968261885;391.16681468472143;391.4246058294306;402.9576894426085;412.8864562245382;14376;16646.667066658658;18148.455546333615;19552.51118722031;19570.11934462949;18551.628967420642;18554.16506257218;18773.812261877378;18975.24099036037;19034.33379831706;5474.124140137569;5527.2538207341895;5543.6119471637;5552.750126244328;5553.389127196006;4092.0997380576227;5431.402545719968;5568.303962004749;5590.608657393984;5909.290885093795;6138.907916381258;6225.377462253761;6234.937650623504;6245.437910588046;6245.812625621216;6136.263648362181;6162.168107305523;6201.193844800147;6214.564980451393;6223.657698826562;5513.869656720402;5518.972405137949;5533.335999680024;5539.584531160179;5545.556355491551;21458.356249312546;21971.560568788536;22193.11227550896;22421.887890560607;22592.54814903709;2494.2517244826663;2522.318973877043;2723.9182824515296;2786.9721302786916;3019.3810268895045;9630.18143457807;9981.251406144496;10147.746306342327;10163.949180254125;13920;1939.7769256535396;2006.9096890639955;2039.7756246812987;2045.6829191475344;2084.3121769816075;80832;85072;86884.13115868824;87061;87417.56291218566;10493.895061049445;10596.470176491144;10660.840087398696;10702.518386672618;10733.677989660166;13293.468261269634;14168.64578385528;14771.556853294203;15032.549023529311;15051.849481505045;7733.651985660546;7845.293923546908;7869.370450364072;7889.171636978034;7932.762017139495;7262.382697470668;7265.782026539212;7281.308275713799;7440.627968601657;7447.622189894887;4533;4539.0921815637;4619.445666519972;4630.652701047367;4688.179568575486;1920.2894928876406;1920.836728878033;1977.8813271203774;1988.7812340642517;1999.3701983875033;948.6821914658528;1031.6904928521415;1088.3633074651418;1106.7454485468227;1124.606387764276;17548.859324144145;18094.457166285032;18647.347342843208;18940.526486837665;18979.525511862314;982.1700662939804;997.0677416615342;1028.9022542858415;1029.9330543514798;1047.120418848171;8936.821263574691;10286.228532859916;10457.215708821717;10462.843057354146;10493.108085812792;443298;447801;449018;495362;499186;87625.56187219151;89249.55375223083;90298;90622;91150;997.6009596161593;1012.0840639221369;1017.2726500552141;1021.2851004296873;1053.4995876958383;16454.506364809076;16482.83517164813;16579.751303730696;16810.663786724443;16857.578560536083;30194.396112078073;36913;38414.807925960195;39082.80458597689;42059.579404205564;50602;51436.74281628568;54514;54719;55015;8125;8443.113473085483;11796.882031179579;12482.375881205722;12693.873061269638;12715.618531444072;13325.933370333087;13433.328333583086;13643.249621270925;13718.65703357424;9131.817363652823;12112.45493952792;12414.503419863104;12644.494220231089;12750.298733569372;11635.418229088342;12125.514979401078;12157.513699451923;12179;12336.568220112253;12192.268463892195;12515.87484125147;12621.495140194289;12832.871671283168;12878.098533102593;12457.501699932263;12712.74574508523;12758.234505929302;12843.293618851052;12847.550335738204;8358.28954538871;8598.140185981352;8798.428102173339;12695;12890.742185156058 10:20:57 INFO - PROCESS | 26475 | |3;mootools.html;1365.078571963924;1523.4744013315405;1536.2933050796632;1684.4104563402802;1845.0866820923645;8380;8751.124887511245;8753.993290771572;8999.415038022524;9013.954930225356;8737.257333126692;8914.73255802327;8939.418937769056;8941.731748047552;8943;1995.0324092814974;2309.711286089239;2352.7059117610297;2367.9408014799683;2386.379541319252;2432.027189124347;2446.486237890036;2448.889799958997;2449.7795198432136;2449.938751531217;2349.48311371498;2387.940301492468;2397.1490121007055;2397.904083836653;2400.063975049732;2008.7187793708893;2298.1152256381247;2357.905683772647;2366.432056306491;2387.1883559589824;2310.4223944013997;2313.6066868632206;2320.4662927526597;2320.5706944215376;2348.272035668931;8786.64853405863;8845.557722113868;8851.60167792451;8854.203121719076;8864.645414183426;4995.650304478688;5132.461091585367;5140.126178549655;5143.639945203838;5146;3433.484977253407;3499.9825000874835;3586.2110335726097;3655.5247817783784;3666.853325866962;1156.9074474042056;1173.3781096019125;1185.4428418643224;1199.5621598116625;1200.495791767451;12600;12622.747545049047;12643;12648.241105533605;12669.113162078658;4723.291506274087;4736.384270044872;4752.28715692642;4795.544423279783;4882.731449770296;10700;10773.78452430947;10776.084032857138;10777.946110269555;10781.892181078245;4756.904861902743;5492.80775172867;5494.972525137428;5501.449855014466;5505.119180931032;4875.634327425386;5003.874903127378;5014.197728363444;5061.342025536656;5064.139096353629;3942.211557688474;3962.980185099056;4024.3561030235605;4036.6367026967714;4074.124063326399;1198.2031948754154;1276.942537585811;1285.2802430638872;1286.4082522039967;1297.6690943809267;1012.1497941728983;1021.1320377679062;1022.6829682798357;1027.8098551767946;1033.452270296744;6079.908801367983;6119.326874043852;6184.474319682878;6195.070739389128;6195.2255968004;445.59005714742517;461.5961034095167;467.92981052842345;471.51905056841827;474.1157740813358;4043.211573743092;4208.179405016053;4209.389638502461;4235.618794308527;4246.426732391149;10526.63156789524;10690.679279621623;10933;11111.111111111253;11166.832497512543;10970.232083754221;11128.221024528206;11150.832737508943;11162.330260184415;11169.720756980978;7727.806804829812;7965.561894095765;7969.362451003905;8161.918380816116;8233.79415514617;6087.726052327567;6295.937040629535;6363.90454143179;6446.806595802133;6449.226092868886;10125.240606954361;10313.762348518227;10400.479976001321;10451.111655509367;10587.364758114538;10486.632967846088;10500.212484063879;10618.8407173894;10679;10716.73208169802;6972.860542789217;7628.237176282328;7692.92307076922;7798.37612990948;8040.517568945882;8846.734597962071;8853.07042760501;8874.156955089256;8914.73255802327;8929.687460938836;7675.961620191863;7778.572178530235;7858.0570331560575;7976.521408715495;8111.432199745961;7627.4279429041935;7690.423218258541;7827.765167044998;7933.880991785012;7944.801379965547;7110.680019399243;7246.818829529304;7327.596982166032;7356;7367.594782287026;5199.506046925536;5281.313429254173;5361.35663720356;5372.5701943843615;5412.648177868426;5298.54962328191;5384.138537833927;5403.459654034565;5508.55931525469;5581.413951535031 10:20:57 INFO - PROCESS | 26475 | |4;prototype.html;331.18032868650096;333.1620973252271;342.7745808733776;343.4127641732637;343.9604445488768;5305.973470132653;5317.707526086064;5376.838694839152;5380.865478363038;5399.352077750676;5253.816116435925;5312.814051508198;5313.707746073965;5319.335083114611;5330.614040349508;4136.937945930814;4151.896202594944;4221.451211342536;4230.450041494617;4233.38615900695;4167.770772607505;4207.431996680455;4209.831606735742;4227.704060715751;4239.682023848209;4185.142045880602;4188.790560471979;4190.826568560808;4197.118605092935;4204.789760511962;3865.724310977399;3980.562138164785;4054.3107671695884;4067.6745860331102;4170.728902621335;3417.487376893461;3652.9634703653155;3658.981705091484;3667.927620894186;3685.8157092145284;5049.267856160873;5079.492050794891;5096.388433388017;5114.69311841287;5133.435322114565;4497.257952437876;4624.953750462486;4691.29630555416;4714.764261786897;4721.197396442613;5454.263674403945;5461.290032295816;5470.650832588062;5479.53423958964;5486.91769623456;4016;4034.334334834778;4035.5762644922447;4039.3537034074407;4041.8787436376956;5541.251930989305;5707.828765137053;5718.685472299022;5769.538436925078;5788.18965344852;4137.482814648169;4155.459790227251;4159.916801664011;4160.708750387444;4213.536510983789;4269.295566231599;4273.401723758676;4275.87172384829;4280.871573852789;4281.571842815693;4639.396878405786;4785.952140478551;4791.425028996543;4794.424669039668;4817.181079216542;5459.426760190123;5498.642588231752;5530.142827861688;5537.2524709163745;5552;1407.2822860341096;1434.6485111147626;1442.9927850360682;1454.163855782929;1462.9664765975303;911.5487833522449;943.4762857984443;951.8244967465175;954.1651055326589;966.367029595616;4652.813887444464;4685.320628508847;4739;4742.905141897143;4793.257045158006;4926.729029903389;4938.950610493921;4974.0797952378925;4996.975015124901;5062.443131255559;4665.6734028617675;4760.619150467955;4828.927566086511;4846.61227101831;4868.707877527359;2676.464707058596;2684.8926042958456;2694.8816241259656;2718.986405067962;2720.9863950680515;5147.716875571879;5152.9742351288005;5172.353455818023;5198.298229738937;5201.427842937273;4984.22744474607;5081.5426611605135;5083.771230294646;5227.660202086852;5601.495865372136;5747.8563035924435;5845.538615346163;5860.970695146497;5899.852503687443;5925.140854576062;5599.80400685974;5639.746211420414;5672.659640421588;5719.8856022880145;5724.198612194379;5416.322959630046;5629.7748090077575;5644.689542075225;5649.322081350264;5656.208130861601;5829.76680932758;5844.240248767633;5849.064149736022;5891.3224979127945;5921.7631294747725;4160.625543701081;4185.079282557833;4186.1418409225425;4186.539480657186;4188.743376986953;5507;5661.348944871393;5686.516646085129;5696.487316141567;5779.68211748341;5453.61824672285;5463.699496527729;5480.862978425571;5492.340919089735;5533.889322213614;5365.309927372865;5532.170174473861;5545.140503222007;5558.305211848519;5591.12697246427;5438.6192966493545;5489.627593101724;5507.256520369859;5508.173773933942;5508.283923089973;5467;5504.091824848855;5602.747876345493;5607.971960140173;5619.8479311740175;5255.921161182662;5386.48828361305;5415.377231618414;5415.945840541702;5422.969635769191 10:20:57 INFO - PROCESS | 26475 | |5;yui.html;686.0875036201852;744.6388501576735;769.9307062364386;822.2846123872231;869.5391442535455;14252.073615215017;15422.845771542296;15635.530934071967;15862.682746345066;16485.093319867403;16588.75116873248;16675.91662041688;16733.665326693488;16740.16299185042;16749.330026798943;681.3356976947462;797.6490344248541;824.8721448175543;825.9174082591722;828.0518805967164;796.80079980005;801.4670244287541;801.4750338528273;801.6633014134078;803.5299349880327;858.3991206155684;860.1355637584219;860.806318578318;861.0829466618063;861.29804209569;491.0204142735248;840.7771940435758;857.3227150551088;862.7109918177418;865.3855762408697;627.6202897247146;634.3783092569262;636.9904451433232;637.2735082006516;638.1767519899324;14867.628309292355;14888.10671359711;14890.553283401516;14904.403823847033;14934;13545.322733863268;13873.514426995007;13948.72102557943;13964.511242106477;13979.930100349535;12115.454804533729;12207.389630518528;12368.072394570354;12430.502779888884;12818.294993775338;4485.349624304457;4503.819847206108;4562.475315338712;4682.648801339913;4683.437987441494;73943;74496;74719.25280747232;74843;75206;10312.742181445525;10381.169506439466;10425.322354046963;10454.581816727397;10534.473276336152;16416.1791910404;16562.089085100437;16686.49940501787;16701.749473757904;16780.244888980025;8150.266476017068;8232.62953167109;8400.663973440995;8505.489670619783;8606.44058136219;4958.305837182797;4972.179590367621;4985.202367621163;5014.448410674823;5104.489551044866;3333.4166520858753;3430.639782822818;3441.82790860456;3447.1554469155217;3450.4996775467916;593.4243783530055;598.5480961873758;647.4270270810273;683.5795985469;689.2831455286546;785.1285073568334;800.1118758178417;807.7495976247264;817.5626040068535;823.5264722784423;10223.488825558692;10310.278280520291;10391.948040259751;10587.523561439753;10774.515146818412;701.382783150824;729.1942403644003;785.5358512032778;787.7676085554775;788.5505262000719;5014.648974571818;5024.2463630454995;5026.547610715053;5052.1663925451885;5165.251038599457;112781;121047;122779.38610306891;126743.366283168;130295;105416;105486.88093149423;106929.46535267273;107667.46166269119;109382.90617093728;91642.54178729196;94213.5289323549;94779.52610236904;94866;94972.52513737387;9366.578503967201;9787.265955053257;9810.16613587853;9947.204223661945;10068.597256109673;41519.58480415278;46974.29538556856;47535.286970694775;56227;58227.70886145542;74152;75739.62130189314;75822;76383.61808191145;76567;13244.404001820134;13464.326783660974;13464.394102265225;13592.406876790894;13705.246211458465;15728.685426291639;15782.842171578137;15871.841281587036;16345.509634710977;16546.089965052037;13774.711635279595;13898.861011389758;14102.506412275521;14589.635259118608;15013.849861501245;14093.295335233403;14214.786778198128;14914.850851491346;14929.10425374481;14941.103533788008;14370.928145359207;14790.408383664533;15063.472778452702;15242.237888105772;15300.846991529943;11540.192186546861;11856.644300670994;11987.501562304711;11988.940055300016;12786.872131278567;11836.526538938346;12116.697082572653;12308.630741077783;12376.381180940736;12398.13213075076 10:20:57 INFO - PROCESS | 26475 | __end_tp_report 10:20:57 INFO - PROCESS | 26475 | __start_cc_report 10:20:57 INFO - PROCESS | 26475 | _x_x_mozilla_cycle_collect,1028 10:20:57 INFO - PROCESS | 26475 | __end_cc_report 10:20:57 INFO - PROCESS | 26475 | __startTimestamp1465060857868__endTimestamp 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | ------- Summary: start ------- 10:20:57 INFO - PROCESS | 26475 | Number of tests: 6 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#0] dojo.html Cycles:165 Average:5329.07 Median:5504.42 stddev:602.06 (10.9%) stddev-sans-first:577.36 10:20:57 INFO - PROCESS | 26475 | Values: 3075.2 3101.3 3114.8 3131.5 3159.5 5241.4 5272.4 5303.3 5352.2 5439.0 5298.2 5322.8 5332.2 5349.0 5418.8 4866.2 4940.4 4942.6 4976.3 4986.3 4944.3 4995.6 5000.2 5000.5 5037.4 4830.3 4861.2 4873.6 4877.1 4878.0 4733.8 4858.3 4932.0 4935.6 4939.0 4884.1 4898.7 4899.8 4903.5 4968.0 5335.2 5358.4 5376.9 5384.5 5388.0 5575.6 5616.8 5637.2 5639.9 5724.7 5694.6 5765.2 5766.5 5767.5 5767.9 5291.8 5364.7 5365.7 5366.4 5374.5 5701.0 5819.1 5845.8 5881.6 5892.7 5658.5 5677.3 5709.6 5710.9 5717.1 5594.0 5716.9 5763.4 5808.4 5826.8 5688.7 5738.2 5738.7 5777.4 5778.2 5730.7 5777.5 5778.1 5783.7 5785.4 4241.4 4281.1 4394.2 4396.4 4450.8 3839.9 3872.5 3885.4 3892.8 3917.1 5401.4 5406.8 5407.2 5407.5 5410.0 5665.6 5677.3 5749.0 5757.3 5814.0 5325.5 5327.3 5350.6 5373.4 5395.4 4960.5 4974.1 4976.3 4976.8 5019.6 5854.2 5869.6 5926.9 5931.3 5937.3 5741.4 5753.4 5762.1 5763.1 5774.2 5953.6 5963.2 5971.2 5972.7 5984.3 5464.3 5615.4 5631.0 5685.9 5700.5 5794.7 5798.2 5798.9 5799.2 5801.4 5631.5 5669.4 5683.3 5687.3 5692.0 5465.6 5530.7 5559.8 5582.7 5630.5 5481.4 5504.4 5506.7 5511.3 5512.4 5487.7 5625.7 5650.7 5666.4 5674.7 5398.7 5469.0 5478.2 5527.4 5537.7 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#1] ext.html Cycles:180 Average:62633.75 Median:43153.46 stddev:124323.70 (288.1%) stddev-sans-first:124585.17 10:20:57 INFO - PROCESS | 26475 | Values: 583.1 629.3 633.6 648.8 649.7 42629.8 43761.6 43992.3 44119.6 46853.3 45469.0 46063.8 46069.8 46097.8 46161.3 8629.5 8776.7 8800.1 8801.0 8804.4 8669.8 8767.1 8776.3 8779.2 8783.1 8797.6 8833.6 8845.5 8854.5 8858.6 8757.3 8810.1 8812.5 8814.0 8824.9 8638.8 8725.6 8730.7 8731.8 8737.8 42744.4 42987.6 43204.8 43209.4 43276.4 3465.8 3705.7 3758.1 3953.2 4306.2 32741.7 33048.2 33176.7 33242.8 33371.8 4098.5 4136.5 4147.6 4148.8 4220.7 368195.0 370089.0 370511.0 370897.0 372418.0 56904.7 57576.4 57655.7 57741.0 57826.7 36122.6 37121.6 37140.0 38358.0 53769.7 16382.6 16441.3 16444.0 16515.1 16903.2 12602.8 12892.7 12966.3 12975.7 13000.2 19361.3 19564.3 19612.9 19628.8 19633.1 7016.6 7110.8 7193.2 7230.3 7330.2 1015.3 1072.4 1154.4 1225.4 1236.3 29814.4 30017.0 30623.0 30652.2 31095.7 1161.7 1174.4 1181.0 1212.8 1225.1 16081.8 16115.0 16270.4 16281.9 16529.4 540579.0 540901.0 543383.0 545001.0 546432.0 57891.0 58393.7 58420.1 58472.1 58566.0 1300.6 1357.1 1383.1 1389.7 1405.5 31830.7 31981.2 33410.8 34465.7 35542.6 56382.7 56969.0 57561.0 57616.0 57700.4 472788.0 475429.0 477977.0 478938.0 479539.0 39199.8 44216.3 45581.0 45853.0 46681.0 47870.8 51144.7 51577.5 51713.0 52230.7 42365.2 42810.0 42932.4 43102.1 43899.8 41917.8 42851.1 42885.6 43544.8 43894.8 42455.6 43308.6 43578.8 43708.3 43818.6 36140.0 37716.0 38055.6 38303.0 38626.8 28940.4 29188.3 29269.3 29272.7 29475.4 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#2] jquery.html Cycles:180 Average:28187.45 Median:22507.22 stddev:77192.44 (343.0%) stddev-sans-first:77380.76 10:20:57 INFO - PROCESS | 26475 | Values: 388.9 391.2 391.4 403.0 412.9 14376.0 16646.7 18148.5 19552.5 19570.1 18551.6 18554.2 18773.8 18975.2 19034.3 5474.1 5527.3 5543.6 5552.8 5553.4 4092.1 5431.4 5568.3 5590.6 5909.3 6138.9 6225.4 6234.9 6245.4 6245.8 6136.3 6162.2 6201.2 6214.6 6223.7 5513.9 5519.0 5533.3 5539.6 5545.6 21458.4 21971.6 22193.1 22421.9 22592.5 2494.3 2522.3 2723.9 2787.0 3019.4 9630.2 9981.3 10147.7 10163.9 13920.0 1939.8 2006.9 2039.8 2045.7 2084.3 80832.0 85072.0 86884.1 87061.0 87417.6 10493.9 10596.5 10660.8 10702.5 10733.7 13293.5 14168.6 14771.6 15032.5 15051.8 7733.7 7845.3 7869.4 7889.2 7932.8 7262.4 7265.8 7281.3 7440.6 7447.6 4533.0 4539.1 4619.4 4630.7 4688.2 1920.3 1920.8 1977.9 1988.8 1999.4 948.7 1031.7 1088.4 1106.7 1124.6 17548.9 18094.5 18647.3 18940.5 18979.5 982.2 997.1 1028.9 1029.9 1047.1 8936.8 10286.2 10457.2 10462.8 10493.1 443298.0 447801.0 449018.0 495362.0 499186.0 87625.6 89249.6 90298.0 90622.0 91150.0 997.6 1012.1 1017.3 1021.3 1053.5 16454.5 16482.8 16579.8 16810.7 16857.6 30194.4 36913.0 38414.8 39082.8 42059.6 50602.0 51436.7 54514.0 54719.0 55015.0 8125.0 8443.1 11796.9 12482.4 12693.9 12715.6 13325.9 13433.3 13643.2 13718.7 9131.8 12112.5 12414.5 12644.5 12750.3 11635.4 12125.5 12157.5 12179.0 12336.6 12192.3 12515.9 12621.5 12832.9 12878.1 12457.5 12712.7 12758.2 12843.3 12847.6 8358.3 8598.1 8798.4 12695.0 12890.7 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#3] mootools.html Cycles:180 Average:5913.46 Median:453.59 stddev:3384.42 (746.1%) stddev-sans-first:3376.65 10:20:57 INFO - PROCESS | 26475 | Values: 1365.1 1523.5 1536.3 1684.4 1845.1 8380.0 8751.1 8754.0 8999.4 9014.0 8737.3 8914.7 8939.4 8941.7 8943.0 1995.0 2309.7 2352.7 2367.9 2386.4 2432.0 2446.5 2448.9 2449.8 2449.9 2349.5 2387.9 2397.1 2397.9 2400.1 2008.7 2298.1 2357.9 2366.4 2387.2 2310.4 2313.6 2320.5 2320.6 2348.3 8786.6 8845.6 8851.6 8854.2 8864.6 4995.7 5132.5 5140.1 5143.6 5146.0 3433.5 3500.0 3586.2 3655.5 3666.9 1156.9 1173.4 1185.4 1199.6 1200.5 12600.0 12622.7 12643.0 12648.2 12669.1 4723.3 4736.4 4752.3 4795.5 4882.7 10700.0 10773.8 10776.1 10777.9 10781.9 4756.9 5492.8 5495.0 5501.4 5505.1 4875.6 5003.9 5014.2 5061.3 5064.1 3942.2 3963.0 4024.4 4036.6 4074.1 1198.2 1276.9 1285.3 1286.4 1297.7 1012.1 1021.1 1022.7 1027.8 1033.5 6079.9 6119.3 6184.5 6195.1 6195.2 445.6 461.6 467.9 471.5 474.1 4043.2 4208.2 4209.4 4235.6 4246.4 10526.6 10690.7 10933.0 11111.1 11166.8 10970.2 11128.2 11150.8 11162.3 11169.7 7727.8 7965.6 7969.4 8161.9 8233.8 6087.7 6295.9 6363.9 6446.8 6449.2 10125.2 10313.8 10400.5 10451.1 10587.4 10486.6 10500.2 10618.8 10679.0 10716.7 6972.9 7628.2 7692.9 7798.4 8040.5 8846.7 8853.1 8874.2 8914.7 8929.7 7676.0 7778.6 7858.1 7976.5 8111.4 7627.4 7690.4 7827.8 7933.9 7944.8 7110.7 7246.8 7327.6 7356.0 7367.6 5199.5 5281.3 5361.4 5372.6 5412.6 5298.5 5384.1 5403.5 5508.6 5581.4 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#4] prototype.html Cycles:180 Average:4587.42 Median:5105.54 stddev:1329.42 (26.0%) stddev-sans-first:1294.20 10:20:57 INFO - PROCESS | 26475 | Values: 331.2 333.2 342.8 343.4 344.0 5306.0 5317.7 5376.8 5380.9 5399.4 5253.8 5312.8 5313.7 5319.3 5330.6 4136.9 4151.9 4221.5 4230.5 4233.4 4167.8 4207.4 4209.8 4227.7 4239.7 4185.1 4188.8 4190.8 4197.1 4204.8 3865.7 3980.6 4054.3 4067.7 4170.7 3417.5 3653.0 3659.0 3667.9 3685.8 5049.3 5079.5 5096.4 5114.7 5133.4 4497.3 4625.0 4691.3 4714.8 4721.2 5454.3 5461.3 5470.7 5479.5 5486.9 4016.0 4034.3 4035.6 4039.4 4041.9 5541.3 5707.8 5718.7 5769.5 5788.2 4137.5 4155.5 4159.9 4160.7 4213.5 4269.3 4273.4 4275.9 4280.9 4281.6 4639.4 4786.0 4791.4 4794.4 4817.2 5459.4 5498.6 5530.1 5537.3 5552.0 1407.3 1434.6 1443.0 1454.2 1463.0 911.5 943.5 951.8 954.2 966.4 4652.8 4685.3 4739.0 4742.9 4793.3 4926.7 4939.0 4974.1 4997.0 5062.4 4665.7 4760.6 4828.9 4846.6 4868.7 2676.5 2684.9 2694.9 2719.0 2721.0 5147.7 5153.0 5172.4 5198.3 5201.4 4984.2 5081.5 5083.8 5227.7 5601.5 5747.9 5845.5 5861.0 5899.9 5925.1 5599.8 5639.7 5672.7 5719.9 5724.2 5416.3 5629.8 5644.7 5649.3 5656.2 5829.8 5844.2 5849.1 5891.3 5921.8 4160.6 4185.1 4186.1 4186.5 4188.7 5507.0 5661.3 5686.5 5696.5 5779.7 5453.6 5463.7 5480.9 5492.3 5533.9 5365.3 5532.2 5545.1 5558.3 5591.1 5438.6 5489.6 5507.3 5508.2 5508.3 5467.0 5504.1 5602.7 5608.0 5619.8 5255.9 5386.5 5415.4 5415.9 5423.0 10:20:57 INFO - PROCESS | 26475 | 10:20:57 INFO - PROCESS | 26475 | [#5] yui.html Cycles:180 Average:21552.60 Median:22485.04 stddev:31598.88 (140.5%) stddev-sans-first:31648.68 10:20:57 INFO - PROCESS | 26475 | Values: 686.1 744.6 769.9 822.3 869.5 14252.1 15422.8 15635.5 15862.7 16485.1 16588.8 16675.9 16733.7 16740.2 16749.3 681.3 797.6 824.9 825.9 828.1 796.8 801.5 801.5 801.7 803.5 858.4 860.1 860.8 861.1 861.3 491.0 840.8 857.3 862.7 865.4 627.6 634.4 637.0 637.3 638.2 14867.6 14888.1 14890.6 14904.4 14934.0 13545.3 13873.5 13948.7 13964.5 13979.9 12115.5 12207.4 12368.1 12430.5 12818.3 4485.3 4503.8 4562.5 4682.6 4683.4 73943.0 74496.0 74719.3 74843.0 75206.0 10312.7 10381.2 10425.3 10454.6 10534.5 16416.2 16562.1 16686.5 16701.7 16780.2 8150.3 8232.6 8400.7 8505.5 8606.4 4958.3 4972.2 4985.2 5014.4 5104.5 3333.4 3430.6 3441.8 3447.2 3450.5 593.4 598.5 647.4 683.6 689.3 785.1 800.1 807.7 817.6 823.5 10223.5 10310.3 10391.9 10587.5 10774.5 701.4 729.2 785.5 787.8 788.6 5014.6 5024.2 5026.5 5052.2 5165.3 112781.0 121047.0 122779.4 126743.4 130295.0 105416.0 105486.9 106929.5 107667.5 109382.9 91642.5 94213.5 94779.5 94866.0 94972.5 9366.6 9787.3 9810.2 9947.2 10068.6 41519.6 46974.3 47535.3 56227.0 58227.7 74152.0 75739.6 75822.0 76383.6 76567.0 13244.4 13464.3 13464.4 13592.4 13705.2 15728.7 15782.8 15871.8 16345.5 16546.1 13774.7 13898.9 14102.5 14589.6 15013.8 14093.3 14214.8 14914.9 14929.1 14941.1 14370.9 14790.4 15063.5 15242.2 15300.8 11540.2 11856.6 11987.5 11988.9 12786.9 11836.5 12116.7 12308.6 12376.4 12398.1 10:20:57 INFO - PROCESS | 26475 | -------- Summary: end -------- 10:20:57 INFO - PROCESS | 26475 | 10:20:58 INFO - TEST-INFO | 26475: exit 0 10:20:58 INFO - TEST-OK | dromaeo_css | took 1112882ms 10:20:58 INFO - TEST-START | kraken 10:20:58 INFO - operating with platform_type : linux_ 10:20:58 INFO - Initialising browser for kraken test... 10:20:58 INFO - TEST-INFO | started process 26661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnkbyso/profile http://localhost:46606/getInfo.html) 10:21:02 INFO - PROCESS | 26661 | __metrics Screen width/height:1600/1200 10:21:02 INFO - PROCESS | 26661 | colorDepth:24 10:21:02 INFO - PROCESS | 26661 | Browser inner width/height: 1024/697 10:21:02 INFO - PROCESS | 26661 | __metrics 10:21:03 ERROR - PROCESS | 26661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:21:04 INFO - TEST-INFO | 26661: exit 0 10:21:04 INFO - Browser initialized. 10:21:04 INFO - Running cycle 1/1 for kraken test... 10:21:04 INFO - TEST-INFO | started process 26742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnkbyso/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:16 INFO - PROCESS | 26742 | RSS: Main: 156196864 10:21:16 INFO - PROCESS | 26742 | 10:21:18 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46606/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:19 INFO - PROCESS | 26742 | RSS: Main: 214429696 10:21:19 INFO - PROCESS | 26742 | 10:21:22 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46606/tests/kraken/driver.html?testName=audio-dft) 10:21:22 INFO - PROCESS | 26742 | RSS: Main: 201773056 10:21:22 INFO - PROCESS | 26742 | 10:21:26 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46606/tests/kraken/driver.html?testName=audio-fft) 10:21:26 INFO - PROCESS | 26742 | RSS: Main: 269000704 10:21:26 INFO - PROCESS | 26742 | 10:21:28 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46606/tests/kraken/driver.html?testName=audio-oscillator) 10:21:29 INFO - PROCESS | 26742 | RSS: Main: 180273152 10:21:29 INFO - PROCESS | 26742 | 10:21:31 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:31 INFO - PROCESS | 26742 | RSS: Main: 183472128 10:21:32 INFO - PROCESS | 26742 | 10:21:35 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46606/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:35 INFO - PROCESS | 26742 | RSS: Main: 218570752 10:21:35 INFO - PROCESS | 26742 | 10:21:38 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46606/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:39 INFO - PROCESS | 26742 | RSS: Main: 220598272 10:21:39 INFO - PROCESS | 26742 | 10:21:42 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46606/tests/kraken/driver.html?testName=json-parse-financial) 10:21:42 INFO - PROCESS | 26742 | RSS: Main: 220626944 10:21:42 INFO - PROCESS | 26742 | 10:21:44 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:45 INFO - PROCESS | 26742 | RSS: Main: 206454784 10:21:45 INFO - PROCESS | 26742 | 10:21:46 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:47 INFO - PROCESS | 26742 | RSS: Main: 211304448 10:21:47 INFO - PROCESS | 26742 | 10:21:49 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:50 INFO - PROCESS | 26742 | RSS: Main: 218812416 10:21:50 INFO - PROCESS | 26742 | 10:21:52 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:53 INFO - PROCESS | 26742 | RSS: Main: 222027776 10:21:53 INFO - PROCESS | 26742 | 10:21:56 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:56 INFO - PROCESS | 26742 | RSS: Main: 222818304 10:21:56 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | Cycle 1(1): loaded http://localhost:46606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46606/tests/kraken/driver.html?testName=ai-astar) 10:21:58 INFO - PROCESS | 26742 | RSS: Main: 264015872 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | __start_tp_report 10:21:58 INFO - PROCESS | 26742 | _x_x_mozilla_page_load 10:21:58 INFO - PROCESS | 26742 | _x_x_mozilla_page_load_details 10:21:58 INFO - PROCESS | 26742 | |i|pagename|runs| 10:21:58 INFO - PROCESS | 26742 | |0;ai-astar;111;106;112;109;109;110;109;110;109;110 10:21:58 INFO - PROCESS | 26742 | |1;audio-beat-detection;159;125;130;171;126;125;150;132;194;130 10:21:58 INFO - PROCESS | 26742 | |2;audio-dft;162;160;161;159;160;161;160;160;161;163 10:21:58 INFO - PROCESS | 26742 | |3;audio-fft;75;74;74;129;75;76;76;75;99;73 10:21:58 INFO - PROCESS | 26742 | |4;audio-oscillator;85;84;116;86;85;85;112;84;84;121 10:21:58 INFO - PROCESS | 26742 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;116 10:21:58 INFO - PROCESS | 26742 | |6;imaging-darkroom;146;145;145;145;145;145;145;146;145;144 10:21:58 INFO - PROCESS | 26742 | |7;imaging-desaturate;95;95;95;95;95;94;96;95;94;94 10:21:58 INFO - PROCESS | 26742 | |8;json-parse-financial;53;53;53;53;54;54;52;52;57;53 10:21:58 INFO - PROCESS | 26742 | |9;json-stringify-tinderbox;63;62;62;62;62;62;62;62;62;62 10:21:58 INFO - PROCESS | 26742 | |10;stanford-crypto-aes;80;79;78;79;81;79;91;87;138;82 10:21:58 INFO - PROCESS | 26742 | |11;stanford-crypto-ccm;128;128;129;120;119;138;129;122;137;131 10:21:58 INFO - PROCESS | 26742 | |12;stanford-crypto-pbkdf2;160;159;159;159;159;163;159;160;161;161 10:21:58 INFO - PROCESS | 26742 | |13;stanford-crypto-sha256-iterative;64;66;62;61;63;64;65;62;62;65 10:21:58 INFO - PROCESS | 26742 | __end_tp_report 10:21:58 INFO - PROCESS | 26742 | __start_cc_report 10:21:58 INFO - PROCESS | 26742 | _x_x_mozilla_cycle_collect,1614 10:21:58 INFO - PROCESS | 26742 | __end_cc_report 10:21:58 INFO - PROCESS | 26742 | __startTimestamp1465060918612__endTimestamp 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | ------- Summary: start ------- 10:21:58 INFO - PROCESS | 26742 | Number of tests: 14 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.58 (1.4%) stddev-sans-first:1.58 10:21:58 INFO - PROCESS | 26742 | Values: 111.0 106.0 112.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:141.00 stddev:23.74 (16.8%) stddev-sans-first:24.57 10:21:58 INFO - PROCESS | 26742 | Values: 159.0 125.0 130.0 171.0 126.0 125.0 150.0 132.0 194.0 130.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 10:21:58 INFO - PROCESS | 26742 | Values: 162.0 160.0 161.0 159.0 160.0 161.0 160.0 160.0 161.0 163.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:18.02 (24.0%) stddev-sans-first:18.90 10:21:58 INFO - PROCESS | 26742 | Values: 75.0 74.0 74.0 129.0 75.0 76.0 76.0 75.0 99.0 73.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.50 stddev:15.43 (18.3%) stddev-sans-first:16.01 10:21:58 INFO - PROCESS | 26742 | Values: 85.0 84.0 116.0 86.0 85.0 85.0 112.0 84.0 84.0 121.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:21:58 INFO - PROCESS | 26742 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 10:21:58 INFO - PROCESS | 26742 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 144.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:21:58 INFO - PROCESS | 26742 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 94.0 94.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.43 (2.7%) stddev-sans-first:1.51 10:21:58 INFO - PROCESS | 26742 | Values: 53.0 53.0 53.0 53.0 54.0 54.0 52.0 52.0 57.0 53.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 10:21:58 INFO - PROCESS | 26742 | Values: 63.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:80.50 stddev:18.25 (22.7%) stddev-sans-first:19.16 10:21:58 INFO - PROCESS | 26742 | Values: 80.0 79.0 78.0 79.0 81.0 79.0 91.0 87.0 138.0 82.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:129.00 stddev:6.44 (5.0%) stddev-sans-first:6.83 10:21:58 INFO - PROCESS | 26742 | Values: 128.0 128.0 129.0 120.0 119.0 138.0 129.0 122.0 137.0 131.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 10:21:58 INFO - PROCESS | 26742 | Values: 160.0 159.0 159.0 159.0 159.0 163.0 159.0 160.0 161.0 161.0 10:21:58 INFO - PROCESS | 26742 | 10:21:58 INFO - PROCESS | 26742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.65 (2.6%) stddev-sans-first:1.73 10:21:58 INFO - PROCESS | 26742 | Values: 64.0 66.0 62.0 61.0 63.0 64.0 65.0 62.0 62.0 65.0 10:21:58 INFO - PROCESS | 26742 | -------- Summary: end -------- 10:21:58 INFO - PROCESS | 26742 | 10:21:59 INFO - TEST-INFO | 26742: exit 0 10:21:59 INFO - TEST-OK | kraken | took 60996ms 10:21:59 INFO - SUITE-END | took 1173s 10:21:59 INFO - Completed test suite (00:19:34) 10:21:59 INFO - javascript benchmark 10:21:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.1850759548715, 3101.348716769477, 3114.7663925205616, 3131.4989601663738, 3159.4628913084775, 5241.42344342122, 5272.420033796284, 5303.257543943851, 5352.170413585895, 5438.99378614956, 5298.20526920962, 5322.8137015204475, 5332.200169974506, 5349.037173308803, 5418.783248670048, 4866.221404575269, 4940.382452193476, 4942.579880710144, 4976.309220720338, 4986.301917731521, 4944.33251511045, 4995.625328100389, 5000.19996800512, 5000.4749501302385, 5037.395512538501, 4830.299606557047, 4861.222204447289, 4873.561379475864, 4877.122118018773, 4878.02439512099, 4733.786979585927, 4858.295547145644, 4932.0, 4935.5804756595735, 4938.987507560942, 4884.13600409662, 4898.681585696954, 4899.779509922062, 4903.534164254425, 4968.0312339093525, 5335.1730481775, 5358.437364076754, 5376.946230537684, 5384.542313903323, 5388.030154572176, 5575.609707320489, 5616.775328986836, 5637.238972738669, 5639.943600563983, 5724.713764311768, 5694.572907031989, 5765.1640512125505, 5766.509846662997, 5767.509761670263, 5767.913481297784, 5291.841244762663, 5364.651297665679, 5365.651232669903, 5366.4096949335935, 5374.543163831118, 5700.97149514258, 5819.098039803837, 5845.766169353264, 5881.5882888198275, 5892.6759028253855, 5658.547316214693, 5677.318721753416, 5709.600327977002, 5710.885782284414, 5717.113847353667, 5594.021046316879, 5716.914246286309, 5763.423657634287, 5808.419158084158, 5826.766929322865, 5688.715564221772, 5738.225339579187, 5738.655680659173, 5777.422257774189, 5778.162166485836, 5730.713464326767, 5777.45114214149, 5778.133280008033, 5783.681897495678, 5785.421457854265, 4241.448611680524, 4281.05816720321, 4394.1651086293505, 4396.384506169139, 4450.755208463565, 3839.9040023999623, 3872.5159355080614, 3885.378339465672, 3892.844286228519, 3917.118648304109, 5401.405845357008, 5406.783728650888, 5407.242985981966, 5407.486288802557, 5410.026195284808, 5665.631733937281, 5677.261955945701, 5749.0, 5757.337906140764, 5814.040683287295, 5325.467453254643, 5327.334083239595, 5350.6254562180275, 5373.35519737634, 5395.3525576931015, 4960.454350021495, 4974.0797952378925, 4976.328195693607, 4976.800927962841, 5019.598432125421, 5854.2389489366105, 5869.647821130746, 5926.851828704317, 5931.3178984417345, 5937.2578427696535, 5741.3971532988435, 5753.424657534213, 5762.078067509178, 5763.106718458645, 5774.249347584871, 5953.613015154001, 5963.165156878127, 5971.193888824953, 5972.701364931823, 5984.311804142405, 5464.3442786865835, 5615.410381910004, 5631.0427227372265, 5685.857853553529, 5700.515456186271, 5794.681292528951, 5798.159266906359, 5798.94201057984, 5799.217105690846, 5801.361850196559, 5631.493165615114, 5669.376368599368, 5683.261176047087, 5687.317521897234, 5691.971540142273, 5465.6447330923365, 5530.668159910419, 5559.833205003856, 5582.720863956704, 5630.549556035426, 5481.369642491165, 5504.422035686195, 5506.669599824023, 5511.311086114236, 5512.4211957743855, 5487.725613719378, 5625.718714064362, 5650.717464126695, 5666.405027472056, 5674.716264186856, 5398.7300634967305, 5469.042917489344, 5478.205660179331, 5527.419620939904, 5537.667739935617], "value": 5288.496951720511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.1427801132334, 629.2637613991631, 633.5628416392692, 648.7664440801314, 649.6654223075116, 42629.78685106574, 43761.56238437615, 43992.3401148983, 44119.55880441194, 46853.297200541936, 45469.0, 46063.76968115155, 46069.76965115178, 46097.7695111524, 46161.30758038632, 8629.482231066124, 8776.69281575145, 8800.119988001212, 8801.031886492481, 8804.383693141483, 8669.826603467927, 8767.079456657022, 8776.341774366916, 8779.165979231962, 8783.121687831197, 8797.648094076229, 8833.646654133827, 8845.469271843709, 8854.468731876075, 8858.645654173826, 8757.2994160467, 8810.118988101203, 8812.471251724854, 8814.0, 8824.867626985568, 8638.827223455559, 8725.607347669371, 8730.69442569507, 8731.825363492695, 8737.825243495094, 42744.3588346172, 42987.57012429867, 43204.78397608023, 43209.35185972213, 43276.350854737204, 3465.8093804840723, 3705.74059815813, 3758.0604848787802, 3953.2291203215386, 4306.246406878784, 32741.6725832741, 33048.173795655064, 33176.67763256573, 33242.83378583116, 33371.83314083414, 4098.549159592472, 4136.462259906223, 4147.564505726886, 4148.8133034013545, 4220.662347012231, 368195.0, 370089.0, 370511.0, 370897.0, 372417.99999999726, 56904.71547642235, 57576.42423575794, 57655.71172144113, 57741.0, 57826.7108664454, 36122.63877361245, 37121.62878371236, 37140.0, 38358.0, 53769.73115134399, 16382.590435238975, 16441.342346306254, 16444.0, 16515.091669958267, 16903.154842257838, 12602.81095783564, 12892.677683057811, 12966.286854223108, 12975.740485190243, 13000.219986800823, 19361.284424751197, 19564.315248966217, 19612.901935490518, 19628.803711962984, 19633.116509757096, 7016.649167541603, 7110.800489229484, 7193.172785129673, 7230.349268565749, 7330.193678695339, 1015.2892974917587, 1072.3619446429361, 1154.3565235610527, 1225.4485481533345, 1236.3200239868036, 29814.403711926076, 30017.0, 30623.0, 30652.233694157378, 31095.68904310973, 1161.7386088130104, 1174.442139983501, 1180.9527618895147, 1212.7695737809963, 1225.081189108169, 16081.758773618405, 16115.0, 16270.43053493122, 16281.91859040721, 16529.421470248482, 540579.0, 540901.0, 543383.0, 545001.0, 546432.0, 57891.0, 58393.70803145957, 58420.12369814456, 58472.12291815626, 58566.0, 1300.648824817294, 1357.0771875124813, 1383.0526089628636, 1389.673426744714, 1405.4940221520244, 31830.6816931837, 31981.200469988435, 33410.832945835115, 34465.65534344625, 35542.64457355393, 56382.7180864093, 56969.0, 57561.0, 57616.0, 57700.422995769506, 472788.0, 475429.0, 477977.0, 478938.0, 479539.0, 39199.8440085798, 44216.33675494806, 45581.0, 45853.0, 46681.0, 47870.76064619655, 51144.74427627838, 51577.48422515877, 51713.0, 52230.738846305525, 42365.152696945275, 42810.0, 42932.35601466043, 43102.137957241306, 43899.78050109729, 41917.79041104897, 42851.14297714091, 42885.5711442894, 43544.782276088416, 43894.780526097165, 42455.575444245165, 43308.566914330455, 43578.78210608927, 43708.34437483504, 43818.56181438145, 36140.0, 37716.0, 38055.61944380632, 38303.0, 38626.80686596549, 28940.42119157647, 29188.27029324284, 29269.268268293465, 29272.70727292785, 29475.410491790473], "value": 20626.60449607459, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.85417968261885, 391.16681468472143, 391.4246058294306, 402.9576894426085, 412.8864562245382, 14376.0, 16646.667066658658, 18148.455546333615, 19552.51118722031, 19570.11934462949, 18551.628967420642, 18554.16506257218, 18773.812261877378, 18975.24099036037, 19034.33379831706, 5474.124140137569, 5527.2538207341895, 5543.6119471637, 5552.750126244328, 5553.389127196006, 4092.0997380576227, 5431.402545719968, 5568.303962004749, 5590.608657393984, 5909.290885093795, 6138.907916381258, 6225.377462253761, 6234.937650623504, 6245.437910588046, 6245.812625621216, 6136.263648362181, 6162.168107305523, 6201.193844800147, 6214.564980451393, 6223.657698826562, 5513.869656720402, 5518.972405137949, 5533.335999680024, 5539.584531160179, 5545.556355491551, 21458.356249312546, 21971.560568788536, 22193.11227550896, 22421.887890560607, 22592.54814903709, 2494.2517244826663, 2522.318973877043, 2723.9182824515296, 2786.9721302786916, 3019.3810268895045, 9630.18143457807, 9981.251406144496, 10147.746306342327, 10163.949180254125, 13920.0, 1939.7769256535396, 2006.9096890639955, 2039.7756246812987, 2045.6829191475344, 2084.3121769816075, 80832.0, 85072.0, 86884.13115868824, 87061.0, 87417.56291218566, 10493.895061049445, 10596.470176491144, 10660.840087398696, 10702.518386672618, 10733.677989660166, 13293.468261269634, 14168.64578385528, 14771.556853294203, 15032.549023529311, 15051.849481505045, 7733.651985660546, 7845.293923546908, 7869.370450364072, 7889.171636978034, 7932.762017139495, 7262.382697470668, 7265.782026539212, 7281.308275713799, 7440.627968601657, 7447.622189894887, 4533.0, 4539.0921815637, 4619.445666519972, 4630.652701047367, 4688.179568575486, 1920.2894928876406, 1920.836728878033, 1977.8813271203774, 1988.7812340642517, 1999.3701983875033, 948.6821914658528, 1031.6904928521415, 1088.3633074651418, 1106.7454485468227, 1124.606387764276, 17548.859324144145, 18094.457166285032, 18647.347342843208, 18940.526486837665, 18979.525511862314, 982.1700662939804, 997.0677416615342, 1028.9022542858415, 1029.9330543514798, 1047.120418848171, 8936.821263574691, 10286.228532859916, 10457.215708821717, 10462.843057354146, 10493.108085812792, 443298.0, 447801.0, 449018.0, 495362.0, 499186.0, 87625.56187219151, 89249.55375223083, 90298.0, 90622.0, 91150.0, 997.6009596161593, 1012.0840639221369, 1017.2726500552141, 1021.2851004296873, 1053.4995876958383, 16454.506364809076, 16482.83517164813, 16579.751303730696, 16810.663786724443, 16857.578560536083, 30194.396112078073, 36913.0, 38414.807925960195, 39082.80458597689, 42059.579404205564, 50602.0, 51436.74281628568, 54514.0, 54719.0, 55015.0, 8125.0, 8443.113473085483, 11796.882031179579, 12482.375881205722, 12693.873061269638, 12715.618531444072, 13325.933370333087, 13433.328333583086, 13643.249621270925, 13718.65703357424, 9131.817363652823, 12112.45493952792, 12414.503419863104, 12644.494220231089, 12750.298733569372, 11635.418229088342, 12125.514979401078, 12157.513699451923, 12179.0, 12336.568220112253, 12192.268463892195, 12515.87484125147, 12621.495140194289, 12832.871671283168, 12878.098533102593, 12457.501699932263, 12712.74574508523, 12758.234505929302, 12843.293618851052, 12847.550335738204, 8358.28954538871, 8598.140185981352, 8798.428102173339, 12695.0, 12890.742185156058], "value": 9291.889085060846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.078571963924, 1523.4744013315405, 1536.2933050796632, 1684.4104563402802, 1845.0866820923645, 8380.0, 8751.124887511245, 8753.993290771572, 8999.415038022524, 9013.954930225356, 8737.257333126692, 8914.73255802327, 8939.418937769056, 8941.731748047552, 8943.0, 1995.0324092814974, 2309.711286089239, 2352.7059117610297, 2367.9408014799683, 2386.379541319252, 2432.027189124347, 2446.486237890036, 2448.889799958997, 2449.7795198432136, 2449.938751531217, 2349.48311371498, 2387.940301492468, 2397.1490121007055, 2397.904083836653, 2400.063975049732, 2008.7187793708893, 2298.1152256381247, 2357.905683772647, 2366.432056306491, 2387.1883559589824, 2310.4223944013997, 2313.6066868632206, 2320.4662927526597, 2320.5706944215376, 2348.272035668931, 8786.64853405863, 8845.557722113868, 8851.60167792451, 8854.203121719076, 8864.645414183426, 4995.650304478688, 5132.461091585367, 5140.126178549655, 5143.639945203838, 5146.0, 3433.484977253407, 3499.9825000874835, 3586.2110335726097, 3655.5247817783784, 3666.853325866962, 1156.9074474042056, 1173.3781096019125, 1185.4428418643224, 1199.5621598116625, 1200.495791767451, 12600.0, 12622.747545049047, 12643.0, 12648.241105533605, 12669.113162078658, 4723.291506274087, 4736.384270044872, 4752.28715692642, 4795.544423279783, 4882.731449770296, 10700.0, 10773.78452430947, 10776.084032857138, 10777.946110269555, 10781.892181078245, 4756.904861902743, 5492.80775172867, 5494.972525137428, 5501.449855014466, 5505.119180931032, 4875.634327425386, 5003.874903127378, 5014.197728363444, 5061.342025536656, 5064.139096353629, 3942.211557688474, 3962.980185099056, 4024.3561030235605, 4036.6367026967714, 4074.124063326399, 1198.2031948754154, 1276.942537585811, 1285.2802430638872, 1286.4082522039967, 1297.6690943809267, 1012.1497941728983, 1021.1320377679062, 1022.6829682798357, 1027.8098551767946, 1033.452270296744, 6079.908801367983, 6119.326874043852, 6184.474319682878, 6195.070739389128, 6195.2255968004, 445.59005714742517, 461.5961034095167, 467.92981052842345, 471.51905056841827, 474.1157740813358, 4043.211573743092, 4208.179405016053, 4209.389638502461, 4235.618794308527, 4246.426732391149, 10526.63156789524, 10690.679279621623, 10933.0, 11111.111111111253, 11166.832497512543, 10970.232083754221, 11128.221024528206, 11150.832737508943, 11162.330260184415, 11169.720756980978, 7727.806804829812, 7965.561894095765, 7969.362451003905, 8161.918380816116, 8233.79415514617, 6087.726052327567, 6295.937040629535, 6363.90454143179, 6446.806595802133, 6449.226092868886, 10125.240606954361, 10313.762348518227, 10400.479976001321, 10451.111655509367, 10587.364758114538, 10486.632967846088, 10500.212484063879, 10618.8407173894, 10679.0, 10716.73208169802, 6972.860542789217, 7628.237176282328, 7692.92307076922, 7798.37612990948, 8040.517568945882, 8846.734597962071, 8853.07042760501, 8874.156955089256, 8914.73255802327, 8929.687460938836, 7675.961620191863, 7778.572178530235, 7858.0570331560575, 7976.521408715495, 8111.432199745961, 7627.4279429041935, 7690.423218258541, 7827.765167044998, 7933.880991785012, 7944.801379965547, 7110.680019399243, 7246.818829529304, 7327.596982166032, 7356.0, 7367.594782287026, 5199.506046925536, 5281.313429254173, 5361.35663720356, 5372.5701943843615, 5412.648177868426, 5298.54962328191, 5384.138537833927, 5403.459654034565, 5508.55931525469, 5581.413951535031], "value": 4651.446899900948, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.18032868650096, 333.1620973252271, 342.7745808733776, 343.4127641732637, 343.9604445488768, 5305.973470132653, 5317.707526086064, 5376.838694839152, 5380.865478363038, 5399.352077750676, 5253.816116435925, 5312.814051508198, 5313.707746073965, 5319.335083114611, 5330.614040349508, 4136.937945930814, 4151.896202594944, 4221.451211342536, 4230.450041494617, 4233.38615900695, 4167.770772607505, 4207.431996680455, 4209.831606735742, 4227.704060715751, 4239.682023848209, 4185.142045880602, 4188.790560471979, 4190.826568560808, 4197.118605092935, 4204.789760511962, 3865.724310977399, 3980.562138164785, 4054.3107671695884, 4067.6745860331102, 4170.728902621335, 3417.487376893461, 3652.9634703653155, 3658.981705091484, 3667.927620894186, 3685.8157092145284, 5049.267856160873, 5079.492050794891, 5096.388433388017, 5114.69311841287, 5133.435322114565, 4497.257952437876, 4624.953750462486, 4691.29630555416, 4714.764261786897, 4721.197396442613, 5454.263674403945, 5461.290032295816, 5470.650832588062, 5479.53423958964, 5486.91769623456, 4016.0, 4034.334334834778, 4035.5762644922447, 4039.3537034074407, 4041.8787436376956, 5541.251930989305, 5707.828765137053, 5718.685472299022, 5769.538436925078, 5788.18965344852, 4137.482814648169, 4155.459790227251, 4159.916801664011, 4160.708750387444, 4213.536510983789, 4269.295566231599, 4273.401723758676, 4275.87172384829, 4280.871573852789, 4281.571842815693, 4639.396878405786, 4785.952140478551, 4791.425028996543, 4794.424669039668, 4817.181079216542, 5459.426760190123, 5498.642588231752, 5530.142827861688, 5537.2524709163745, 5552.0, 1407.2822860341096, 1434.6485111147626, 1442.9927850360682, 1454.163855782929, 1462.9664765975303, 911.5487833522449, 943.4762857984443, 951.8244967465175, 954.1651055326589, 966.367029595616, 4652.813887444464, 4685.320628508847, 4739.0, 4742.905141897143, 4793.257045158006, 4926.729029903389, 4938.950610493921, 4974.0797952378925, 4996.975015124901, 5062.443131255559, 4665.6734028617675, 4760.619150467955, 4828.927566086511, 4846.61227101831, 4868.707877527359, 2676.464707058596, 2684.8926042958456, 2694.8816241259656, 2718.986405067962, 2720.9863950680515, 5147.716875571879, 5152.9742351288005, 5172.353455818023, 5198.298229738937, 5201.427842937273, 4984.22744474607, 5081.5426611605135, 5083.771230294646, 5227.660202086852, 5601.495865372136, 5747.8563035924435, 5845.538615346163, 5860.970695146497, 5899.852503687443, 5925.140854576062, 5599.80400685974, 5639.746211420414, 5672.659640421588, 5719.8856022880145, 5724.198612194379, 5416.322959630046, 5629.7748090077575, 5644.689542075225, 5649.322081350264, 5656.208130861601, 5829.76680932758, 5844.240248767633, 5849.064149736022, 5891.3224979127945, 5921.7631294747725, 4160.625543701081, 4185.079282557833, 4186.1418409225425, 4186.539480657186, 4188.743376986953, 5507.0, 5661.348944871393, 5686.516646085129, 5696.487316141567, 5779.68211748341, 5453.61824672285, 5463.699496527729, 5480.862978425571, 5492.340919089735, 5533.889322213614, 5365.309927372865, 5532.170174473861, 5545.140503222007, 5558.305211848519, 5591.12697246427, 5438.6192966493545, 5489.627593101724, 5507.256520369859, 5508.173773933942, 5508.283923089973, 5467.0, 5504.091824848855, 5602.747876345493, 5607.971960140173, 5619.8479311740175, 5255.921161182662, 5386.48828361305, 5415.377231618414, 5415.945840541702, 5422.969635769191], "value": 4168.3691469763025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.0875036201852, 744.6388501576735, 769.9307062364386, 822.2846123872231, 869.5391442535455, 14252.073615215017, 15422.845771542296, 15635.530934071967, 15862.682746345066, 16485.093319867403, 16588.75116873248, 16675.91662041688, 16733.665326693488, 16740.16299185042, 16749.330026798943, 681.3356976947462, 797.6490344248541, 824.8721448175543, 825.9174082591722, 828.0518805967164, 796.80079980005, 801.4670244287541, 801.4750338528273, 801.6633014134078, 803.5299349880327, 858.3991206155684, 860.1355637584219, 860.806318578318, 861.0829466618063, 861.29804209569, 491.0204142735248, 840.7771940435758, 857.3227150551088, 862.7109918177418, 865.3855762408697, 627.6202897247146, 634.3783092569262, 636.9904451433232, 637.2735082006516, 638.1767519899324, 14867.628309292355, 14888.10671359711, 14890.553283401516, 14904.403823847033, 14934.0, 13545.322733863268, 13873.514426995007, 13948.72102557943, 13964.511242106477, 13979.930100349535, 12115.454804533729, 12207.389630518528, 12368.072394570354, 12430.502779888884, 12818.294993775338, 4485.349624304457, 4503.819847206108, 4562.475315338712, 4682.648801339913, 4683.437987441494, 73943.0, 74496.0, 74719.25280747232, 74843.0, 75206.0, 10312.742181445525, 10381.169506439466, 10425.322354046963, 10454.581816727397, 10534.473276336152, 16416.1791910404, 16562.089085100437, 16686.49940501787, 16701.749473757904, 16780.244888980025, 8150.266476017068, 8232.62953167109, 8400.663973440995, 8505.489670619783, 8606.44058136219, 4958.305837182797, 4972.179590367621, 4985.202367621163, 5014.448410674823, 5104.489551044866, 3333.4166520858753, 3430.639782822818, 3441.82790860456, 3447.1554469155217, 3450.4996775467916, 593.4243783530055, 598.5480961873758, 647.4270270810273, 683.5795985469, 689.2831455286546, 785.1285073568334, 800.1118758178417, 807.7495976247264, 817.5626040068535, 823.5264722784423, 10223.488825558692, 10310.278280520291, 10391.948040259751, 10587.523561439753, 10774.515146818412, 701.382783150824, 729.1942403644003, 785.5358512032778, 787.7676085554775, 788.5505262000719, 5014.648974571818, 5024.2463630454995, 5026.547610715053, 5052.1663925451885, 5165.251038599457, 112781.0, 121047.0, 122779.38610306891, 126743.366283168, 130295.0, 105416.0, 105486.88093149423, 106929.46535267273, 107667.46166269119, 109382.90617093728, 91642.54178729196, 94213.5289323549, 94779.52610236904, 94866.0, 94972.52513737387, 9366.578503967201, 9787.265955053257, 9810.16613587853, 9947.204223661945, 10068.597256109673, 41519.58480415278, 46974.29538556856, 47535.286970694775, 56227.0, 58227.70886145542, 74152.0, 75739.62130189314, 75822.0, 76383.61808191145, 76567.0, 13244.404001820134, 13464.326783660974, 13464.394102265225, 13592.406876790894, 13705.246211458465, 15728.685426291639, 15782.842171578137, 15871.841281587036, 16345.509634710977, 16546.089965052037, 13774.711635279595, 13898.861011389758, 14102.506412275521, 14589.635259118608, 15013.849861501245, 14093.295335233403, 14214.786778198128, 14914.850851491346, 14929.10425374481, 14941.103533788008, 14370.928145359207, 14790.408383664533, 15063.472778452702, 15242.237888105772, 15300.846991529943, 11540.192186546861, 11856.644300670994, 11987.501562304711, 11988.940055300016, 12786.872131278567, 11836.526538938346, 12116.697082572653, 12308.630741077783, 12376.381180940736, 12398.13213075076], "value": 7771.093107294193, "unit": "score"}], "name": "dromaeo_css", "value": 7311.242989658405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 130.0, 171.0, 126.0, 125.0, 150.0, 132.0, 194.0, 130.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0, 163.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 129.0, 75.0, 76.0, 76.0, 75.0, 99.0, 73.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 86.0, 85.0, 85.0, 112.0, 84.0, 84.0, 121.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 52.0, 52.0, 57.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 81.0, 79.0, 91.0, 87.0, 138.0, 82.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 129.0, 120.0, 119.0, 138.0, 129.0, 122.0, 137.0, 131.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 159.0, 159.0, 163.0, 159.0, 160.0, 161.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 62.0, 61.0, 63.0, 64.0, 65.0, 62.0, 62.0, 65.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1502.2, "alertThreshold": 2.0}]} 10:21:59 INFO - Return code: 0 10:21:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:59 ERROR - # TBPL SUCCESS # 10:21:59 INFO - Running post-action listener: _resource_record_post_action 10:21:59 INFO - ##### 10:21:59 INFO - ##### Finished run-tests step (success) 10:21:59 INFO - ##### 10:21:59 INFO - Running post-run listener: _resource_record_post_run 10:22:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541822976; Read time: 8; Write time: 503572 10:22:00 INFO - TinderboxPrint: CPU usage
13.2% 10:22:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:22:00 INFO - TinderboxPrint: I/O write bytes / time
541,822,976 / 503,572 10:22:00 INFO - TinderboxPrint: CPU idle
8,261.0 (86.8%) 10:22:00 INFO - TinderboxPrint: CPU user
1,206.1 (12.7%) 10:22:00 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 237056000; Read time: 0; Write time: 274768 10:22:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293175296; Read time: 8; Write time: 227164 10:22:00 INFO - Running post-run listener: _upload_blobber_files 10:22:00 INFO - Blob upload gear active. 10:22:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:00 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 10:22:00 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'] 10:22:00 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 10:22:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:01 INFO - (blobuploader) - INFO - Done attempting. 10:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:05 INFO - (blobuploader) - INFO - Done attempting. 10:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:06 INFO - (blobuploader) - INFO - Done attempting. 10:22:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:06 INFO - Return code: 0 10:22:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96086e7788698b7d53b9db4449addc48cebb1ac8642e04e935931d2782abd5c12614001c49d9e3fe744c08536e01f669770d0c8ecd70cfd078d5d70fa855a457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e069ccb416c4801b55b1b0dab6f41aae4f3f3cbf58db66545c69a431381b3d4b7b886b78246b300a256eadda7d27f1f82a99d9daba450ebb4621dfdf8dda81cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f3139f76f31b9f9f4ca4d0a3a0fe05d9116572b7e117282e3d54ddb509f91e0b694708f6e465c0ec524a75a7ad46f811490b165681a36010684f91e81abdf2"} 10:22:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:06 INFO - Contents: 10:22:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96086e7788698b7d53b9db4449addc48cebb1ac8642e04e935931d2782abd5c12614001c49d9e3fe744c08536e01f669770d0c8ecd70cfd078d5d70fa855a457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e069ccb416c4801b55b1b0dab6f41aae4f3f3cbf58db66545c69a431381b3d4b7b886b78246b300a256eadda7d27f1f82a99d9daba450ebb4621dfdf8dda81cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f3139f76f31b9f9f4ca4d0a3a0fe05d9116572b7e117282e3d54ddb509f91e0b694708f6e465c0ec524a75a7ad46f811490b165681a36010684f91e81abdf2"} 10:22:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:06 INFO - Copying logs to upload dir... 10:22:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.126904 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-04 10:22:06.054293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:06.059596) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 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/96086e7788698b7d53b9db4449addc48cebb1ac8642e04e935931d2782abd5c12614001c49d9e3fe744c08536e01f669770d0c8ecd70cfd078d5d70fa855a457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e069ccb416c4801b55b1b0dab6f41aae4f3f3cbf58db66545c69a431381b3d4b7b886b78246b300a256eadda7d27f1f82a99d9daba450ebb4621dfdf8dda81cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f3139f76f31b9f9f4ca4d0a3a0fe05d9116572b7e117282e3d54ddb509f91e0b694708f6e465c0ec524a75a7ad46f811490b165681a36010684f91e81abdf2"} build_url:https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96086e7788698b7d53b9db4449addc48cebb1ac8642e04e935931d2782abd5c12614001c49d9e3fe744c08536e01f669770d0c8ecd70cfd078d5d70fa855a457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e069ccb416c4801b55b1b0dab6f41aae4f3f3cbf58db66545c69a431381b3d4b7b886b78246b300a256eadda7d27f1f82a99d9daba450ebb4621dfdf8dda81cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f3139f76f31b9f9f4ca4d0a3a0fe05d9116572b7e117282e3d54ddb509f91e0b694708f6e465c0ec524a75a7ad46f811490b165681a36010684f91e81abdf2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:06.084710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:06.085056) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465058842.572061-589619413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:06.166678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 10:22:06.167034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 10:22:06.167348) ========= ========= Total master_lag: 0.16 =========