builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1466901085.57 results: success (0) buildid: 20160625162124 builduid: c270ad447da0449b88b05b100b73b116 revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.567461) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.568119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.568607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.612498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.613000) ========= 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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 17:31:26-- 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% 27.4M=0s 2016-06-25 17:31:26 (27.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.778131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.778464) ========= 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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015008 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.828248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:25.828617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 17:31:26,414 truncating revision to first 12 chars 2016-06-25 17:31:26,414 Setting DEBUG logging. 2016-06-25 17:31:26,414 attempt 1/10 2016-06-25 17:31:26,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59bc5cd1caa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 17:31:26,723 unpacking tar archive at: mozilla-central-59bc5cd1caa6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:26.505213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:26.505586) ========= script_repo_revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:26.506014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:26.506320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 17:31:26.518101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-06-25 17:31:26.518413) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:31:27 INFO - MultiFileLogger online at 20160625 17:31:27 in /builds/slave/test 17:31:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:31:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:31:27 INFO - {'append_to_log': False, 17:31:27 INFO - 'base_work_dir': '/builds/slave/test', 17:31:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:31:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:31:27 INFO - 'branch': 'Firefox-Non-PGO', 17:31:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:31:27 INFO - 'config_files': ('talos/linux_config.py',), 17:31:27 INFO - 'default_actions': ('clobber', 17:31:27 INFO - 'read-buildbot-config', 17:31:27 INFO - 'download-and-extract', 17:31:27 INFO - 'populate-webroot', 17:31:27 INFO - 'create-virtualenv', 17:31:27 INFO - 'install', 17:31:27 INFO - 'run-tests'), 17:31:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:31:27 INFO - 'download_minidump_stackwalk': True, 17:31:27 INFO - 'download_symbols': 'ondemand', 17:31:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:31:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:31:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:31:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:31:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:31:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:31:27 INFO - 'installer_path': 'installer.exe', 17:31:27 INFO - 'log_level': 'info', 17:31:27 INFO - 'log_name': 'talos', 17:31:27 INFO - 'log_to_console': True, 17:31:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:31:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:31:27 INFO - 'opt_config_files': (), 17:31:27 INFO - 'pip_index': False, 17:31:27 INFO - 'sps_profile': False, 17:31:27 INFO - 'sps_profile_interval': 0, 17:31:27 INFO - 'suite': 'dromaeojs-e10s', 17:31:27 INFO - 'system_bits': '32', 17:31:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:31:27 INFO - 'title': 'talos-linux64-ix-063', 17:31:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:31:27 INFO - 'use_talos_json': True, 17:31:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:31:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:31:27 INFO - 'work_dir': 'build'} 17:31:27 INFO - ##### 17:31:27 INFO - ##### Running clobber step. 17:31:27 INFO - ##### 17:31:27 INFO - Running pre-action listener: _resource_record_pre_action 17:31:27 INFO - Running main action method: clobber 17:31:27 INFO - rmtree: /builds/slave/test/build 17:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:31:27 INFO - Running post-action listener: _resource_record_post_action 17:31:27 INFO - ##### 17:31:27 INFO - ##### Finished clobber step (success) 17:31:27 INFO - ##### 17:31:27 INFO - ##### 17:31:27 INFO - ##### Running read-buildbot-config step. 17:31:27 INFO - ##### 17:31:27 INFO - Running pre-action listener: _resource_record_pre_action 17:31:27 INFO - Running main action method: read_buildbot_config 17:31:27 INFO - Using buildbot properties: 17:31:27 INFO - { 17:31:27 INFO - "project": "", 17:31:27 INFO - "product": "firefox", 17:31:27 INFO - "script_repo_revision": "production", 17:31:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:31:27 INFO - "repository": "", 17:31:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:31:27 INFO - "buildid": "20160625162124", 17:31:27 INFO - "pgo_build": "False", 17:31:27 INFO - "basedir": "/builds/slave/test", 17:31:27 INFO - "buildnumber": 363, 17:31:27 INFO - "slavename": "talos-linux64-ix-063", 17:31:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:31:27 INFO - "platform": "ubuntu64_hw", 17:31:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:31:27 INFO - "branch": "mozilla-central", 17:31:27 INFO - "repo_path": "mozilla-central", 17:31:27 INFO - "revision": "59bc5cd1caa619e2be168d5fa67803f9e96c4309", 17:31:27 INFO - "stage_platform": "linux64", 17:31:27 INFO - "builduid": "c270ad447da0449b88b05b100b73b116", 17:31:27 INFO - "slavebuilddir": "test" 17:31:27 INFO - } 17:31:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:31:27 INFO - Running post-action listener: _resource_record_post_action 17:31:27 INFO - ##### 17:31:27 INFO - ##### Finished read-buildbot-config step (success) 17:31:27 INFO - ##### 17:31:27 INFO - ##### 17:31:27 INFO - ##### Running download-and-extract step. 17:31:27 INFO - ##### 17:31:27 INFO - Running pre-action listener: _resource_record_pre_action 17:31:27 INFO - Running main action method: download_and_extract 17:31:27 INFO - mkdir: /builds/slave/test/build/tests 17:31:27 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')]} 17:31:27 INFO - https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:31:39 INFO - Downloaded 1361 bytes. 17:31:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:39 INFO - Using the following test package requirements: 17:31:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:31:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:31:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'jsshell-linux-x86_64.zip'], 17:31:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:31:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:31:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:31:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:31:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:31:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:31:39 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')]} 17:31:39 INFO - https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:31:45 INFO - Downloaded 22713069 bytes. 17:31:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:31:47 INFO - Return code: 0 17:31:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:47 INFO - https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:31:52 INFO - Downloaded 22713069 bytes. 17:31:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:31:53 INFO - Return code: 0 17:31: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')]} 17:31:53 INFO - https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:31:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:31:54 INFO - Downloaded 14405188 bytes. 17:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:31:54 INFO - Return code: 0 17:31:54 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')]} 17:31:54 INFO - https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:31:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:31:56 INFO - Downloaded 56275615 bytes. 17:31:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:56 INFO - mkdir: /builds/slave/test/properties 17:31:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:56 INFO - Contents: 17:31:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:56 INFO - Running post-action listener: _resource_record_post_action 17:31:56 INFO - Running post-action listener: set_extra_try_arguments 17:31:56 INFO - ##### 17:31:56 INFO - ##### Finished download-and-extract step (success) 17:31:56 INFO - ##### 17:31:56 INFO - ##### 17:31:56 INFO - ##### Running populate-webroot step. 17:31:56 INFO - ##### 17:31:56 INFO - Running pre-action listener: _resource_record_pre_action 17:31:56 INFO - Running main action method: populate_webroot 17:31:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:56 INFO - '--tppagecycles', 17:31:56 INFO - '7'], 17:31:56 INFO - 'tests': ['tsvgm']}}, 17:31:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['damp', 'tps']}, 17:31:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'tests': ['damp', 'tps']}, 17:31:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['dromaeo_dom']}, 17:31:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['basic_compositor_video']}, 17:31:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:31:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['a11yr', 17:31:56 INFO - 'ts_paint', 17:31:56 INFO - 'tpaint', 17:31:56 INFO - 'sessionrestore', 17:31:56 INFO - 'sessionrestore_no_auto_restore', 17:31:56 INFO - 'tabpaint']}, 17:31:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['tsvgx', 17:31:56 INFO - 'tsvgr_opacity', 17:31:56 INFO - 'tart', 17:31:56 INFO - 'tscrollx', 17:31:56 INFO - 'cart']}, 17:31:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:56 INFO - 'tsvgr_opacity', 17:31:56 INFO - 'tart', 17:31:56 INFO - 'tscrollx', 17:31:56 INFO - 'cart']}, 17:31:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'talos_options': ['--disable-e10s'], 17:31:56 INFO - 'tests': ['tp5o']}, 17:31:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'tests': ['tp5o']}, 17:31:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'talos_options': ['--disable-e10s', 17:31:56 INFO - '--xperf_path', 17:31:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:56 INFO - 'tests': ['tp5n']}, 17:31:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:56 INFO - 'talos_options': ['--xperf_path', 17:31:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:56 INFO - 'tests': ['tp5n']}}, 17:31:56 INFO - 'talos.zip': {'path': '', 17:31:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:56 INFO - Running post-action listener: _resource_record_post_action 17:31:56 INFO - ##### 17:31:56 INFO - ##### Finished populate-webroot step (success) 17:31:56 INFO - ##### 17:31:56 INFO - ##### 17:31:56 INFO - ##### Running create-virtualenv step. 17:31:56 INFO - ##### 17:31:56 INFO - Running pre-action listener: _resource_record_pre_action 17:31:56 INFO - Running main action method: create_virtualenv 17:31:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:56 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 17:31:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:57 INFO - Using real prefix '/usr' 17:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:59 INFO - Installing pip.................done. 17:31:59 INFO - Return code: 0 17:31:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:31:59 INFO - Using env: {'DISPLAY': ':0', 17:31:59 INFO - 'HOME': '/home/cltbld', 17:31:59 INFO - 'LANG': 'en_US.UTF-8', 17:31:59 INFO - 'LANGUAGE': 'en_US:en', 17:31:59 INFO - 'LOGNAME': 'cltbld', 17:31:59 INFO - 'MAIL': '/var/mail/cltbld', 17:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:59 INFO - 'MOZ_NO_REMOTE': '1', 17:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:59 INFO - 'NO_EM_RESTART': '1', 17:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:59 INFO - 'PWD': '/builds/slave/test', 17:31:59 INFO - 'SHELL': '/bin/bash', 17:31:59 INFO - 'SHLVL': '1', 17:31:59 INFO - 'TERM': 'linux', 17:31:59 INFO - 'TMOUT': '86400', 17:31:59 INFO - 'USER': 'cltbld', 17:31:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:59 INFO - '_': '/tools/buildbot/bin/python'} 17:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:00 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 17:32:00 INFO - Cleaning up... 17:32:00 INFO - Return code: 0 17:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:32:00 INFO - Using env: {'DISPLAY': ':0', 17:32:00 INFO - 'HOME': '/home/cltbld', 17:32:00 INFO - 'LANG': 'en_US.UTF-8', 17:32:00 INFO - 'LANGUAGE': 'en_US:en', 17:32:00 INFO - 'LOGNAME': 'cltbld', 17:32:00 INFO - 'MAIL': '/var/mail/cltbld', 17:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:00 INFO - 'MOZ_NO_REMOTE': '1', 17:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:00 INFO - 'NO_EM_RESTART': '1', 17:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:00 INFO - 'PWD': '/builds/slave/test', 17:32:00 INFO - 'SHELL': '/bin/bash', 17:32:00 INFO - 'SHLVL': '1', 17:32:00 INFO - 'TERM': 'linux', 17:32:00 INFO - 'TMOUT': '86400', 17:32:00 INFO - 'USER': 'cltbld', 17:32:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:00 INFO - '_': '/tools/buildbot/bin/python'} 17:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:00 INFO - Downloading/unpacking psutil>=3.1.1 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:02 INFO - Installing collected packages: psutil 17:32:02 INFO - Running setup.py install for psutil 17:32:02 INFO - building 'psutil._psutil_linux' extension 17:32:02 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 17:32:02 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 17:32:02 INFO - building 'psutil._psutil_posix' extension 17:32:02 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 17:32:02 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 17:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:02 INFO - Successfully installed psutil 17:32:02 INFO - Cleaning up... 17:32:02 INFO - Return code: 0 17:32:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:32:02 INFO - Using env: {'DISPLAY': ':0', 17:32:02 INFO - 'HOME': '/home/cltbld', 17:32:02 INFO - 'LANG': 'en_US.UTF-8', 17:32:02 INFO - 'LANGUAGE': 'en_US:en', 17:32:02 INFO - 'LOGNAME': 'cltbld', 17:32:02 INFO - 'MAIL': '/var/mail/cltbld', 17:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:02 INFO - 'MOZ_NO_REMOTE': '1', 17:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:02 INFO - 'NO_EM_RESTART': '1', 17:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:02 INFO - 'PWD': '/builds/slave/test', 17:32:02 INFO - 'SHELL': '/bin/bash', 17:32:02 INFO - 'SHLVL': '1', 17:32:02 INFO - 'TERM': 'linux', 17:32:02 INFO - 'TMOUT': '86400', 17:32:02 INFO - 'USER': 'cltbld', 17:32:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:02 INFO - '_': '/tools/buildbot/bin/python'} 17:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:32:03 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 17:32:03 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 17:32:03 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 17:32:03 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 17:32:03 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 17:32:03 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 17:32:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:32:05 INFO - Installing collected packages: mozsystemmonitor 17:32:05 INFO - Running setup.py install for mozsystemmonitor 17:32:05 INFO - Successfully installed mozsystemmonitor 17:32:05 INFO - Cleaning up... 17:32:05 INFO - Return code: 0 17:32:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:05 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:05 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 17:32:05 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 17:32:05 INFO - Using env: {'DISPLAY': ':0', 17:32:05 INFO - 'HOME': '/home/cltbld', 17:32:05 INFO - 'LANG': 'en_US.UTF-8', 17:32:05 INFO - 'LANGUAGE': 'en_US:en', 17:32:05 INFO - 'LOGNAME': 'cltbld', 17:32:05 INFO - 'MAIL': '/var/mail/cltbld', 17:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:05 INFO - 'MOZ_NO_REMOTE': '1', 17:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:05 INFO - 'NO_EM_RESTART': '1', 17:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:05 INFO - 'PWD': '/builds/slave/test', 17:32:05 INFO - 'SHELL': '/bin/bash', 17:32:05 INFO - 'SHLVL': '1', 17:32:05 INFO - 'TERM': 'linux', 17:32:05 INFO - 'TMOUT': '86400', 17:32:05 INFO - 'USER': 'cltbld', 17:32:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:05 INFO - '_': '/tools/buildbot/bin/python'} 17:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:32:05 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 17:32:05 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 17:32:05 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 17:32:05 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 17:32:05 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 17:32:05 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 17:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:32:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:32:07 INFO - warning: no files found matching '*.txt' 17:32:07 INFO - no previously-included directories found matching 'build' 17:32:07 INFO - no previously-included directories found matching 'dist' 17:32:07 INFO - no previously-included directories found matching '.git*' 17:32:07 INFO - Installing collected packages: jsonschema, functools32 17:32:07 INFO - Running setup.py install for functools32 17:32:07 INFO - warning: no files found matching '*.txt' 17:32:07 INFO - no previously-included directories found matching 'build' 17:32:07 INFO - no previously-included directories found matching 'dist' 17:32:07 INFO - no previously-included directories found matching '.git*' 17:32:07 INFO - Successfully installed jsonschema functools32 17:32:07 INFO - Cleaning up... 17:32:07 INFO - Return code: 0 17:32:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:32:07 INFO - Using env: {'DISPLAY': ':0', 17:32:07 INFO - 'HOME': '/home/cltbld', 17:32:07 INFO - 'LANG': 'en_US.UTF-8', 17:32:07 INFO - 'LANGUAGE': 'en_US:en', 17:32:07 INFO - 'LOGNAME': 'cltbld', 17:32:07 INFO - 'MAIL': '/var/mail/cltbld', 17:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:07 INFO - 'MOZ_NO_REMOTE': '1', 17:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:07 INFO - 'NO_EM_RESTART': '1', 17:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:07 INFO - 'PWD': '/builds/slave/test', 17:32:07 INFO - 'SHELL': '/bin/bash', 17:32:07 INFO - 'SHLVL': '1', 17:32:07 INFO - 'TERM': 'linux', 17:32:07 INFO - 'TMOUT': '86400', 17:32:07 INFO - 'USER': 'cltbld', 17:32:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:07 INFO - '_': '/tools/buildbot/bin/python'} 17:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:07 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 17:32:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:32:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:32:09 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 17:32:09 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 17:32:09 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 17:32:09 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 17:32:09 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 17:32:09 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 17:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:10 INFO - Downloading docopt-0.6.1.tar.gz 17:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:32:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:32:10 INFO - Running setup.py install for blobuploader 17:32:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:32:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:32:10 INFO - Running setup.py install for requests 17:32:11 INFO - Running setup.py install for docopt 17:32:11 INFO - Successfully installed blobuploader requests docopt 17:32:11 INFO - Cleaning up... 17:32:11 INFO - Return code: 0 17:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:11 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:11 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 17:32:11 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 17:32:11 INFO - Using env: {'DISPLAY': ':0', 17:32:11 INFO - 'HOME': '/home/cltbld', 17:32:11 INFO - 'LANG': 'en_US.UTF-8', 17:32:11 INFO - 'LANGUAGE': 'en_US:en', 17:32:11 INFO - 'LOGNAME': 'cltbld', 17:32:11 INFO - 'MAIL': '/var/mail/cltbld', 17:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:11 INFO - 'MOZ_NO_REMOTE': '1', 17:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:11 INFO - 'NO_EM_RESTART': '1', 17:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:11 INFO - 'PWD': '/builds/slave/test', 17:32:11 INFO - 'SHELL': '/bin/bash', 17:32:11 INFO - 'SHLVL': '1', 17:32:11 INFO - 'TERM': 'linux', 17:32:11 INFO - 'TMOUT': '86400', 17:32:11 INFO - 'USER': 'cltbld', 17:32:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:11 INFO - '_': '/tools/buildbot/bin/python'} 17:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:11 INFO - Running setup.py (path:/tmp/pip-CV6VQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:11 INFO - Running setup.py (path:/tmp/pip-3Tj6hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:11 INFO - Running setup.py (path:/tmp/pip-OvX4uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:11 INFO - Running setup.py (path:/tmp/pip-FxmeOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:11 INFO - Running setup.py (path:/tmp/pip-Rg5gMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:11 INFO - Running setup.py (path:/tmp/pip-ODGheP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:11 INFO - Running setup.py (path:/tmp/pip-UUDkxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:11 INFO - Running setup.py (path:/tmp/pip-qvwyCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:11 INFO - Running setup.py (path:/tmp/pip-FiFyyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:12 INFO - Running setup.py (path:/tmp/pip-Pzfm_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:12 INFO - Running setup.py (path:/tmp/pip-oTNtDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:12 INFO - Running setup.py (path:/tmp/pip-2S7sY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:12 INFO - Running setup.py (path:/tmp/pip-YkCGtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:12 INFO - Running setup.py (path:/tmp/pip-yEa7ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:12 INFO - Running setup.py (path:/tmp/pip-aZLyF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:12 INFO - Running setup.py (path:/tmp/pip-zMEsVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:12 INFO - Running setup.py (path:/tmp/pip-uy49Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:12 INFO - Running setup.py install for manifestparser 17:32:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:12 INFO - Running setup.py install for mozcrash 17:32:12 INFO - Running setup.py install for mozdebug 17:32:12 INFO - Running setup.py install for mozdevice 17:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozfile 17:32:13 INFO - Running setup.py install for mozhttpd 17:32:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozinfo 17:32:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozInstall 17:32:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozleak 17:32:13 INFO - Running setup.py install for mozlog 17:32:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for moznetwork 17:32:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozprocess 17:32:13 INFO - Running setup.py install for mozprofile 17:32:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:13 INFO - Running setup.py install for mozrunner 17:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:14 INFO - Running setup.py install for mozscreenshot 17:32:14 INFO - Running setup.py install for moztest 17:32:14 INFO - Running setup.py install for mozversion 17:32:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:14 INFO - Cleaning up... 17:32:14 INFO - Return code: 0 17:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:14 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')]} 17:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:14 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')]} 17:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:14 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:14 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 17:32:14 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 17:32:14 INFO - Using env: {'DISPLAY': ':0', 17:32:14 INFO - 'HOME': '/home/cltbld', 17:32:14 INFO - 'LANG': 'en_US.UTF-8', 17:32:14 INFO - 'LANGUAGE': 'en_US:en', 17:32:14 INFO - 'LOGNAME': 'cltbld', 17:32:14 INFO - 'MAIL': '/var/mail/cltbld', 17:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:14 INFO - 'MOZ_NO_REMOTE': '1', 17:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:14 INFO - 'NO_EM_RESTART': '1', 17:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:14 INFO - 'PWD': '/builds/slave/test', 17:32:14 INFO - 'SHELL': '/bin/bash', 17:32:14 INFO - 'SHLVL': '1', 17:32:14 INFO - 'TERM': 'linux', 17:32:14 INFO - 'TMOUT': '86400', 17:32:14 INFO - 'USER': 'cltbld', 17:32:14 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:14 INFO - '_': '/tools/buildbot/bin/python'} 17:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:14 INFO - Running setup.py (path:/tmp/pip-G2pjOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:14 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)) 17:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:14 INFO - Running setup.py (path:/tmp/pip-CrFYde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:14 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)) 17:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:14 INFO - Running setup.py (path:/tmp/pip-f7h9T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:14 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)) 17:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:14 INFO - Running setup.py (path:/tmp/pip-c4qV8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:14 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)) 17:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:14 INFO - Running setup.py (path:/tmp/pip-xN3nbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:15 INFO - Running setup.py (path:/tmp/pip-npxjnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:15 INFO - Running setup.py (path:/tmp/pip-v9k8gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:15 INFO - Running setup.py (path:/tmp/pip-ZUflkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:15 INFO - Running setup.py (path:/tmp/pip-8qjjS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:15 INFO - Running setup.py (path:/tmp/pip-VbvRTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:15 INFO - Running setup.py (path:/tmp/pip-UqCA8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:15 INFO - Running setup.py (path:/tmp/pip-alXXfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:15 INFO - Running setup.py (path:/tmp/pip-47KBql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:15 INFO - Running setup.py (path:/tmp/pip-HZfyAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:15 INFO - Running setup.py (path:/tmp/pip-klJ6WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:15 INFO - Running setup.py (path:/tmp/pip-pX0pzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:15 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)) 17:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:15 INFO - Running setup.py (path:/tmp/pip-vyytwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:15 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)) 17:32:15 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)) 17:32:15 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)) 17:32:15 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)) 17:32:15 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)) 17:32:15 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)) 17:32:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:17 INFO - Downloading blessings-1.6.tar.gz 17:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:17 INFO - Installing collected packages: blessings 17:32:17 INFO - Running setup.py install for blessings 17:32:17 INFO - Successfully installed blessings 17:32:17 INFO - Cleaning up... 17:32:18 INFO - Return code: 0 17:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:18 INFO - Reading from file tmpfile_stdout 17:32:18 INFO - Current package versions: 17:32:18 INFO - argparse == 1.2.1 17:32:18 INFO - blessings == 1.6 17:32:18 INFO - blobuploader == 1.2.4 17:32:18 INFO - docopt == 0.6.1 17:32:18 INFO - functools32 == 3.2.3-2 17:32:18 INFO - jsonschema == 2.5.1 17:32:18 INFO - manifestparser == 1.1 17:32:18 INFO - mozInstall == 1.12 17:32:18 INFO - mozcrash == 0.17 17:32:18 INFO - mozdebug == 0.1 17:32:18 INFO - mozdevice == 0.48 17:32:18 INFO - mozfile == 1.2 17:32:18 INFO - mozhttpd == 0.7 17:32:18 INFO - mozinfo == 0.9 17:32:18 INFO - mozleak == 0.1 17:32:18 INFO - mozlog == 3.2 17:32:18 INFO - moznetwork == 0.27 17:32:18 INFO - mozprocess == 0.22 17:32:18 INFO - mozprofile == 0.28 17:32:18 INFO - mozrunner == 6.11 17:32:18 INFO - mozscreenshot == 0.1 17:32:18 INFO - mozsystemmonitor == 0.3 17:32:18 INFO - moztest == 0.7 17:32:18 INFO - mozversion == 1.4 17:32:18 INFO - psutil == 3.1.1 17:32:18 INFO - requests == 1.2.3 17:32:18 INFO - wsgiref == 0.1.2 17:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:18 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')]} 17:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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')]} 17:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:18 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 17:32:18 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 17:32:18 INFO - Using env: {'DISPLAY': ':0', 17:32:18 INFO - 'HOME': '/home/cltbld', 17:32:18 INFO - 'LANG': 'en_US.UTF-8', 17:32:18 INFO - 'LANGUAGE': 'en_US:en', 17:32:18 INFO - 'LOGNAME': 'cltbld', 17:32:18 INFO - 'MAIL': '/var/mail/cltbld', 17:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:18 INFO - 'MOZ_NO_REMOTE': '1', 17:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:18 INFO - 'NO_EM_RESTART': '1', 17:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:18 INFO - 'PWD': '/builds/slave/test', 17:32:18 INFO - 'SHELL': '/bin/bash', 17:32:18 INFO - 'SHLVL': '1', 17:32:18 INFO - 'TERM': 'linux', 17:32:18 INFO - 'TMOUT': '86400', 17:32:18 INFO - 'USER': 'cltbld', 17:32:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:18 INFO - '_': '/tools/buildbot/bin/python'} 17:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 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)) 17:32:18 INFO - Cleaning up... 17:32:18 INFO - Return code: 0 17:32:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32:18 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')]} 17:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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')]} 17:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:18 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 17:32:18 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 17:32:18 INFO - Using env: {'DISPLAY': ':0', 17:32:18 INFO - 'HOME': '/home/cltbld', 17:32:18 INFO - 'LANG': 'en_US.UTF-8', 17:32:18 INFO - 'LANGUAGE': 'en_US:en', 17:32:18 INFO - 'LOGNAME': 'cltbld', 17:32:18 INFO - 'MAIL': '/var/mail/cltbld', 17:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:18 INFO - 'MOZ_NO_REMOTE': '1', 17:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:18 INFO - 'NO_EM_RESTART': '1', 17:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:18 INFO - 'PWD': '/builds/slave/test', 17:32:18 INFO - 'SHELL': '/bin/bash', 17:32:18 INFO - 'SHLVL': '1', 17:32:18 INFO - 'TERM': 'linux', 17:32:18 INFO - 'TMOUT': '86400', 17:32:18 INFO - 'USER': 'cltbld', 17:32:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:18 INFO - '_': '/tools/buildbot/bin/python'} 17:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:32:18 INFO - Cleaning up... 17:32:18 INFO - Return code: 0 17:32:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:32:18 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')]} 17:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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')]} 17:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:18 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 0x7f0ea2b2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', '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 17:32:18 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 17:32:18 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 17:32:18 INFO - Using env: {'DISPLAY': ':0', 17:32:18 INFO - 'HOME': '/home/cltbld', 17:32:18 INFO - 'LANG': 'en_US.UTF-8', 17:32:18 INFO - 'LANGUAGE': 'en_US:en', 17:32:18 INFO - 'LOGNAME': 'cltbld', 17:32:18 INFO - 'MAIL': '/var/mail/cltbld', 17:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:18 INFO - 'MOZ_NO_REMOTE': '1', 17:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:18 INFO - 'NO_EM_RESTART': '1', 17:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:18 INFO - 'PWD': '/builds/slave/test', 17:32:18 INFO - 'SHELL': '/bin/bash', 17:32:18 INFO - 'SHLVL': '1', 17:32:18 INFO - 'TERM': 'linux', 17:32:18 INFO - 'TMOUT': '86400', 17:32:18 INFO - 'USER': 'cltbld', 17:32:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:18 INFO - '_': '/tools/buildbot/bin/python'} 17:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:18 INFO - Downloading/unpacking flake8 17:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:32:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:32:20 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 17:32:20 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 17:32:20 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 17:32:20 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 17:32:20 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 17:32:20 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 17:32:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:32:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 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 17:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:21 INFO - no previously-included directories found matching 'docs/_build' 17:32:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:32:21 INFO - Running setup.py install for pep8 17:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:21 INFO - no previously-included directories found matching 'docs/_build' 17:32:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:32:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:32:21 INFO - Cleaning up... 17:32:21 INFO - Return code: 0 17:32:21 INFO - Running post-action listener: _resource_record_post_action 17:32:21 INFO - Running post-action listener: _start_resource_monitoring 17:32:21 INFO - Starting resource monitoring. 17:32:21 INFO - ##### 17:32:21 INFO - ##### Finished create-virtualenv step (success) 17:32:21 INFO - ##### 17:32:21 INFO - ##### 17:32:21 INFO - ##### Running install step. 17:32:21 INFO - ##### 17:32:21 INFO - Running pre-action listener: _resource_record_pre_action 17:32:21 INFO - Running main action method: install 17:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:22 INFO - Reading from file tmpfile_stdout 17:32:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:22 INFO - Reading from file tmpfile_stdout 17:32:22 INFO - Output received: 17:32:22 INFO - Usage: mozinstall [options] installer 17:32:22 INFO - Options: 17:32:22 INFO - -h, --help show this help message and exit 17:32:22 INFO - -d DEST, --destination=DEST 17:32:22 INFO - Directory to install application into. [default: 17:32:22 INFO - "/builds/slave/test"] 17:32:22 INFO - --app=APP Application being installed. [default: firefox] 17:32:22 INFO - mkdir: /builds/slave/test/build/application 17:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:32:46 INFO - Reading from file tmpfile_stdout 17:32:47 INFO - Output received: 17:32:47 INFO - /builds/slave/test/build/application/firefox/firefox 17:32:48 INFO - Running post-action listener: _resource_record_post_action 17:32:48 INFO - ##### 17:32:48 INFO - ##### Finished install step (success) 17:32:48 INFO - ##### 17:32:48 INFO - ##### 17:32:48 INFO - ##### Running run-tests step. 17:32:48 INFO - ##### 17:32:48 INFO - Running pre-action listener: _resource_record_pre_action 17:32:48 INFO - Running main action method: run_tests 17:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:32:48 INFO - Python 2.7.3 17:32:48 INFO - Return code: 0 17:32:48 INFO - grabbing minidump binary from tooltool 17:32: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')]} 17:32:48 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 0x185a1c0>, '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 0x185b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:32:48 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 17:32:48 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 17:32:48 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 17:32:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:32:49 INFO - Return code: 0 17:32:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:32:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:32:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:32:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:32:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:32:49 INFO - Return code: 0 17:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:32:49 INFO - Using env: {'DISPLAY': ':0', 17:32:49 INFO - 'HOME': '/home/cltbld', 17:32:49 INFO - 'LANG': 'en_US.UTF-8', 17:32:49 INFO - 'LANGUAGE': 'en_US:en', 17:32:49 INFO - 'LOGNAME': 'cltbld', 17:32:49 INFO - 'MAIL': '/var/mail/cltbld', 17:32:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:32:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:49 INFO - 'MOZ_NO_REMOTE': '1', 17:32:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:49 INFO - 'NO_EM_RESTART': '1', 17:32:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:49 INFO - 'PWD': '/builds/slave/test', 17:32:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:32:49 INFO - 'SHELL': '/bin/bash', 17:32:49 INFO - 'SHLVL': '1', 17:32:49 INFO - 'TERM': 'linux', 17:32:49 INFO - 'TMOUT': '86400', 17:32:49 INFO - 'USER': 'cltbld', 17:32:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387', 17:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:49 INFO - '_': '/tools/buildbot/bin/python'} 17:32:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:32:50 INFO - mozversion application_buildid: 20160625162124 17:32:50 INFO - mozversion application_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 17:32:50 INFO - mozversion application_display_name: Nightly 17:32:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:32:50 INFO - mozversion application_name: Firefox 17:32:50 INFO - mozversion application_remotingname: firefox 17:32:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:32:50 INFO - mozversion application_vendor: Mozilla 17:32:50 INFO - mozversion application_version: 50.0a1 17:32:50 INFO - mozversion platform_buildid: 20160625162124 17:32:50 INFO - mozversion platform_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 17:32:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:32:50 INFO - mozversion platform_version: 50.0a1 17:32:50 INFO - using testdate: 1466901170 17:32:50 INFO - actual date: 1466901170 17:32:50 INFO - starting webserver on 'localhost:33438' 17:32:50 INFO - SUITE-START | Running 2 tests 17:32:50 INFO - TEST-START | dromaeo_css 17:32:50 INFO - operating with platform_type : linux_ 17:32:50 INFO - Initialising browser for dromaeo_css test... 17:32:50 INFO - TEST-INFO | started process 18439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIZfIu4/profile http://localhost:33438/getInfo.html) 17:32:58 INFO - PROCESS | 18439 | __metrics Screen width/height:1600/1200 17:32:58 INFO - PROCESS | 18439 | colorDepth:24 17:32:58 INFO - PROCESS | 18439 | Browser inner width/height: 1024/697 17:32:58 INFO - PROCESS | 18439 | __metrics 17:32:59 ERROR - PROCESS | 18439 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:33:00 INFO - TEST-INFO | 18439: exit 0 17:33:00 INFO - Browser initialized. 17:33:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:00 INFO - TEST-INFO | started process 18558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIZfIu4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:12 INFO - PROCESS | 18558 | RSS: Main: 185745408 17:33:12 INFO - PROCESS | 18558 | 17:34:02 INFO - PROCESS | 18558 | 1466901242446 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] 17:36:14 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33438/tests/dromaeo/cssquery-ext.html) 17:36:15 INFO - PROCESS | 18558 | RSS: Main: 188780544 17:36:15 INFO - PROCESS | 18558 | 17:39:17 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-ext.html (next: http://localhost:33438/tests/dromaeo/cssquery-jquery.html) 17:39:18 INFO - PROCESS | 18558 | RSS: Main: 187916288 17:39:18 INFO - PROCESS | 18558 | 17:42:20 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33438/tests/dromaeo/cssquery-mootools.html) 17:42:21 INFO - PROCESS | 18558 | RSS: Main: 189128704 17:42:21 INFO - PROCESS | 18558 | 17:45:22 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33438/tests/dromaeo/cssquery-prototype.html) 17:45:23 INFO - PROCESS | 18558 | RSS: Main: 186515456 17:45:23 INFO - PROCESS | 18558 | 17:48:26 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33438/tests/dromaeo/cssquery-yui.html) 17:48:26 INFO - PROCESS | 18558 | RSS: Main: 188764160 17:48:26 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | Cycle 1(1): loaded http://localhost:33438/tests/dromaeo/cssquery-yui.html (next: http://localhost:33438/tests/dromaeo/cssquery-dojo.html) 17:51:29 INFO - PROCESS | 18558 | RSS: Main: 189755392 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | __start_tp_report 17:51:29 INFO - PROCESS | 18558 | _x_x_mozilla_page_load 17:51:29 INFO - PROCESS | 18558 | _x_x_mozilla_page_load_details 17:51:29 INFO - PROCESS | 18558 | |i|pagename|runs| 17:51:29 INFO - PROCESS | 18558 | |0;dojo.html;2629.263806134282;2642.260167153197;2645.9680724517443;2685.033387980328;2688.690800557936;4906.36217291752;4906.901861962763;4975.950240497594;5002.8249011284615;5047.990401919613;4816.373871396722;4868.634852386068;4900.852974410765;4938.864061265911;4945.714114330273;4475.306327519232;4516.006478574708;4641.25739881619;4671.416072990876;4697.06058788242;168.2395916156762;4538.933350662592;4571.839985600504;4635.513271106536;4669.34629151919;4492.258777301741;4511;4547.977260113695;4574.977125114387;4586.701864378805;4455.376247325377;4582.98432451835;4602.9079418411775;4606.746628935407;4629.722216666977;4502.549745025504;4520.819167233307;4560.429946256718;4589.380433641482;4632.62938964882;4908.361912951329;4924.212126059813;4951.084049450863;4978.128827455181;4990.351254336949;5088.720120393377;5176.844694659167;5277.604179686539;5337.626366154371;5395.352557693062;5302.973485132588;5323.574114070865;5341.759620817073;5343.572514198855;5394.595405344615;4989.151844186497;5006.249062640561;5006.449290578106;5017.899642007213;5056.519630635121;5187.299714538489;5348.064088784447;5389.326334208224;5418.972905135528;5476.808311709071;5155.74221288934;5165.74171291434;5180;5182.196759502283;5195.584353251731;5252.317198764213;5253.737313134328;5256.080185967517;5280.9471905281225;5316.680999140064;5096.159133742891;5168.043911876315;5172.327597412387;5261.421243663194;5263.105272103751;5082.593392528589;5144.922826157611;5152.639315247897;5188.662736922088;5210.218467229945;4436.268015777425;4473.373727678128;4479.17135329965;4493.033997690447;4538.773061346919;3803.5055442792814;3904.668103211202;3922.4508568800393;3938.212357528506;3943.3296339622334;4587.105514424722;4596.2186428306595;4597.195490789099;4597.7011494252765;4633.374494443275;5174.120399532013;5348.465153484621;5366.141417373202;5374.516293533601;5402.729863506809;4502.302143167814;4533.184026875194;4538.478075021349;4539.6368290536675;4541.75020373876;4770.9024543862715;4792.945551978559;4795.592374648124;4796.544328288876;4833.661643684908;4730.243161094346;4936.753162341796;4945.851624451272;4973.950260497349;4982.10322142018;5350.384705758887;5376.193570964387;5378.946210538001;5398.4871437213405;5432.809851655173;4966.205407134986;4976.377952755905;4977.129002424489;4984.22744474607;5037.823676171463;5001;5200.817971370984;5227.451117632594;5259.947400526099;5272.815451459181;5328.17413300939;5345.278387417648;5359.062164121186;5369.865753356197;5414.350277966511;5119.616028797929;5190.273361729436;5196.740162991911;5199.376074871039;5256.605754568346;4997.300377947017;5149.124648809786;5174.818881339135;5195.480451954774;5212.843614691566;4894.486078961658;4988.501149884983;5009.7996080157845;5043.420006699276;5054.671446355975;5201.9336036111745;5207.914999528854;5208.010478009166;5217.9478205217465;5264.131418315935;4955.876103097451;4956.256561515802;5002.87492812668;5107.284980102714;5120.334356533627 17:51:29 INFO - PROCESS | 18558 | |1;ext.html;537.4901842196392;575.4820661404735;590.8877313310471;602.4969150759117;612.6171143035602;35238.823805880966;39165.80417097914;39166;39250.80374598123;39259.803700981494;39426.40860387089;39511.60488395115;39896.20207595846;39943.600563994354;40045.19909601806;7623.656935437891;7749.457537972344;7758.922410775876;7777.922220777777;7787.610619469032;7837;7888.1323054463965;7938.2855543001115;7939.245771651684;7944.086430060559;7936.047674279094;7948.205179482064;7969;7974.800629984239;7976;7820.608969551528;7846.921530784676;7852.803679908048;7856.764297071126;7888.723894663716;7665.655045522964;7700.653470593781;7765.495242809199;7821.687132514692;7826.099998500188;37340.25319493595;37623.247535049144;37683.24633507342;38029.619703802884;38119;3115.6417012043453;3163.383140287645;3297.258116923697;3397.813120278384;3687.6865466435383;28485.430291394263;29129.563056553958;29797;30037.849810750806;30510.389792204252;3429.4855771634207;3440.9483857742152;3470.1498132957336;3484.61669216386;3499.7375196860085;245285;246607;247092;247374;247576;52006;52146;52190.47809521932;52240.738796306534;52353.7382313086;32845.34309313848;32855.05739311298;32855.507167392505;34906.12734681602;35129.64870351315;13927.373268202955;13983.650408739863;14008.299585020708;14122;14153.5046273382;10950.616728414627;11009.889901101047;11071.944640276746;11081.667549973514;11103.500342484607;17807.59597454353;18123;18302.725459118123;18313.450596482126;18333.17500712471;6874.759383421556;6944.131983502062;6971.79297523145;7025.121859767529;7086.468514861406;786.3041208530492;794.9006374203225;852.6376290076693;871.3769654696922;928.0580211085753;27367.589486157725;28169.859150704524;28369.007084752346;28395.432091358056;28674;907.5915837872983;971.6987733802544;972.1590823937385;1029.7528593137592;1040.843873418993;14375.712485750226;14522.491712790214;14562.126272423688;14669.559913202622;14686.41254349814;372166;375503;380144;381744;383063;48701.26948095782;49167;49224;49289.26066109011;49514.50485495171;1148.2306854407566;1148.936808475542;1158.0677554568485;1162.273579013117;1191.8093105103142;25246.495070098863;26877.328066797705;26981.460370792083;27492.312692182855;27628.447431051667;41416.585834141275;41559.1688166241;41748.58251417447;41819.1636167281;41863.37204941989;266431;271538;335128;336408;336704;24479.63280550829;25025.49949001046;25031.624525631767;25065.74934250707;25104.874475627505;41179.7941010293;42274.577254228294;42277.1544569113;43196.56803431926;43285.13429731451;36592.63407365892;37201.627983719816;37314.253714925006;37530;37960.62039379682;36150.819245904655;36280.81859590685;36686.816565917;36706.26587468289;37150;35534.822325888206;35609.64390356167;36184;36387.63612363948;36406.63593364138;32486.675133248365;33086.66913330932;33136.834315829234;33489.665103348656;33833.83083084667;25374.252993024515;25383.87308063448;25633.615495767204;25880.870595646902;25890.611640825027 17:51:29 INFO - PROCESS | 18558 | |2;jquery.html;371.70449492653336;375.1502846053689;379.61658724688056;386.83172819823363;392.48388369294395;14909.701805963874;14967.25163741814;16120.193990300468;16138.999999999985;16152.515424537254;15133.848661513382;15613.375464981387;15741.92129039356;15747.291371888265;15871.523854284362;4236.110416812466;4620.792064357112;4642.953570464303;4645;4662.370579971711;4529.297958816373;4556.589906908378;4608.078384323148;4624.421947256593;4637.814487420499;4583.266677331628;4604.746738929358;4663.417072865892;4666.416697912761;4684.836030738925;4653.162430762462;4653.348531205634;4679.672422930396;4888.560029597354;5146.279520867081;4636.443626764776;4649.488556258809;4649.907001859978;4669.019505903764;4683.555062269079;19301.4209573713;19525.80474195254;20325.88207648579;20699.27552535669;20824;1717.2615775216652;1805.1696219738935;1837.61410103877;1841.9815801841944;1922.259929926974;8816.779580510474;8921.420107693044;9000.144986226298;9039.457632542002;9236.769080772967;1650.9669806603802;1753.9649207015789;1763.285869222954;1801.9819801801946;1834.642244762272;47893.76053119712;60601.6969915152;61572.384276157114;63574.68212658907;66510;9854.458004809661;9961.80076398468;10158;10346.53440595175;10371.429571373495;14125.646858828406;14219.36012879423;14299.78550321746;14301.78547321791;14338.641533961734;6977.092977912839;7144.607046612487;7261.273872612696;7370.336669699753;7547.207543207884;6679.332066793282;6700.564463309869;6804.829879253059;6967.9199724042855;7143.285671432919;4397.1205758848355;4397.450318710161;4492.146492166478;4495.123450927038;4538.6369090473345;1827.2873579304082;1854.6105317883396;1904.1431355889904;1909.2458478900755;1911.9139638716013;706.809161526385;842.0989541190867;851.7529916324197;901.8376692195336;937.9343445958717;16942.915285423493;16968.06675632852;16987.320507179822;17477.475675729493;17716.82283177152;833.1293797981124;849.3417601358873;872.9563521823883;882.1663527966139;893.9687110951086;9413.764655883657;9824.950875245579;9838;9889.752756181153;9893.554790034466;364240;366881;367499;367527;388590;47138.29292560614;47997.520024799305;51585.7420712894;76836.61581692168;78906;798.5647821937058;841.2344766262671;880.7709995401242;880.8502554565739;884.0849720539339;15235.695286094438;15592.454264100703;15907.443239486562;16007;16055.598610034842;27425.31436714098;28375.716242838134;33214.571438509774;35057.298854023284;35246;49757.50242497529;51026.489735103656;53044.20433693575;53074.73462632662;53099.73450132724;7580.734674286374;7670;7911.28798408146;8001.679932802623;8010.319122874621;10976.451177440937;11775.52897884075;11811.409429528318;12032.458539365574;12214.145009849226;4989.201727723546;6241.687915604292;9632.711018669452;10180.287379883634;10339.0694837465;9931.255155863484;10382.636607718694;10539.63111291101;10736.51685674131;10766.407847568458;9425.717228483156;9670.56482458305;10460.163186944874;10515.526801293807;10638;6772.356626120511;7592.164861865301;7618;7771.650275737718;8085.353171746128;7422.109346878409;9740.366876153028;9952.303338766216;10127.442990635585;10182.300364401188 17:51:29 INFO - PROCESS | 18558 | |3;mootools.html;1382.9792553111702;1406.9015168938174;1471.2937789860866;1650.951645704977;1663.7920259967505;6629.734810607582;7239.1674957379855;7394.70421183152;7762.728304509336;7802.336801371883;7478.439117066215;7726.150123486426;7739.458237923348;7762.068551773795;7774.92225077749;1928.2961718972579;1954.8240658340746;1958.2754380879023;1958.8432925365937;1970.2217624038497;1954.3355259211864;1992.2628627407807;2005.8696184748017;2016.4958760309923;2022.514596496845;2084.98957505213;2096.716943212662;2105.11585134244;2108.968365474519;2119.4065661614695;2045.100155931393;2056.1775289884017;2067.390119914629;2079.6048750737314;2082.552251265985;2075.4707549574914;2096.1091536097097;2109.673000684881;2114.9154033838627;2121.798429149244;7765.650545725456;7768.766936991843;7853.332466740334;7868.645910933965;7879.96060019702;4409.052053808415;4523.841665541723;4533.252013417782;4536.500984891659;4540.114677637862;2681.316264352597;2750.7386798254133;2799.860006999642;2802.369466869958;2837.517622004264;863.8272345530856;889.1108891108892;895.4135041547796;904.5436846676845;907.3195103672246;10485.056344928917;10487.842682359771;10492;10538.262321637412;10575.365478071264;4073.327900896378;4105.3636686313075;4147.917041659211;4199.076203235283;4203.243416185116;8801.51591662452;8823.073577274423;8860.202581767542;8879.91120088791;8889.333300002396;4612.815487380467;4615.3077038443835;4618.515055919147;4622.19111655459;4633.0733853229485;3682.9447558286647;4020.3969404589548;4030.556638769733;4045.8786236412366;4056.8985775355854;3499.6675315844955;3612.259486805199;3661.5423072115987;3672.3573374659327;3687.2809802088873;1144.7882141803793;1172.2321879169158;1188.8395066666062;1198.7722332756923;1201.8017027190415;831.5717405536154;840.9957950210332;843.9704610338608;860.2257967828879;861.8922634670666;4962.925556116661;5043.041822053798;5106.259592359087;5157.200633901752;5188.948110518922;391.8491380818405;399.12989682492446;401.7729982559844;405.126951419691;410.70018886213234;3497.562804649419;3549.680528752425;3559.2169722660974;3610.5125808016105;3615.313090512847;9038.412503187272;9147;9348.158665720119;9369.859452108223;9383.671571494964;8986.640534378683;9230.58462369195;9292.349535532448;9311.76720581991;9321;7092.361687448051;7093.006979022941;7198.460115491359;7198.820029499199;7231.493795434374;4968.850934471971;5110.897782044412;5157.8452646420665;5170.482951704799;5189.584833213409;8585.8712119317;8612.267957223707;8661;8715.08491608372;8801.207891289558;8795.120487951153;8813.515256660945;8826.338024648048;8831.205191532792;8935.553222338727;5939.762409503572;6668.699908504226;6732.42774364165;6794.252632210551;7189.065421495172;7040.0847889774;7182.425405967406;7258.49190556656;7264.34620884123;7288.906664000442;6357.110004599453;6385.584936979268;6414.711337989708;6505.51208659343;6558.573692709959;6212.1303017578475;6313.40022697843;6488.675566221765;6490.48076153916;6667.166604174478;5655.264815573949;5672.5745569081655;5679.801206957736;5685.175649530877;5751.079827227791;4296.720713153635;4429.224885645063;4573.565511276423;4629.722216667011;4680.040591678766;4430.37974683551;4458.308962110878;4503.887402814956;4524.705894116872;4526.366308716848 17:51:29 INFO - PROCESS | 18558 | |4;prototype.html;299.9010326592225;300.465171993851;302.34391370725524;302.8001518997459;304.8399590215136;5096.120691809126;5134.820281290151;5149.974250128744;5167.250748641445;5170.9482905170935;5066.164082926312;5076.340075790142;5104.979004199156;5123.205903085019;5138.203578445337;3710.610385909488;3837.3092843288196;3914.8825535233987;3925.41118832176;3931.8034098295116;3920.29434701755;3930.862419815307;3943.6845052395884;3955.3671412573995;3972.622600852929;3928.6071392860626;3930.4081846852073;3933.940990885139;3934.154156856275;3960.742551734128;3816.160444702161;3916.373380259159;3929.528456585228;3985.960140398588;4017.0359113812765;3469.311283755085;3485.7559970802054;3508.614052454228;3525.823708814549;3528.4001719707453;4960.900781984376;4966.925496117561;4980.950190498085;4993.883715705106;5004.396834279313;4341.8290854572715;4557.635389168859;4577.496475387705;4586.518415566351;4598.884513123967;5295.629305948585;5302.469753024667;5377.81177658784;5388.461153884619;5405.486478784509;3820.59883712209;3835.76985380878;3835.9232815343535;3838.098046958962;3842.193139440693;5283.735813209362;5671.432856714337;5686.943130568683;5690.5447564194765;5722.599418040739;3791.8862434127022;3800.1449673823167;3801.9239615208094;3811.1615444602144;3822.4648549203134;3853.499045124172;3855.7493762905883;3868.864589739346;3877.1470276539117;3899;4453.955460445354;4464.241079016575;4473.932891006638;4512.2329204035395;4513.277875539898;5174.9482505174465;5346.235742205063;5356.91964620531;5385.919211211756;5415.702136382537;1326.0319966424372;1331.7669407853587;1345.280275052842;1354.7087376213965;1358.7961805729021;811.7280710961894;818.7953011747063;849.7110982266059;852.7569642651814;857.9447279845824;4547.976705241361;4647.744374059392;4650.279206722896;4664.603508701731;4665.160271151158;5488.32606055157;5491.862703432446;5562.276904002535;5607.607467477237;5611.551075913917;4431.911361772811;4660.370849935283;4673.509281525459;4707;4708.88227794301;2947.2189869684553;2959.230600044004;2980;2986.2086547065046;2988.3873805869744;5128.461511541309;5135.640505164677;5155.252488389237;5168.793248270027;5180.404253510895;5479.397266300703;5634.605577609528;5656.2929633795775;5707.686077265707;5723.742431590588;5100.183970564766;5110.415771110967;5123;5124.769385377667;5126.7188999040645;5527.198556209408;5530.723463826712;5532.3637781655625;5532.806351777668;5535.833924982257;5234;5457.672539647634;5475;5480.3971563128825;5492.093804522369;5068.493150684902;5138.12651849179;5140.537351638371;5186.585073194211;5190.480951904779;3826.464294998647;3837.333053527883;3838.9616103838603;3842.442845787401;3854.1328201154515;5400.891982160413;5469.781208751764;5503.257060296809;5507.421720719427;5508.14623733322;5301.920471193012;5323;5336.146216605324;5355.4376790436445;5382.766152046856;5069.214271787879;5306.681599104066;5322.3388305847075;5323.095073837534;5357.758900849393;5274.525292723673;5281.260623512788;5292.497212764782;5296.549793267615;5328.387235467816;5148.4851514848215;5282.3132992712235;5431.2667789847865;5439.292891924025;5454;5293.311869456946;5296.232046353334;5300.628955973045;5324.227986941949;5343.7862485500145 17:51:29 INFO - PROCESS | 18558 | |5;yui.html;610.2158726037042;637.5791977294987;651.4657980456022;708.9326513981172;728.8469421421502;12081.516739330427;13789.448422063106;13851.722965540683;13882.028258021917;13887.444502219912;13239.867601323984;13288.734225315487;13356;13367.866321336784;13376.799348009788;625.583986648878;770.7418014964979;774.6668932359083;803.4054799448425;804.5012092502657;791.4341246009102;795.32794788404;801.6713147609481;802.1697543042952;802.9799255018613;831.4803247970019;837.1712005114953;837.623069618674;838.9664413423455;839.3033781960988;828.2131974624072;830.9542975136366;832.5421018439864;832.8958880139983;835.6156168162622;611.2115371171184;611.9357467465941;612.4090252905967;614.2567493333072;614.2690198663576;12603.873961260362;12641.620751377473;12705.682357941034;12731.42708578107;12733.872661273454;13255.138416002928;13545.525906593222;13592.86407135926;13653.156823828755;13789.793153102712;10155.238357123171;10286.279960402775;10536.789264214749;10580.470976451146;10670.893291067068;3370.5449764281752;3422.26421319415;3422.401079811023;3425.5033020212177;3430.828458577061;57795.711021445044;58154.41845581532;58404.70797646027;58483.415165848644;58684.41315586875;10706.892931070746;10708.30396024256;10714.517846696917;10753.569857205624;10873.021428071512;19503.219871204994;19537;19705;19734.605307893762;19765.802341976396;7011.26381729911;7085.468589855782;7095.751648692271;7101.538400003983;7325.7802265932105;3595.2270261893295;3693.316736403774;3708.499352587366;3784.962150378516;3793.374093274634;2821.548552231633;2933.4426458972725;2939.4562006028955;2945.23423909785;2968.1540760883477;482.38736804258394;483.6421048424141;486.1977736734346;486.6252985201446;488.7092180152803;443.47891227807196;537.6182910133771;565.465634974953;604.4288147700381;605.1860247966478;7753.8449231015065;7906.881396779053;8247.175282471824;8317.334613230927;8444.240018398374;503.41603739661815;533.2884803751784;546.7184400033985;548.8216329692866;598.2073752278249;3678.3378991781738;3807.1814559869763;3820.6179382061573;3866.555346135174;3927.1752931884625;55223.723881380334;81585.59207203926;84004.57997709973;91610;91756;83982.58008709918;84645.15354846496;85663.14336856676;85704.14295856962;85953.57023214844;72311;73087.2691273091;73428.63285683644;73954.6302268496;74027.62986185035;7282.380997615051;7383.630818459163;7624.8475030500185;7639.159692433939;7665.6933722650465;38909.61090389173;39745.40381894332;41860.58139418567;43585.346219806095;44321.556784433036;54164;60728;61737;62242;62707.6864615674;10423.42671153094;10506.894931050592;10588.853733770955;10663.573457061631;10756;11850.913966970767;11948.641540753792;11975.520979160736;11990.269857862804;12172.695682608006;10945.179111566506;11187.384693841917;11264.436778161224;11331.943340283246;11584.594539191088;10819.404932728776;10858.185636077167;11069.391183484986;11211.887881121085;11309.434528273388;10654.200934930066;10677.89322106769;10682.679519614425;10710.571577136827;10950.780984380108;9984.500774961369;10000.349977251455;10058.346207496783;10336.121429678562;10386.376817390981;10017.449040302854;10081.546330415296;10109.292349535463;10217.33587316822;10232.23258255619 17:51:29 INFO - PROCESS | 18558 | __end_tp_report 17:51:29 INFO - PROCESS | 18558 | __start_cc_report 17:51:29 INFO - PROCESS | 18558 | _x_x_mozilla_cycle_collect,381 17:51:29 INFO - PROCESS | 18558 | __end_cc_report 17:51:29 INFO - PROCESS | 18558 | __startTimestamp1466902289563__endTimestamp 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | ------- Summary: start ------- 17:51:29 INFO - PROCESS | 18558 | Number of tests: 6 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#0] dojo.html Cycles:165 Average:4858.19 Median:4997.30 stddev:638.92 (12.8%) stddev-sans-first:616.49 17:51:29 INFO - PROCESS | 18558 | Values: 2629.3 2642.3 2646.0 2685.0 2688.7 4906.4 4906.9 4976.0 5002.8 5048.0 4816.4 4868.6 4900.9 4938.9 4945.7 4475.3 4516.0 4641.3 4671.4 4697.1 168.2 4538.9 4571.8 4635.5 4669.3 4492.3 4511.0 4548.0 4575.0 4586.7 4455.4 4583.0 4602.9 4606.7 4629.7 4502.5 4520.8 4560.4 4589.4 4632.6 4908.4 4924.2 4951.1 4978.1 4990.4 5088.7 5176.8 5277.6 5337.6 5395.4 5303.0 5323.6 5341.8 5343.6 5394.6 4989.2 5006.2 5006.4 5017.9 5056.5 5187.3 5348.1 5389.3 5419.0 5476.8 5155.7 5165.7 5180.0 5182.2 5195.6 5252.3 5253.7 5256.1 5280.9 5316.7 5096.2 5168.0 5172.3 5261.4 5263.1 5082.6 5144.9 5152.6 5188.7 5210.2 4436.3 4473.4 4479.2 4493.0 4538.8 3803.5 3904.7 3922.5 3938.2 3943.3 4587.1 4596.2 4597.2 4597.7 4633.4 5174.1 5348.5 5366.1 5374.5 5402.7 4502.3 4533.2 4538.5 4539.6 4541.8 4770.9 4792.9 4795.6 4796.5 4833.7 4730.2 4936.8 4945.9 4974.0 4982.1 5350.4 5376.2 5378.9 5398.5 5432.8 4966.2 4976.4 4977.1 4984.2 5037.8 5001.0 5200.8 5227.5 5259.9 5272.8 5328.2 5345.3 5359.1 5369.9 5414.4 5119.6 5190.3 5196.7 5199.4 5256.6 4997.3 5149.1 5174.8 5195.5 5212.8 4894.5 4988.5 5009.8 5043.4 5054.7 5201.9 5207.9 5208.0 5217.9 5264.1 4955.9 4956.3 5002.9 5107.3 5120.3 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#1] ext.html Cycles:180 Average:46179.14 Median:36696.54 stddev:83314.60 (227.0%) stddev-sans-first:83477.85 17:51:29 INFO - PROCESS | 18558 | Values: 537.5 575.5 590.9 602.5 612.6 35238.8 39165.8 39166.0 39250.8 39259.8 39426.4 39511.6 39896.2 39943.6 40045.2 7623.7 7749.5 7758.9 7777.9 7787.6 7837.0 7888.1 7938.3 7939.2 7944.1 7936.0 7948.2 7969.0 7974.8 7976.0 7820.6 7846.9 7852.8 7856.8 7888.7 7665.7 7700.7 7765.5 7821.7 7826.1 37340.3 37623.2 37683.2 38029.6 38119.0 3115.6 3163.4 3297.3 3397.8 3687.7 28485.4 29129.6 29797.0 30037.8 30510.4 3429.5 3440.9 3470.1 3484.6 3499.7 245285.0 246607.0 247092.0 247374.0 247576.0 52006.0 52146.0 52190.5 52240.7 52353.7 32845.3 32855.1 32855.5 34906.1 35129.6 13927.4 13983.7 14008.3 14122.0 14153.5 10950.6 11009.9 11071.9 11081.7 11103.5 17807.6 18123.0 18302.7 18313.5 18333.2 6874.8 6944.1 6971.8 7025.1 7086.5 786.3 794.9 852.6 871.4 928.1 27367.6 28169.9 28369.0 28395.4 28674.0 907.6 971.7 972.2 1029.8 1040.8 14375.7 14522.5 14562.1 14669.6 14686.4 372166.0 375503.0 380144.0 381744.0 383063.0 48701.3 49167.0 49224.0 49289.3 49514.5 1148.2 1148.9 1158.1 1162.3 1191.8 25246.5 26877.3 26981.5 27492.3 27628.4 41416.6 41559.2 41748.6 41819.2 41863.4 266431.0 271538.0 335128.0 336408.0 336704.0 24479.6 25025.5 25031.6 25065.7 25104.9 41179.8 42274.6 42277.2 43196.6 43285.1 36592.6 37201.6 37314.3 37530.0 37960.6 36150.8 36280.8 36686.8 36706.3 37150.0 35534.8 35609.6 36184.0 36387.6 36406.6 32486.7 33086.7 33136.8 33489.7 33833.8 25374.3 25383.9 25633.6 25880.9 25890.6 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#2] jquery.html Cycles:180 Average:22741.56 Median:4622.61 stddev:60974.70 (1319.1%) stddev-sans-first:61122.62 17:51:29 INFO - PROCESS | 18558 | Values: 371.7 375.2 379.6 386.8 392.5 14909.7 14967.3 16120.2 16139.0 16152.5 15133.8 15613.4 15741.9 15747.3 15871.5 4236.1 4620.8 4643.0 4645.0 4662.4 4529.3 4556.6 4608.1 4624.4 4637.8 4583.3 4604.7 4663.4 4666.4 4684.8 4653.2 4653.3 4679.7 4888.6 5146.3 4636.4 4649.5 4649.9 4669.0 4683.6 19301.4 19525.8 20325.9 20699.3 20824.0 1717.3 1805.2 1837.6 1842.0 1922.3 8816.8 8921.4 9000.1 9039.5 9236.8 1651.0 1754.0 1763.3 1802.0 1834.6 47893.8 60601.7 61572.4 63574.7 66510.0 9854.5 9961.8 10158.0 10346.5 10371.4 14125.6 14219.4 14299.8 14301.8 14338.6 6977.1 7144.6 7261.3 7370.3 7547.2 6679.3 6700.6 6804.8 6967.9 7143.3 4397.1 4397.5 4492.1 4495.1 4538.6 1827.3 1854.6 1904.1 1909.2 1911.9 706.8 842.1 851.8 901.8 937.9 16942.9 16968.1 16987.3 17477.5 17716.8 833.1 849.3 873.0 882.2 894.0 9413.8 9825.0 9838.0 9889.8 9893.6 364240.0 366881.0 367499.0 367527.0 388590.0 47138.3 47997.5 51585.7 76836.6 78906.0 798.6 841.2 880.8 880.9 884.1 15235.7 15592.5 15907.4 16007.0 16055.6 27425.3 28375.7 33214.6 35057.3 35246.0 49757.5 51026.5 53044.2 53074.7 53099.7 7580.7 7670.0 7911.3 8001.7 8010.3 10976.5 11775.5 11811.4 12032.5 12214.1 4989.2 6241.7 9632.7 10180.3 10339.1 9931.3 10382.6 10539.6 10736.5 10766.4 9425.7 9670.6 10460.2 10515.5 10638.0 6772.4 7592.2 7618.0 7771.7 8085.4 7422.1 9740.4 9952.3 10127.4 10182.3 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#3] mootools.html Cycles:180 Average:4982.04 Median:4965.89 stddev:2821.93 (56.8%) stddev-sans-first:2816.89 17:51:29 INFO - PROCESS | 18558 | Values: 1383.0 1406.9 1471.3 1651.0 1663.8 6629.7 7239.2 7394.7 7762.7 7802.3 7478.4 7726.2 7739.5 7762.1 7774.9 1928.3 1954.8 1958.3 1958.8 1970.2 1954.3 1992.3 2005.9 2016.5 2022.5 2085.0 2096.7 2105.1 2109.0 2119.4 2045.1 2056.2 2067.4 2079.6 2082.6 2075.5 2096.1 2109.7 2114.9 2121.8 7765.7 7768.8 7853.3 7868.6 7880.0 4409.1 4523.8 4533.3 4536.5 4540.1 2681.3 2750.7 2799.9 2802.4 2837.5 863.8 889.1 895.4 904.5 907.3 10485.1 10487.8 10492.0 10538.3 10575.4 4073.3 4105.4 4147.9 4199.1 4203.2 8801.5 8823.1 8860.2 8879.9 8889.3 4612.8 4615.3 4618.5 4622.2 4633.1 3682.9 4020.4 4030.6 4045.9 4056.9 3499.7 3612.3 3661.5 3672.4 3687.3 1144.8 1172.2 1188.8 1198.8 1201.8 831.6 841.0 844.0 860.2 861.9 4962.9 5043.0 5106.3 5157.2 5188.9 391.8 399.1 401.8 405.1 410.7 3497.6 3549.7 3559.2 3610.5 3615.3 9038.4 9147.0 9348.2 9369.9 9383.7 8986.6 9230.6 9292.3 9311.8 9321.0 7092.4 7093.0 7198.5 7198.8 7231.5 4968.9 5110.9 5157.8 5170.5 5189.6 8585.9 8612.3 8661.0 8715.1 8801.2 8795.1 8813.5 8826.3 8831.2 8935.6 5939.8 6668.7 6732.4 6794.3 7189.1 7040.1 7182.4 7258.5 7264.3 7288.9 6357.1 6385.6 6414.7 6505.5 6558.6 6212.1 6313.4 6488.7 6490.5 6667.2 5655.3 5672.6 5679.8 5685.2 5751.1 4296.7 4429.2 4573.6 4629.7 4680.0 4430.4 4458.3 4503.9 4524.7 4526.4 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#4] prototype.html Cycles:180 Average:4428.43 Median:5102.58 stddev:1304.44 (25.6%) stddev-sans-first:1270.76 17:51:29 INFO - PROCESS | 18558 | Values: 299.9 300.5 302.3 302.8 304.8 5096.1 5134.8 5150.0 5167.3 5170.9 5066.2 5076.3 5105.0 5123.2 5138.2 3710.6 3837.3 3914.9 3925.4 3931.8 3920.3 3930.9 3943.7 3955.4 3972.6 3928.6 3930.4 3933.9 3934.2 3960.7 3816.2 3916.4 3929.5 3986.0 4017.0 3469.3 3485.8 3508.6 3525.8 3528.4 4960.9 4966.9 4981.0 4993.9 5004.4 4341.8 4557.6 4577.5 4586.5 4598.9 5295.6 5302.5 5377.8 5388.5 5405.5 3820.6 3835.8 3835.9 3838.1 3842.2 5283.7 5671.4 5686.9 5690.5 5722.6 3791.9 3800.1 3801.9 3811.2 3822.5 3853.5 3855.7 3868.9 3877.1 3899.0 4454.0 4464.2 4473.9 4512.2 4513.3 5174.9 5346.2 5356.9 5385.9 5415.7 1326.0 1331.8 1345.3 1354.7 1358.8 811.7 818.8 849.7 852.8 857.9 4548.0 4647.7 4650.3 4664.6 4665.2 5488.3 5491.9 5562.3 5607.6 5611.6 4431.9 4660.4 4673.5 4707.0 4708.9 2947.2 2959.2 2980.0 2986.2 2988.4 5128.5 5135.6 5155.3 5168.8 5180.4 5479.4 5634.6 5656.3 5707.7 5723.7 5100.2 5110.4 5123.0 5124.8 5126.7 5527.2 5530.7 5532.4 5532.8 5535.8 5234.0 5457.7 5475.0 5480.4 5492.1 5068.5 5138.1 5140.5 5186.6 5190.5 3826.5 3837.3 3839.0 3842.4 3854.1 5400.9 5469.8 5503.3 5507.4 5508.1 5301.9 5323.0 5336.1 5355.4 5382.8 5069.2 5306.7 5322.3 5323.1 5357.8 5274.5 5281.3 5292.5 5296.5 5328.4 5148.5 5282.3 5431.3 5439.3 5454.0 5293.3 5296.2 5300.6 5324.2 5343.8 17:51:29 INFO - PROCESS | 18558 | 17:51:29 INFO - PROCESS | 18558 | [#5] yui.html Cycles:180 Average:17007.21 Median:40802.99 stddev:23695.06 (58.1%) stddev-sans-first:23729.55 17:51:29 INFO - PROCESS | 18558 | Values: 610.2 637.6 651.5 708.9 728.8 12081.5 13789.4 13851.7 13882.0 13887.4 13239.9 13288.7 13356.0 13367.9 13376.8 625.6 770.7 774.7 803.4 804.5 791.4 795.3 801.7 802.2 803.0 831.5 837.2 837.6 839.0 839.3 828.2 831.0 832.5 832.9 835.6 611.2 611.9 612.4 614.3 614.3 12603.9 12641.6 12705.7 12731.4 12733.9 13255.1 13545.5 13592.9 13653.2 13789.8 10155.2 10286.3 10536.8 10580.5 10670.9 3370.5 3422.3 3422.4 3425.5 3430.8 57795.7 58154.4 58404.7 58483.4 58684.4 10706.9 10708.3 10714.5 10753.6 10873.0 19503.2 19537.0 19705.0 19734.6 19765.8 7011.3 7085.5 7095.8 7101.5 7325.8 3595.2 3693.3 3708.5 3785.0 3793.4 2821.5 2933.4 2939.5 2945.2 2968.2 482.4 483.6 486.2 486.6 488.7 443.5 537.6 565.5 604.4 605.2 7753.8 7906.9 8247.2 8317.3 8444.2 503.4 533.3 546.7 548.8 598.2 3678.3 3807.2 3820.6 3866.6 3927.2 55223.7 81585.6 84004.6 91610.0 91756.0 83982.6 84645.2 85663.1 85704.1 85953.6 72311.0 73087.3 73428.6 73954.6 74027.6 7282.4 7383.6 7624.8 7639.2 7665.7 38909.6 39745.4 41860.6 43585.3 44321.6 54164.0 60728.0 61737.0 62242.0 62707.7 10423.4 10506.9 10588.9 10663.6 10756.0 11850.9 11948.6 11975.5 11990.3 12172.7 10945.2 11187.4 11264.4 11331.9 11584.6 10819.4 10858.2 11069.4 11211.9 11309.4 10654.2 10677.9 10682.7 10710.6 10950.8 9984.5 10000.3 10058.3 10336.1 10386.4 10017.4 10081.5 10109.3 10217.3 10232.2 17:51:29 INFO - PROCESS | 18558 | -------- Summary: end -------- 17:51:29 INFO - PROCESS | 18558 | 17:51:30 INFO - TEST-INFO | 18558: exit 0 17:51:30 INFO - TEST-OK | dromaeo_css | took 1120336ms 17:51:30 INFO - TEST-START | kraken 17:51:30 INFO - operating with platform_type : linux_ 17:51:30 INFO - Initialising browser for kraken test... 17:51:30 INFO - TEST-INFO | started process 18797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUszJwg/profile http://localhost:33438/getInfo.html) 17:51:37 INFO - PROCESS | 18797 | __metrics Screen width/height:1600/1200 17:51:37 INFO - PROCESS | 18797 | colorDepth:24 17:51:37 INFO - PROCESS | 18797 | Browser inner width/height: 1024/697 17:51:37 INFO - PROCESS | 18797 | __metrics 17:51:39 ERROR - PROCESS | 18797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:51:40 INFO - TEST-INFO | 18797: exit 0 17:51:40 INFO - Browser initialized. 17:51:40 INFO - Running cycle 1/1 for kraken test... 17:51:40 INFO - TEST-INFO | started process 18919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUszJwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:52 INFO - PROCESS | 18919 | RSS: Main: 186388480 17:51:52 INFO - PROCESS | 18919 | 17:51:55 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33438/tests/kraken/driver.html?testName=audio-beat-detection) 17:51:56 INFO - PROCESS | 18919 | RSS: Main: 190504960 17:51:56 INFO - PROCESS | 18919 | 17:51:58 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33438/tests/kraken/driver.html?testName=audio-dft) 17:51:59 INFO - PROCESS | 18919 | RSS: Main: 190504960 17:51:59 INFO - PROCESS | 18919 | 17:52:02 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33438/tests/kraken/driver.html?testName=audio-fft) 17:52:03 INFO - PROCESS | 18919 | RSS: Main: 185835520 17:52:03 INFO - PROCESS | 18919 | 17:52:05 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33438/tests/kraken/driver.html?testName=audio-oscillator) 17:52:05 INFO - PROCESS | 18919 | RSS: Main: 186658816 17:52:05 INFO - PROCESS | 18919 | 17:52:08 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:08 INFO - PROCESS | 18919 | RSS: Main: 187117568 17:52:08 INFO - PROCESS | 18919 | 17:52:11 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33438/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:12 INFO - PROCESS | 18919 | RSS: Main: 187428864 17:52:12 INFO - PROCESS | 18919 | 17:52:16 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33438/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:16 INFO - PROCESS | 18919 | RSS: Main: 184737792 17:52:16 INFO - PROCESS | 18919 | 17:52:19 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33438/tests/kraken/driver.html?testName=json-parse-financial) 17:52:20 INFO - PROCESS | 18919 | RSS: Main: 185892864 17:52:20 INFO - PROCESS | 18919 | 17:52:22 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:22 INFO - PROCESS | 18919 | RSS: Main: 186118144 17:52:22 INFO - PROCESS | 18919 | 17:52:24 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:25 INFO - PROCESS | 18919 | RSS: Main: 186093568 17:52:25 INFO - PROCESS | 18919 | 17:52:27 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:28 INFO - PROCESS | 18919 | RSS: Main: 186630144 17:52:28 INFO - PROCESS | 18919 | 17:52:31 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:31 INFO - PROCESS | 18919 | RSS: Main: 186601472 17:52:31 INFO - PROCESS | 18919 | 17:52:34 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:35 INFO - PROCESS | 18919 | RSS: Main: 186605568 17:52:35 INFO - PROCESS | 18919 | 17:52:36 INFO - PROCESS | 18919 | Cycle 1(1): loaded http://localhost:33438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33438/tests/kraken/driver.html?testName=ai-astar) 17:52:37 INFO - PROCESS | 18919 | RSS: Main: 187002880 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | __start_tp_report 17:52:37 INFO - PROCESS | 18919 | _x_x_mozilla_page_load 17:52:37 INFO - PROCESS | 18919 | _x_x_mozilla_page_load_details 17:52:37 INFO - PROCESS | 18919 | |i|pagename|runs| 17:52:37 INFO - PROCESS | 18919 | |0;ai-astar;104;114;110;113;115;115;116;114;114;115 17:52:37 INFO - PROCESS | 18919 | |1;audio-beat-detection;155;138;153;177;133;167;159;132;202;138 17:52:37 INFO - PROCESS | 18919 | |2;audio-dft;161;163;164;179;164;162;166;163;163;166 17:52:37 INFO - PROCESS | 18919 | |3;audio-fft;77;75;78;152;79;77;76;75;180;76 17:52:37 INFO - PROCESS | 18919 | |4;audio-oscillator;87;87;144;87;86;86;135;86;87;130 17:52:37 INFO - PROCESS | 18919 | |5;imaging-gaussian-blur;118;118;117;118;120;118;117;118;118;118 17:52:37 INFO - PROCESS | 18919 | |6;imaging-darkroom;148;151;149;147;148;149;149;148;147;150 17:52:37 INFO - PROCESS | 18919 | |7;imaging-desaturate;95;96;96;97;97;96;97;96;95;96 17:52:37 INFO - PROCESS | 18919 | |8;json-parse-financial;64;65;64;64;63;64;63;64;65;65 17:52:37 INFO - PROCESS | 18919 | |9;json-stringify-tinderbox;66;65;64;64;68;66;65;65;64;65 17:52:37 INFO - PROCESS | 18919 | |10;stanford-crypto-aes;83;82;83;85;85;84;84;83;93;86 17:52:37 INFO - PROCESS | 18919 | |11;stanford-crypto-ccm;133;157;130;136;140;134;142;143;138;156 17:52:37 INFO - PROCESS | 18919 | |12;stanford-crypto-pbkdf2;172;171;170;172;170;182;172;176;179;165 17:52:37 INFO - PROCESS | 18919 | |13;stanford-crypto-sha256-iterative;67;69;67;68;72;67;68;71;67;70 17:52:37 INFO - PROCESS | 18919 | __end_tp_report 17:52:37 INFO - PROCESS | 18919 | __start_cc_report 17:52:37 INFO - PROCESS | 18919 | _x_x_mozilla_cycle_collect,1020 17:52:37 INFO - PROCESS | 18919 | __end_cc_report 17:52:37 INFO - PROCESS | 18919 | __startTimestamp1466902357240__endTimestamp 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | ------- Summary: start ------- 17:52:37 INFO - PROCESS | 18919 | Number of tests: 14 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:3.56 (3.1%) stddev-sans-first:1.73 17:52:37 INFO - PROCESS | 18919 | Values: 104.0 114.0 110.0 113.0 115.0 115.0 116.0 114.0 114.0 115.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:157.00 stddev:22.23 (14.2%) stddev-sans-first:23.57 17:52:37 INFO - PROCESS | 18919 | Values: 155.0 138.0 153.0 177.0 133.0 167.0 159.0 132.0 202.0 138.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:5.13 (3.1%) stddev-sans-first:5.22 17:52:37 INFO - PROCESS | 18919 | Values: 161.0 163.0 164.0 179.0 164.0 162.0 166.0 163.0 163.0 166.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.50 stddev:38.28 (50.0%) stddev-sans-first:40.07 17:52:37 INFO - PROCESS | 18919 | Values: 77.0 75.0 78.0 152.0 79.0 77.0 76.0 75.0 180.0 76.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:86.50 stddev:24.27 (28.1%) stddev-sans-first:25.17 17:52:37 INFO - PROCESS | 18919 | Values: 87.0 87.0 144.0 87.0 86.0 86.0 135.0 86.0 87.0 130.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 17:52:37 INFO - PROCESS | 18919 | Values: 118.0 118.0 117.0 118.0 120.0 118.0 117.0 118.0 118.0 118.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 17:52:37 INFO - PROCESS | 18919 | Values: 148.0 151.0 149.0 147.0 148.0 149.0 149.0 148.0 147.0 150.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 17:52:37 INFO - PROCESS | 18919 | Values: 95.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 95.0 96.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 17:52:37 INFO - PROCESS | 18919 | Values: 64.0 65.0 64.0 64.0 63.0 64.0 63.0 64.0 65.0 65.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 17:52:37 INFO - PROCESS | 18919 | Values: 66.0 65.0 64.0 64.0 68.0 66.0 65.0 65.0 64.0 65.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:3.12 (3.7%) stddev-sans-first:3.24 17:52:37 INFO - PROCESS | 18919 | Values: 83.0 82.0 83.0 85.0 85.0 84.0 84.0 83.0 93.0 86.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:141.00 stddev:9.16 (6.5%) stddev-sans-first:9.26 17:52:37 INFO - PROCESS | 18919 | Values: 133.0 157.0 130.0 136.0 140.0 134.0 142.0 143.0 138.0 156.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:172.00 stddev:4.89 (2.8%) stddev-sans-first:5.17 17:52:37 INFO - PROCESS | 18919 | Values: 172.0 171.0 170.0 172.0 170.0 182.0 172.0 176.0 179.0 165.0 17:52:37 INFO - PROCESS | 18919 | 17:52:37 INFO - PROCESS | 18919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.84 (2.7%) stddev-sans-first:1.86 17:52:37 INFO - PROCESS | 18919 | Values: 67.0 69.0 67.0 68.0 72.0 67.0 68.0 71.0 67.0 70.0 17:52:37 INFO - PROCESS | 18919 | -------- Summary: end -------- 17:52:37 INFO - PROCESS | 18919 | 17:52:38 INFO - TEST-INFO | 18919: exit 0 17:52:38 INFO - TEST-OK | kraken | took 68063ms 17:52:38 INFO - SUITE-END | took 1188s 17:52:38 INFO - Completed test suite (00:19:48) 17:52:38 INFO - javascript benchmark 17:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6362.310414711825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.263806134282, 2642.260167153197, 2645.9680724517443, 2685.033387980328, 2688.690800557936, 4906.36217291752, 4906.901861962763, 4975.950240497594, 5002.8249011284615, 5047.990401919613, 4816.373871396722, 4868.634852386068, 4900.852974410765, 4938.864061265911, 4945.714114330273, 4475.306327519232, 4516.006478574708, 4641.25739881619, 4671.416072990876, 4697.06058788242, 168.2395916156762, 4538.933350662592, 4571.839985600504, 4635.513271106536, 4669.34629151919, 4492.258777301741, 4511.0, 4547.977260113695, 4574.977125114387, 4586.701864378805, 4455.376247325377, 4582.98432451835, 4602.9079418411775, 4606.746628935407, 4629.722216666977, 4502.549745025504, 4520.819167233307, 4560.429946256718, 4589.380433641482, 4632.62938964882, 4908.361912951329, 4924.212126059813, 4951.084049450863, 4978.128827455181, 4990.351254336949, 5088.720120393377, 5176.844694659167, 5277.604179686539, 5337.626366154371, 5395.352557693062, 5302.973485132588, 5323.574114070865, 5341.759620817073, 5343.572514198855, 5394.595405344615, 4989.151844186497, 5006.249062640561, 5006.449290578106, 5017.899642007213, 5056.519630635121, 5187.299714538489, 5348.064088784447, 5389.326334208224, 5418.972905135528, 5476.808311709071, 5155.74221288934, 5165.74171291434, 5180.0, 5182.196759502283, 5195.584353251731, 5252.317198764213, 5253.737313134328, 5256.080185967517, 5280.9471905281225, 5316.680999140064, 5096.159133742891, 5168.043911876315, 5172.327597412387, 5261.421243663194, 5263.105272103751, 5082.593392528589, 5144.922826157611, 5152.639315247897, 5188.662736922088, 5210.218467229945, 4436.268015777425, 4473.373727678128, 4479.17135329965, 4493.033997690447, 4538.773061346919, 3803.5055442792814, 3904.668103211202, 3922.4508568800393, 3938.212357528506, 3943.3296339622334, 4587.105514424722, 4596.2186428306595, 4597.195490789099, 4597.7011494252765, 4633.374494443275, 5174.120399532013, 5348.465153484621, 5366.141417373202, 5374.516293533601, 5402.729863506809, 4502.302143167814, 4533.184026875194, 4538.478075021349, 4539.6368290536675, 4541.75020373876, 4770.9024543862715, 4792.945551978559, 4795.592374648124, 4796.544328288876, 4833.661643684908, 4730.243161094346, 4936.753162341796, 4945.851624451272, 4973.950260497349, 4982.10322142018, 5350.384705758887, 5376.193570964387, 5378.946210538001, 5398.4871437213405, 5432.809851655173, 4966.205407134986, 4976.377952755905, 4977.129002424489, 4984.22744474607, 5037.823676171463, 5001.0, 5200.817971370984, 5227.451117632594, 5259.947400526099, 5272.815451459181, 5328.17413300939, 5345.278387417648, 5359.062164121186, 5369.865753356197, 5414.350277966511, 5119.616028797929, 5190.273361729436, 5196.740162991911, 5199.376074871039, 5256.605754568346, 4997.300377947017, 5149.124648809786, 5174.818881339135, 5195.480451954774, 5212.843614691566, 4894.486078961658, 4988.501149884983, 5009.7996080157845, 5043.420006699276, 5054.671446355975, 5201.9336036111745, 5207.914999528854, 5208.010478009166, 5217.9478205217465, 5264.131418315935, 4955.876103097451, 4956.256561515802, 5002.87492812668, 5107.284980102714, 5120.334356533627], "value": 4818.827650357748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.4901842196392, 575.4820661404735, 590.8877313310471, 602.4969150759117, 612.6171143035602, 35238.823805880966, 39165.80417097914, 39166.0, 39250.80374598123, 39259.803700981494, 39426.40860387089, 39511.60488395115, 39896.20207595846, 39943.600563994354, 40045.19909601806, 7623.656935437891, 7749.457537972344, 7758.922410775876, 7777.922220777777, 7787.610619469032, 7837.0, 7888.1323054463965, 7938.2855543001115, 7939.245771651684, 7944.086430060559, 7936.047674279094, 7948.205179482064, 7969.0, 7974.800629984239, 7976.0, 7820.608969551528, 7846.921530784676, 7852.803679908048, 7856.764297071126, 7888.723894663716, 7665.655045522964, 7700.653470593781, 7765.495242809199, 7821.687132514692, 7826.099998500188, 37340.25319493595, 37623.247535049144, 37683.24633507342, 38029.619703802884, 38119.0, 3115.6417012043453, 3163.383140287645, 3297.258116923697, 3397.813120278384, 3687.6865466435383, 28485.430291394263, 29129.563056553958, 29797.0, 30037.849810750806, 30510.389792204252, 3429.4855771634207, 3440.9483857742152, 3470.1498132957336, 3484.61669216386, 3499.7375196860085, 245285.0, 246607.0, 247092.0, 247374.0, 247576.0, 52006.0, 52146.0, 52190.47809521932, 52240.738796306534, 52353.7382313086, 32845.34309313848, 32855.05739311298, 32855.507167392505, 34906.12734681602, 35129.64870351315, 13927.373268202955, 13983.650408739863, 14008.299585020708, 14122.0, 14153.5046273382, 10950.616728414627, 11009.889901101047, 11071.944640276746, 11081.667549973514, 11103.500342484607, 17807.59597454353, 18123.0, 18302.725459118123, 18313.450596482126, 18333.17500712471, 6874.759383421556, 6944.131983502062, 6971.79297523145, 7025.121859767529, 7086.468514861406, 786.3041208530492, 794.9006374203225, 852.6376290076693, 871.3769654696922, 928.0580211085753, 27367.589486157725, 28169.859150704524, 28369.007084752346, 28395.432091358056, 28674.0, 907.5915837872983, 971.6987733802544, 972.1590823937385, 1029.7528593137592, 1040.843873418993, 14375.712485750226, 14522.491712790214, 14562.126272423688, 14669.559913202622, 14686.41254349814, 372166.0, 375503.0, 380144.0, 381744.0, 383063.0, 48701.26948095782, 49167.0, 49224.0, 49289.26066109011, 49514.50485495171, 1148.2306854407566, 1148.936808475542, 1158.0677554568485, 1162.273579013117, 1191.8093105103142, 25246.495070098863, 26877.328066797705, 26981.460370792083, 27492.312692182855, 27628.447431051667, 41416.585834141275, 41559.1688166241, 41748.58251417447, 41819.1636167281, 41863.37204941989, 266431.0, 271538.0, 335128.0, 336408.0, 336704.0, 24479.63280550829, 25025.49949001046, 25031.624525631767, 25065.74934250707, 25104.874475627505, 41179.7941010293, 42274.577254228294, 42277.1544569113, 43196.56803431926, 43285.13429731451, 36592.63407365892, 37201.627983719816, 37314.253714925006, 37530.0, 37960.62039379682, 36150.819245904655, 36280.81859590685, 36686.816565917, 36706.26587468289, 37150.0, 35534.822325888206, 35609.64390356167, 36184.0, 36387.63612363948, 36406.63593364138, 32486.675133248365, 33086.66913330932, 33136.834315829234, 33489.665103348656, 33833.83083084667, 25374.252993024515, 25383.87308063448, 25633.615495767204, 25880.870595646902, 25890.611640825027], "value": 17247.61558374605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.70449492653336, 375.1502846053689, 379.61658724688056, 386.83172819823363, 392.48388369294395, 14909.701805963874, 14967.25163741814, 16120.193990300468, 16138.999999999985, 16152.515424537254, 15133.848661513382, 15613.375464981387, 15741.92129039356, 15747.291371888265, 15871.523854284362, 4236.110416812466, 4620.792064357112, 4642.953570464303, 4645.0, 4662.370579971711, 4529.297958816373, 4556.589906908378, 4608.078384323148, 4624.421947256593, 4637.814487420499, 4583.266677331628, 4604.746738929358, 4663.417072865892, 4666.416697912761, 4684.836030738925, 4653.162430762462, 4653.348531205634, 4679.672422930396, 4888.560029597354, 5146.279520867081, 4636.443626764776, 4649.488556258809, 4649.907001859978, 4669.019505903764, 4683.555062269079, 19301.4209573713, 19525.80474195254, 20325.88207648579, 20699.27552535669, 20824.0, 1717.2615775216652, 1805.1696219738935, 1837.61410103877, 1841.9815801841944, 1922.259929926974, 8816.779580510474, 8921.420107693044, 9000.144986226298, 9039.457632542002, 9236.769080772967, 1650.9669806603802, 1753.9649207015789, 1763.285869222954, 1801.9819801801946, 1834.642244762272, 47893.76053119712, 60601.6969915152, 61572.384276157114, 63574.68212658907, 66510.0, 9854.458004809661, 9961.80076398468, 10158.0, 10346.53440595175, 10371.429571373495, 14125.646858828406, 14219.36012879423, 14299.78550321746, 14301.78547321791, 14338.641533961734, 6977.092977912839, 7144.607046612487, 7261.273872612696, 7370.336669699753, 7547.207543207884, 6679.332066793282, 6700.564463309869, 6804.829879253059, 6967.9199724042855, 7143.285671432919, 4397.1205758848355, 4397.450318710161, 4492.146492166478, 4495.123450927038, 4538.6369090473345, 1827.2873579304082, 1854.6105317883396, 1904.1431355889904, 1909.2458478900755, 1911.9139638716013, 706.809161526385, 842.0989541190867, 851.7529916324197, 901.8376692195336, 937.9343445958717, 16942.915285423493, 16968.06675632852, 16987.320507179822, 17477.475675729493, 17716.82283177152, 833.1293797981124, 849.3417601358873, 872.9563521823883, 882.1663527966139, 893.9687110951086, 9413.764655883657, 9824.950875245579, 9838.0, 9889.752756181153, 9893.554790034466, 364240.0, 366881.0, 367499.0, 367527.0, 388590.0, 47138.29292560614, 47997.520024799305, 51585.7420712894, 76836.61581692168, 78906.0, 798.5647821937058, 841.2344766262671, 880.7709995401242, 880.8502554565739, 884.0849720539339, 15235.695286094438, 15592.454264100703, 15907.443239486562, 16007.0, 16055.598610034842, 27425.31436714098, 28375.716242838134, 33214.571438509774, 35057.298854023284, 35246.0, 49757.50242497529, 51026.489735103656, 53044.20433693575, 53074.73462632662, 53099.73450132724, 7580.734674286374, 7670.0, 7911.28798408146, 8001.679932802623, 8010.319122874621, 10976.451177440937, 11775.52897884075, 11811.409429528318, 12032.458539365574, 12214.145009849226, 4989.201727723546, 6241.687915604292, 9632.711018669452, 10180.287379883634, 10339.0694837465, 9931.255155863484, 10382.636607718694, 10539.63111291101, 10736.51685674131, 10766.407847568458, 9425.717228483156, 9670.56482458305, 10460.163186944874, 10515.526801293807, 10638.0, 6772.356626120511, 7592.164861865301, 7618.0, 7771.650275737718, 8085.353171746128, 7422.109346878409, 9740.366876153028, 9952.303338766216, 10127.442990635585, 10182.300364401188], "value": 7838.457494097388, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.9792553111702, 1406.9015168938174, 1471.2937789860866, 1650.951645704977, 1663.7920259967505, 6629.734810607582, 7239.1674957379855, 7394.70421183152, 7762.728304509336, 7802.336801371883, 7478.439117066215, 7726.150123486426, 7739.458237923348, 7762.068551773795, 7774.92225077749, 1928.2961718972579, 1954.8240658340746, 1958.2754380879023, 1958.8432925365937, 1970.2217624038497, 1954.3355259211864, 1992.2628627407807, 2005.8696184748017, 2016.4958760309923, 2022.514596496845, 2084.98957505213, 2096.716943212662, 2105.11585134244, 2108.968365474519, 2119.4065661614695, 2045.100155931393, 2056.1775289884017, 2067.390119914629, 2079.6048750737314, 2082.552251265985, 2075.4707549574914, 2096.1091536097097, 2109.673000684881, 2114.9154033838627, 2121.798429149244, 7765.650545725456, 7768.766936991843, 7853.332466740334, 7868.645910933965, 7879.96060019702, 4409.052053808415, 4523.841665541723, 4533.252013417782, 4536.500984891659, 4540.114677637862, 2681.316264352597, 2750.7386798254133, 2799.860006999642, 2802.369466869958, 2837.517622004264, 863.8272345530856, 889.1108891108892, 895.4135041547796, 904.5436846676845, 907.3195103672246, 10485.056344928917, 10487.842682359771, 10492.0, 10538.262321637412, 10575.365478071264, 4073.327900896378, 4105.3636686313075, 4147.917041659211, 4199.076203235283, 4203.243416185116, 8801.51591662452, 8823.073577274423, 8860.202581767542, 8879.91120088791, 8889.333300002396, 4612.815487380467, 4615.3077038443835, 4618.515055919147, 4622.19111655459, 4633.0733853229485, 3682.9447558286647, 4020.3969404589548, 4030.556638769733, 4045.8786236412366, 4056.8985775355854, 3499.6675315844955, 3612.259486805199, 3661.5423072115987, 3672.3573374659327, 3687.2809802088873, 1144.7882141803793, 1172.2321879169158, 1188.8395066666062, 1198.7722332756923, 1201.8017027190415, 831.5717405536154, 840.9957950210332, 843.9704610338608, 860.2257967828879, 861.8922634670666, 4962.925556116661, 5043.041822053798, 5106.259592359087, 5157.200633901752, 5188.948110518922, 391.8491380818405, 399.12989682492446, 401.7729982559844, 405.126951419691, 410.70018886213234, 3497.562804649419, 3549.680528752425, 3559.2169722660974, 3610.5125808016105, 3615.313090512847, 9038.412503187272, 9147.0, 9348.158665720119, 9369.859452108223, 9383.671571494964, 8986.640534378683, 9230.58462369195, 9292.349535532448, 9311.76720581991, 9321.0, 7092.361687448051, 7093.006979022941, 7198.460115491359, 7198.820029499199, 7231.493795434374, 4968.850934471971, 5110.897782044412, 5157.8452646420665, 5170.482951704799, 5189.584833213409, 8585.8712119317, 8612.267957223707, 8661.0, 8715.08491608372, 8801.207891289558, 8795.120487951153, 8813.515256660945, 8826.338024648048, 8831.205191532792, 8935.553222338727, 5939.762409503572, 6668.699908504226, 6732.42774364165, 6794.252632210551, 7189.065421495172, 7040.0847889774, 7182.425405967406, 7258.49190556656, 7264.34620884123, 7288.906664000442, 6357.110004599453, 6385.584936979268, 6414.711337989708, 6505.51208659343, 6558.573692709959, 6212.1303017578475, 6313.40022697843, 6488.675566221765, 6490.48076153916, 6667.166604174478, 5655.264815573949, 5672.5745569081655, 5679.801206957736, 5685.175649530877, 5751.079827227791, 4296.720713153635, 4429.224885645063, 4573.565511276423, 4629.722216667011, 4680.040591678766, 4430.37974683551, 4458.308962110878, 4503.887402814956, 4524.705894116872, 4526.366308716848], "value": 3941.7155555394393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9010326592225, 300.465171993851, 302.34391370725524, 302.8001518997459, 304.8399590215136, 5096.120691809126, 5134.820281290151, 5149.974250128744, 5167.250748641445, 5170.9482905170935, 5066.164082926312, 5076.340075790142, 5104.979004199156, 5123.205903085019, 5138.203578445337, 3710.610385909488, 3837.3092843288196, 3914.8825535233987, 3925.41118832176, 3931.8034098295116, 3920.29434701755, 3930.862419815307, 3943.6845052395884, 3955.3671412573995, 3972.622600852929, 3928.6071392860626, 3930.4081846852073, 3933.940990885139, 3934.154156856275, 3960.742551734128, 3816.160444702161, 3916.373380259159, 3929.528456585228, 3985.960140398588, 4017.0359113812765, 3469.311283755085, 3485.7559970802054, 3508.614052454228, 3525.823708814549, 3528.4001719707453, 4960.900781984376, 4966.925496117561, 4980.950190498085, 4993.883715705106, 5004.396834279313, 4341.8290854572715, 4557.635389168859, 4577.496475387705, 4586.518415566351, 4598.884513123967, 5295.629305948585, 5302.469753024667, 5377.81177658784, 5388.461153884619, 5405.486478784509, 3820.59883712209, 3835.76985380878, 3835.9232815343535, 3838.098046958962, 3842.193139440693, 5283.735813209362, 5671.432856714337, 5686.943130568683, 5690.5447564194765, 5722.599418040739, 3791.8862434127022, 3800.1449673823167, 3801.9239615208094, 3811.1615444602144, 3822.4648549203134, 3853.499045124172, 3855.7493762905883, 3868.864589739346, 3877.1470276539117, 3899.0, 4453.955460445354, 4464.241079016575, 4473.932891006638, 4512.2329204035395, 4513.277875539898, 5174.9482505174465, 5346.235742205063, 5356.91964620531, 5385.919211211756, 5415.702136382537, 1326.0319966424372, 1331.7669407853587, 1345.280275052842, 1354.7087376213965, 1358.7961805729021, 811.7280710961894, 818.7953011747063, 849.7110982266059, 852.7569642651814, 857.9447279845824, 4547.976705241361, 4647.744374059392, 4650.279206722896, 4664.603508701731, 4665.160271151158, 5488.32606055157, 5491.862703432446, 5562.276904002535, 5607.607467477237, 5611.551075913917, 4431.911361772811, 4660.370849935283, 4673.509281525459, 4707.0, 4708.88227794301, 2947.2189869684553, 2959.230600044004, 2980.0, 2986.2086547065046, 2988.3873805869744, 5128.461511541309, 5135.640505164677, 5155.252488389237, 5168.793248270027, 5180.404253510895, 5479.397266300703, 5634.605577609528, 5656.2929633795775, 5707.686077265707, 5723.742431590588, 5100.183970564766, 5110.415771110967, 5123.0, 5124.769385377667, 5126.7188999040645, 5527.198556209408, 5530.723463826712, 5532.3637781655625, 5532.806351777668, 5535.833924982257, 5234.0, 5457.672539647634, 5475.0, 5480.3971563128825, 5492.093804522369, 5068.493150684902, 5138.12651849179, 5140.537351638371, 5186.585073194211, 5190.480951904779, 3826.464294998647, 3837.333053527883, 3838.9616103838603, 3842.442845787401, 3854.1328201154515, 5400.891982160413, 5469.781208751764, 5503.257060296809, 5507.421720719427, 5508.14623733322, 5301.920471193012, 5323.0, 5336.146216605324, 5355.4376790436445, 5382.766152046856, 5069.214271787879, 5306.681599104066, 5322.3388305847075, 5323.095073837534, 5357.758900849393, 5274.525292723673, 5281.260623512788, 5292.497212764782, 5296.549793267615, 5328.387235467816, 5148.4851514848215, 5282.3132992712235, 5431.2667789847865, 5439.292891924025, 5454.0, 5293.311869456946, 5296.232046353334, 5300.628955973045, 5324.227986941949, 5343.7862485500145], "value": 4004.8570481129186, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.2158726037042, 637.5791977294987, 651.4657980456022, 708.9326513981172, 728.8469421421502, 12081.516739330427, 13789.448422063106, 13851.722965540683, 13882.028258021917, 13887.444502219912, 13239.867601323984, 13288.734225315487, 13356.0, 13367.866321336784, 13376.799348009788, 625.583986648878, 770.7418014964979, 774.6668932359083, 803.4054799448425, 804.5012092502657, 791.4341246009102, 795.32794788404, 801.6713147609481, 802.1697543042952, 802.9799255018613, 831.4803247970019, 837.1712005114953, 837.623069618674, 838.9664413423455, 839.3033781960988, 828.2131974624072, 830.9542975136366, 832.5421018439864, 832.8958880139983, 835.6156168162622, 611.2115371171184, 611.9357467465941, 612.4090252905967, 614.2567493333072, 614.2690198663576, 12603.873961260362, 12641.620751377473, 12705.682357941034, 12731.42708578107, 12733.872661273454, 13255.138416002928, 13545.525906593222, 13592.86407135926, 13653.156823828755, 13789.793153102712, 10155.238357123171, 10286.279960402775, 10536.789264214749, 10580.470976451146, 10670.893291067068, 3370.5449764281752, 3422.26421319415, 3422.401079811023, 3425.5033020212177, 3430.828458577061, 57795.711021445044, 58154.41845581532, 58404.70797646027, 58483.415165848644, 58684.41315586875, 10706.892931070746, 10708.30396024256, 10714.517846696917, 10753.569857205624, 10873.021428071512, 19503.219871204994, 19537.0, 19705.0, 19734.605307893762, 19765.802341976396, 7011.26381729911, 7085.468589855782, 7095.751648692271, 7101.538400003983, 7325.7802265932105, 3595.2270261893295, 3693.316736403774, 3708.499352587366, 3784.962150378516, 3793.374093274634, 2821.548552231633, 2933.4426458972725, 2939.4562006028955, 2945.23423909785, 2968.1540760883477, 482.38736804258394, 483.6421048424141, 486.1977736734346, 486.6252985201446, 488.7092180152803, 443.47891227807196, 537.6182910133771, 565.465634974953, 604.4288147700381, 605.1860247966478, 7753.8449231015065, 7906.881396779053, 8247.175282471824, 8317.334613230927, 8444.240018398374, 503.41603739661815, 533.2884803751784, 546.7184400033985, 548.8216329692866, 598.2073752278249, 3678.3378991781738, 3807.1814559869763, 3820.6179382061573, 3866.555346135174, 3927.1752931884625, 55223.723881380334, 81585.59207203926, 84004.57997709973, 91610.0, 91756.0, 83982.58008709918, 84645.15354846496, 85663.14336856676, 85704.14295856962, 85953.57023214844, 72311.0, 73087.2691273091, 73428.63285683644, 73954.6302268496, 74027.62986185035, 7282.380997615051, 7383.630818459163, 7624.8475030500185, 7639.159692433939, 7665.6933722650465, 38909.61090389173, 39745.40381894332, 41860.58139418567, 43585.346219806095, 44321.556784433036, 54164.0, 60728.0, 61737.0, 62242.0, 62707.6864615674, 10423.42671153094, 10506.894931050592, 10588.853733770955, 10663.573457061631, 10756.0, 11850.913966970767, 11948.641540753792, 11975.520979160736, 11990.269857862804, 12172.695682608006, 10945.179111566506, 11187.384693841917, 11264.436778161224, 11331.943340283246, 11584.594539191088, 10819.404932728776, 10858.185636077167, 11069.391183484986, 11211.887881121085, 11309.434528273388, 10654.200934930066, 10677.89322106769, 10682.679519614425, 10710.571577136827, 10950.780984380108, 9984.500774961369, 10000.349977251455, 10058.346207496783, 10336.121429678562, 10386.376817390981, 10017.449040302854, 10081.546330415296, 10109.292349535463, 10217.33587316822, 10232.23258255619], "value": 6448.6478327333225, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 110.0, 113.0, 115.0, 115.0, 116.0, 114.0, 114.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 138.0, 153.0, 177.0, 133.0, 167.0, 159.0, 132.0, 202.0, 138.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 179.0, 164.0, 162.0, 166.0, 163.0, 163.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 152.0, 79.0, 77.0, 76.0, 75.0, 180.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 144.0, 87.0, 86.0, 86.0, 135.0, 86.0, 87.0, 130.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 120.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 149.0, 147.0, 148.0, 149.0, 149.0, 148.0, 147.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 68.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 85.0, 85.0, 84.0, 84.0, 83.0, 93.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 157.0, 130.0, 136.0, 140.0, 134.0, 142.0, 143.0, 138.0, 156.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 170.0, 172.0, 170.0, 182.0, 172.0, 176.0, 179.0, 165.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 72.0, 67.0, 68.0, 71.0, 67.0, 70.0], "value": 68.6, "unit": "score"}]}]} 17:52:38 INFO - Return code: 0 17:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:52:39 ERROR - # TBPL SUCCESS # 17:52:39 INFO - Running post-action listener: _resource_record_post_action 17:52:39 INFO - ##### 17:52:39 INFO - ##### Finished run-tests step (success) 17:52:39 INFO - ##### 17:52:39 INFO - Running post-run listener: _resource_record_post_run 17:52:39 INFO - Total resource usage - Wall time: 1217s; CPU: 14.0%; Read bytes: 4096; Write bytes: 537800704; Read time: 92; Write time: 3724880 17:52:39 INFO - TinderboxPrint: CPU usage
13.9% 17:52:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 92 17:52:39 INFO - TinderboxPrint: I/O write bytes / time
537,800,704 / 3,724,880 17:52:39 INFO - TinderboxPrint: CPU idle
8,359.7 (86.1%) 17:52:39 INFO - TinderboxPrint: CPU user
1,230.4 (12.7%) 17:52:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:52:39 INFO - install - Wall time: 27s; CPU: 23.0%; Read bytes: 0; Write bytes: 240680960; Read time: 0; Write time: 2230328 17:52:39 INFO - run-tests - Wall time: 1190s; CPU: 14.0%; Read bytes: 4096; Write bytes: 282750976; Read time: 92; Write time: 1305748 17:52:39 INFO - Running post-run listener: _upload_blobber_files 17:52:39 INFO - Blob upload gear active. 17:52:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:39 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 17:52:39 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:39 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:43 INFO - (blobuploader) - INFO - Done attempting. 17:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:44 INFO - (blobuploader) - INFO - Done attempting. 17:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:44 INFO - (blobuploader) - INFO - Done attempting. 17:52:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:44 INFO - Return code: 0 17:52:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d450bede52efab4bf0afa99553ab057313a1e8db4abb5dc0f334a3215163c76e64d88a5381c9370d871d0661baa42ca30f089185991412a6bb3a9a48313206b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90de0bb45f59b17a122775ba2be6687345a82c777cf819552d20981365bff3a10b76eb3a7d6244fd7058e5c871bd6db46ab99f2916912fd89859ae75da3229a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85195a2a268dacd4f1ffd3e7f56b5af98dc1ec42055c5b0e2bd1d95a7aa7dfc0482af133e335997fc20b9ecb7ffb333ee31caa4144426b6ae4829541d8731de1"} 17:52:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:44 INFO - Contents: 17:52:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d450bede52efab4bf0afa99553ab057313a1e8db4abb5dc0f334a3215163c76e64d88a5381c9370d871d0661baa42ca30f089185991412a6bb3a9a48313206b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90de0bb45f59b17a122775ba2be6687345a82c777cf819552d20981365bff3a10b76eb3a7d6244fd7058e5c871bd6db46ab99f2916912fd89859ae75da3229a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85195a2a268dacd4f1ffd3e7f56b5af98dc1ec42055c5b0e2bd1d95a7aa7dfc0482af133e335997fc20b9ecb7ffb333ee31caa4144426b6ae4829541d8731de1"} 17:52:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:44 INFO - Copying logs to upload dir... 17:52:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.883375 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-06-25 17:52:44.410227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 17:52:44.415008) ========= 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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d450bede52efab4bf0afa99553ab057313a1e8db4abb5dc0f334a3215163c76e64d88a5381c9370d871d0661baa42ca30f089185991412a6bb3a9a48313206b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90de0bb45f59b17a122775ba2be6687345a82c777cf819552d20981365bff3a10b76eb3a7d6244fd7058e5c871bd6db46ab99f2916912fd89859ae75da3229a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85195a2a268dacd4f1ffd3e7f56b5af98dc1ec42055c5b0e2bd1d95a7aa7dfc0482af133e335997fc20b9ecb7ffb333ee31caa4144426b6ae4829541d8731de1"} build_url:https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/Th-aps_LTOunE3l9p-5XLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d450bede52efab4bf0afa99553ab057313a1e8db4abb5dc0f334a3215163c76e64d88a5381c9370d871d0661baa42ca30f089185991412a6bb3a9a48313206b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90de0bb45f59b17a122775ba2be6687345a82c777cf819552d20981365bff3a10b76eb3a7d6244fd7058e5c871bd6db46ab99f2916912fd89859ae75da3229a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85195a2a268dacd4f1ffd3e7f56b5af98dc1ec42055c5b0e2bd1d95a7aa7dfc0482af133e335997fc20b9ecb7ffb333ee31caa4144426b6ae4829541d8731de1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 17:52:44.442863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:52:44.443227) ========= 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=33d5923976266a1c518c4bf7000001ab-1466900867.271834-1907808387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:52:44.528637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 17:52:44.528995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 17:52:44.529318) ========= ========= Total master_lag: 0.18 =========