builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1465046477.68 results: success (0) buildid: 20160604051025 builduid: fb21a03363b74390bc58993df17d3905 revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.678771) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.679226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.679524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.704884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.705144) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 06:21:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-06-04 06:21:19 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.834870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.835207) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014727 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.888000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:17.888359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e8ee3599a67edd971770af4982ad4b0fe77f073 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e8ee3599a67edd971770af4982ad4b0fe77f073 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 06:21:19,438 truncating revision to first 12 chars 2016-06-04 06:21:19,438 Setting DEBUG logging. 2016-06-04 06:21:19,438 attempt 1/10 2016-06-04 06:21:19,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e8ee3599a67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 06:21:20,039 unpacking tar archive at: mozilla-central-3e8ee3599a67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:18.888195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:18.888471) ========= script_repo_revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:18.888907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:18.889180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 06:21:18.901671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-04 06:21:18.901940) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:20 INFO - MultiFileLogger online at 20160604 06:21:20 in /builds/slave/test 06:21:20 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 06:21:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:20 INFO - {'append_to_log': False, 06:21:20 INFO - 'base_work_dir': '/builds/slave/test', 06:21:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:21:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:20 INFO - 'branch': 'Firefox-Non-PGO', 06:21:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:20 INFO - 'config_files': ('talos/linux_config.py',), 06:21:20 INFO - 'default_actions': ('clobber', 06:21:20 INFO - 'read-buildbot-config', 06:21:20 INFO - 'download-and-extract', 06:21:20 INFO - 'populate-webroot', 06:21:20 INFO - 'create-virtualenv', 06:21:20 INFO - 'install', 06:21:20 INFO - 'run-tests'), 06:21:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:20 INFO - 'download_minidump_stackwalk': True, 06:21:20 INFO - 'download_symbols': 'ondemand', 06:21:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:20 INFO - 'installer_path': 'installer.exe', 06:21:20 INFO - 'log_level': 'info', 06:21:20 INFO - 'log_name': 'talos', 06:21:20 INFO - 'log_to_console': True, 06:21:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:20 INFO - 'opt_config_files': (), 06:21:20 INFO - 'pip_index': False, 06:21:20 INFO - 'sps_profile': False, 06:21:20 INFO - 'sps_profile_interval': 0, 06:21:20 INFO - 'suite': 'dromaeojs-e10s', 06:21:20 INFO - 'system_bits': '32', 06:21:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:20 INFO - 'title': 'talos-linux64-ix-064', 06:21:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:20 INFO - 'use_talos_json': True, 06:21:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:20 INFO - 'work_dir': 'build'} 06:21:20 INFO - ##### 06:21:20 INFO - ##### Running clobber step. 06:21:20 INFO - ##### 06:21:20 INFO - Running pre-action listener: _resource_record_pre_action 06:21:20 INFO - Running main action method: clobber 06:21:20 INFO - rmtree: /builds/slave/test/build 06:21:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:21 INFO - Running post-action listener: _resource_record_post_action 06:21:21 INFO - ##### 06:21:21 INFO - ##### Finished clobber step (success) 06:21:21 INFO - ##### 06:21:21 INFO - ##### 06:21:21 INFO - ##### Running read-buildbot-config step. 06:21:21 INFO - ##### 06:21:21 INFO - Running pre-action listener: _resource_record_pre_action 06:21:21 INFO - Running main action method: read_buildbot_config 06:21:21 INFO - Using buildbot properties: 06:21:21 INFO - { 06:21:21 INFO - "project": "", 06:21:21 INFO - "product": "firefox", 06:21:21 INFO - "script_repo_revision": "production", 06:21:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:21:21 INFO - "repository": "", 06:21:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:21:21 INFO - "buildid": "20160604051025", 06:21:21 INFO - "pgo_build": "False", 06:21:21 INFO - "basedir": "/builds/slave/test", 06:21:21 INFO - "buildnumber": 335, 06:21:21 INFO - "slavename": "talos-linux64-ix-064", 06:21:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:21:21 INFO - "platform": "ubuntu64_hw", 06:21:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:21:21 INFO - "branch": "mozilla-central", 06:21:21 INFO - "repo_path": "mozilla-central", 06:21:21 INFO - "revision": "3e8ee3599a67edd971770af4982ad4b0fe77f073", 06:21:21 INFO - "stage_platform": "linux64", 06:21:21 INFO - "builduid": "fb21a03363b74390bc58993df17d3905", 06:21:21 INFO - "slavebuilddir": "test" 06:21:21 INFO - } 06:21:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:21:21 INFO - Running post-action listener: _resource_record_post_action 06:21:21 INFO - ##### 06:21:21 INFO - ##### Finished read-buildbot-config step (success) 06:21:21 INFO - ##### 06:21:21 INFO - ##### 06:21:21 INFO - ##### Running download-and-extract step. 06:21:21 INFO - ##### 06:21:21 INFO - Running pre-action listener: _resource_record_pre_action 06:21:21 INFO - Running main action method: download_and_extract 06:21:21 INFO - mkdir: /builds/slave/test/build/tests 06:21:21 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')]} 06:21:21 INFO - https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:21:25 INFO - Downloaded 1361 bytes. 06:21:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:21:25 INFO - Using the following test package requirements: 06:21:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:21:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:21:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'jsshell-linux-x86_64.zip'], 06:21:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:21:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:21:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:21:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21:25 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')]} 06:21:25 INFO - https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:21:26 INFO - Downloaded 22868144 bytes. 06:21:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:21:28 INFO - Return code: 0 06:21:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:21:28 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')]} 06:21:28 INFO - https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:21:29 INFO - Downloaded 22868144 bytes. 06:21:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:21:31 INFO - Return code: 0 06:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:31 INFO - https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:21:32 INFO - Downloaded 10833369 bytes. 06:21:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:21:32 INFO - Return code: 0 06:21:32 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')]} 06:21:32 INFO - https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:21:34 INFO - Downloaded 55166241 bytes. 06:21:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:21:34 INFO - mkdir: /builds/slave/test/properties 06:21:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:34 INFO - Contents: 06:21:34 INFO - build_url:https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:21:35 INFO - Running post-action listener: _resource_record_post_action 06:21:35 INFO - Running post-action listener: set_extra_try_arguments 06:21:35 INFO - ##### 06:21:35 INFO - ##### Finished download-and-extract step (success) 06:21:35 INFO - ##### 06:21:35 INFO - ##### 06:21:35 INFO - ##### Running populate-webroot step. 06:21:35 INFO - ##### 06:21:35 INFO - Running pre-action listener: _resource_record_pre_action 06:21:35 INFO - Running main action method: populate_webroot 06:21:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:35 INFO - '--tppagecycles', 06:21:35 INFO - '7'], 06:21:35 INFO - 'tests': ['tsvgm']}}, 06:21:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['damp', 'tps']}, 06:21:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'tests': ['damp', 'tps']}, 06:21:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['dromaeo_dom']}, 06:21:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['a11yr', 06:21:35 INFO - 'ts_paint', 06:21:35 INFO - 'tpaint', 06:21:35 INFO - 'sessionrestore', 06:21:35 INFO - 'sessionrestore_no_auto_restore', 06:21:35 INFO - 'tabpaint']}, 06:21:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['tsvgx', 06:21:35 INFO - 'tsvgr_opacity', 06:21:35 INFO - 'tart', 06:21:35 INFO - 'tscrollx', 06:21:35 INFO - 'cart']}, 06:21:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:35 INFO - 'tsvgr_opacity', 06:21:35 INFO - 'tart', 06:21:35 INFO - 'tscrollx', 06:21:35 INFO - 'cart']}, 06:21:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'talos_options': ['--disable-e10s'], 06:21:35 INFO - 'tests': ['tp5o']}, 06:21:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'tests': ['tp5o']}, 06:21:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'talos_options': ['--disable-e10s', 06:21:35 INFO - '--xperf_path', 06:21:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:35 INFO - 'tests': ['tp5n']}, 06:21:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:35 INFO - 'talos_options': ['--xperf_path', 06:21:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:35 INFO - 'tests': ['tp5n']}}, 06:21:35 INFO - 'talos.zip': {'path': '', 06:21:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:35 INFO - Running post-action listener: _resource_record_post_action 06:21:35 INFO - ##### 06:21:35 INFO - ##### Finished populate-webroot step (success) 06:21:35 INFO - ##### 06:21:35 INFO - ##### 06:21:35 INFO - ##### Running create-virtualenv step. 06:21:35 INFO - ##### 06:21:35 INFO - Running pre-action listener: _resource_record_pre_action 06:21:35 INFO - Running main action method: create_virtualenv 06:21:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:35 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 06:21:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:35 INFO - Using real prefix '/usr' 06:21:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:38 INFO - Installing pip.................done. 06:21:38 INFO - Return code: 0 06:21:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:38 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 06:21:38 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 06:21:38 INFO - Using env: {'DISPLAY': ':0', 06:21:38 INFO - 'HOME': '/home/cltbld', 06:21:38 INFO - 'LANG': 'en_US.UTF-8', 06:21:38 INFO - 'LANGUAGE': 'en_US:en', 06:21:38 INFO - 'LOGNAME': 'cltbld', 06:21:38 INFO - 'MAIL': '/var/mail/cltbld', 06:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:38 INFO - 'MOZ_NO_REMOTE': '1', 06:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:38 INFO - 'NO_EM_RESTART': '1', 06:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:38 INFO - 'PWD': '/builds/slave/test', 06:21:38 INFO - 'SHELL': '/bin/bash', 06:21:38 INFO - 'SHLVL': '1', 06:21:38 INFO - 'TERM': 'linux', 06:21:38 INFO - 'TMOUT': '86400', 06:21:38 INFO - 'USER': 'cltbld', 06:21:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:38 INFO - '_': '/tools/buildbot/bin/python'} 06:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:38 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 06:21:38 INFO - Cleaning up... 06:21:38 INFO - Return code: 0 06:21:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:38 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 06:21:38 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 06:21:38 INFO - Using env: {'DISPLAY': ':0', 06:21:38 INFO - 'HOME': '/home/cltbld', 06:21:38 INFO - 'LANG': 'en_US.UTF-8', 06:21:38 INFO - 'LANGUAGE': 'en_US:en', 06:21:38 INFO - 'LOGNAME': 'cltbld', 06:21:38 INFO - 'MAIL': '/var/mail/cltbld', 06:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:38 INFO - 'MOZ_NO_REMOTE': '1', 06:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:38 INFO - 'NO_EM_RESTART': '1', 06:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:38 INFO - 'PWD': '/builds/slave/test', 06:21:38 INFO - 'SHELL': '/bin/bash', 06:21:38 INFO - 'SHLVL': '1', 06:21:38 INFO - 'TERM': 'linux', 06:21:38 INFO - 'TMOUT': '86400', 06:21:38 INFO - 'USER': 'cltbld', 06:21:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:38 INFO - '_': '/tools/buildbot/bin/python'} 06:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:38 INFO - Downloading/unpacking psutil>=3.1.1 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:40 INFO - Installing collected packages: psutil 06:21:40 INFO - Running setup.py install for psutil 06:21:40 INFO - building 'psutil._psutil_linux' extension 06:21:40 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 06:21:40 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 06:21:40 INFO - building 'psutil._psutil_posix' extension 06:21:40 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 06:21:40 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 06:21:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:40 INFO - Successfully installed psutil 06:21:40 INFO - Cleaning up... 06:21:41 INFO - Return code: 0 06:21:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:21:41 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')]} 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:41 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')]} 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:41 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:41 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 06:21:41 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 06:21:41 INFO - Using env: {'DISPLAY': ':0', 06:21:41 INFO - 'HOME': '/home/cltbld', 06:21:41 INFO - 'LANG': 'en_US.UTF-8', 06:21:41 INFO - 'LANGUAGE': 'en_US:en', 06:21:41 INFO - 'LOGNAME': 'cltbld', 06:21:41 INFO - 'MAIL': '/var/mail/cltbld', 06:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:41 INFO - 'MOZ_NO_REMOTE': '1', 06:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:41 INFO - 'NO_EM_RESTART': '1', 06:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:41 INFO - 'PWD': '/builds/slave/test', 06:21:41 INFO - 'SHELL': '/bin/bash', 06:21:41 INFO - 'SHLVL': '1', 06:21:41 INFO - 'TERM': 'linux', 06:21:41 INFO - 'TMOUT': '86400', 06:21:41 INFO - 'USER': 'cltbld', 06:21:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:41 INFO - '_': '/tools/buildbot/bin/python'} 06:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:21:41 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 06:21:41 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 06:21:41 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 06:21:41 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 06:21:41 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 06:21:41 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 06:21:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:21:43 INFO - Installing collected packages: mozsystemmonitor 06:21:43 INFO - Running setup.py install for mozsystemmonitor 06:21:43 INFO - Successfully installed mozsystemmonitor 06:21:43 INFO - Cleaning up... 06:21:43 INFO - Return code: 0 06:21:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:21:43 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')]} 06:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:43 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')]} 06:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:43 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:43 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 06:21:43 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 06:21:43 INFO - Using env: {'DISPLAY': ':0', 06:21:43 INFO - 'HOME': '/home/cltbld', 06:21:43 INFO - 'LANG': 'en_US.UTF-8', 06:21:43 INFO - 'LANGUAGE': 'en_US:en', 06:21:43 INFO - 'LOGNAME': 'cltbld', 06:21:43 INFO - 'MAIL': '/var/mail/cltbld', 06:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:43 INFO - 'MOZ_NO_REMOTE': '1', 06:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:43 INFO - 'NO_EM_RESTART': '1', 06:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:43 INFO - 'PWD': '/builds/slave/test', 06:21:43 INFO - 'SHELL': '/bin/bash', 06:21:43 INFO - 'SHLVL': '1', 06:21:43 INFO - 'TERM': 'linux', 06:21:43 INFO - 'TMOUT': '86400', 06:21:43 INFO - 'USER': 'cltbld', 06:21:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:43 INFO - '_': '/tools/buildbot/bin/python'} 06:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:21:43 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 06:21:43 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 06:21:43 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 06:21:43 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 06:21:43 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 06:21:43 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 06:21:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 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 06:21:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:45 INFO - warning: no files found matching '*.txt' 06:21:45 INFO - no previously-included directories found matching 'build' 06:21:45 INFO - no previously-included directories found matching 'dist' 06:21:45 INFO - no previously-included directories found matching '.git*' 06:21:45 INFO - Installing collected packages: jsonschema, functools32 06:21:45 INFO - Running setup.py install for functools32 06:21:45 INFO - warning: no files found matching '*.txt' 06:21:45 INFO - no previously-included directories found matching 'build' 06:21:45 INFO - no previously-included directories found matching 'dist' 06:21:45 INFO - no previously-included directories found matching '.git*' 06:21:45 INFO - Successfully installed jsonschema functools32 06:21:45 INFO - Cleaning up... 06:21:45 INFO - Return code: 0 06:21:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:21:45 INFO - Using env: {'DISPLAY': ':0', 06:21:45 INFO - 'HOME': '/home/cltbld', 06:21:45 INFO - 'LANG': 'en_US.UTF-8', 06:21:45 INFO - 'LANGUAGE': 'en_US:en', 06:21:45 INFO - 'LOGNAME': 'cltbld', 06:21:45 INFO - 'MAIL': '/var/mail/cltbld', 06:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:45 INFO - 'MOZ_NO_REMOTE': '1', 06:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:45 INFO - 'NO_EM_RESTART': '1', 06:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:45 INFO - 'PWD': '/builds/slave/test', 06:21:45 INFO - 'SHELL': '/bin/bash', 06:21:45 INFO - 'SHLVL': '1', 06:21:45 INFO - 'TERM': 'linux', 06:21:45 INFO - 'TMOUT': '86400', 06:21:45 INFO - 'USER': 'cltbld', 06:21:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:45 INFO - '_': '/tools/buildbot/bin/python'} 06:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:47 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 06:21:47 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 06:21:47 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 06:21:47 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 06:21:47 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 06:21:47 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 06:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:48 INFO - Downloading docopt-0.6.1.tar.gz 06:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:48 INFO - Running setup.py install for blobuploader 06:21:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:48 INFO - Running setup.py install for requests 06:21:49 INFO - Running setup.py install for docopt 06:21:49 INFO - Successfully installed blobuploader requests docopt 06:21:49 INFO - Cleaning up... 06:21:49 INFO - Return code: 0 06:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:49 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')]} 06:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 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')]} 06:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:49 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 06:21:49 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 06:21:49 INFO - Using env: {'DISPLAY': ':0', 06:21:49 INFO - 'HOME': '/home/cltbld', 06:21:49 INFO - 'LANG': 'en_US.UTF-8', 06:21:49 INFO - 'LANGUAGE': 'en_US:en', 06:21:49 INFO - 'LOGNAME': 'cltbld', 06:21:49 INFO - 'MAIL': '/var/mail/cltbld', 06:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:49 INFO - 'MOZ_NO_REMOTE': '1', 06:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:49 INFO - 'NO_EM_RESTART': '1', 06:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:49 INFO - 'PWD': '/builds/slave/test', 06:21:49 INFO - 'SHELL': '/bin/bash', 06:21:49 INFO - 'SHLVL': '1', 06:21:49 INFO - 'TERM': 'linux', 06:21:49 INFO - 'TMOUT': '86400', 06:21:49 INFO - 'USER': 'cltbld', 06:21:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:49 INFO - '_': '/tools/buildbot/bin/python'} 06:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:49 INFO - Running setup.py (path:/tmp/pip-Bm0vZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:49 INFO - Running setup.py (path:/tmp/pip-OqhZ31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:49 INFO - Running setup.py (path:/tmp/pip-LT9F9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:49 INFO - Running setup.py (path:/tmp/pip-z48Wql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:49 INFO - Running setup.py (path:/tmp/pip-bys6lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:49 INFO - Running setup.py (path:/tmp/pip-xkZBJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:49 INFO - Running setup.py (path:/tmp/pip-G7u8Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:50 INFO - Running setup.py (path:/tmp/pip-0QiKUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:50 INFO - Running setup.py (path:/tmp/pip-bfbvCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:50 INFO - Running setup.py (path:/tmp/pip-MBV5T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:50 INFO - Running setup.py (path:/tmp/pip-ReXuFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:50 INFO - Running setup.py (path:/tmp/pip-tfj8df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:50 INFO - Running setup.py (path:/tmp/pip-1dUsoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:50 INFO - Running setup.py (path:/tmp/pip-hAC6Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:50 INFO - Running setup.py (path:/tmp/pip-UYZDbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:50 INFO - Running setup.py (path:/tmp/pip-gsB_tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:50 INFO - Running setup.py (path:/tmp/pip-UtRtni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:50 INFO - Running setup.py install for manifestparser 06:21:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozcrash 06:21:50 INFO - Running setup.py install for mozdebug 06:21:51 INFO - Running setup.py install for mozdevice 06:21:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozfile 06:21:51 INFO - Running setup.py install for mozhttpd 06:21:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozinfo 06:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozInstall 06:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozleak 06:21:51 INFO - Running setup.py install for mozlog 06:21:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for moznetwork 06:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozprocess 06:21:51 INFO - Running setup.py install for mozprofile 06:21:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Running setup.py install for mozrunner 06:21:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Running setup.py install for mozscreenshot 06:21:52 INFO - Running setup.py install for moztest 06:21:52 INFO - Running setup.py install for mozversion 06:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:52 INFO - Cleaning up... 06:21:52 INFO - Return code: 0 06:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:52 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:52 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 06:21:52 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 06:21:52 INFO - Using env: {'DISPLAY': ':0', 06:21:52 INFO - 'HOME': '/home/cltbld', 06:21:52 INFO - 'LANG': 'en_US.UTF-8', 06:21:52 INFO - 'LANGUAGE': 'en_US:en', 06:21:52 INFO - 'LOGNAME': 'cltbld', 06:21:52 INFO - 'MAIL': '/var/mail/cltbld', 06:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:52 INFO - 'MOZ_NO_REMOTE': '1', 06:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:52 INFO - 'NO_EM_RESTART': '1', 06:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:52 INFO - 'PWD': '/builds/slave/test', 06:21:52 INFO - 'SHELL': '/bin/bash', 06:21:52 INFO - 'SHLVL': '1', 06:21:52 INFO - 'TERM': 'linux', 06:21:52 INFO - 'TMOUT': '86400', 06:21:52 INFO - 'USER': 'cltbld', 06:21:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:52 INFO - '_': '/tools/buildbot/bin/python'} 06:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 INFO - Running setup.py (path:/tmp/pip-bgQQHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 INFO - Running setup.py (path:/tmp/pip-GHROk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 INFO - Running setup.py (path:/tmp/pip-OOiwBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 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)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:52 INFO - Running setup.py (path:/tmp/pip-vh1r_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:53 INFO - Running setup.py (path:/tmp/pip-8Dcr3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:53 INFO - Running setup.py (path:/tmp/pip-jzpCzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:53 INFO - Running setup.py (path:/tmp/pip-Yr9UZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:53 INFO - Running setup.py (path:/tmp/pip-Gq_18l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:53 INFO - Running setup.py (path:/tmp/pip-uNQS4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:53 INFO - Running setup.py (path:/tmp/pip-4SIB9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 INFO - Running setup.py (path:/tmp/pip-Q_sktv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 INFO - Running setup.py (path:/tmp/pip-5qWv9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 INFO - Running setup.py (path:/tmp/pip-9z3frZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 INFO - Running setup.py (path:/tmp/pip-zHi6rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 INFO - Running setup.py (path:/tmp/pip-YTuvaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:53 INFO - Running setup.py (path:/tmp/pip-wtxzwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:53 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)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:53 INFO - Running setup.py (path:/tmp/pip-EIqMU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:53 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)) 06:21:53 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)) 06:21:53 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)) 06:21:53 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)) 06:21:53 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)) 06:21:53 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)) 06:21:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:55 INFO - Downloading blessings-1.6.tar.gz 06:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:55 INFO - Installing collected packages: blessings 06:21:55 INFO - Running setup.py install for blessings 06:21:56 INFO - Successfully installed blessings 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:56 INFO - Reading from file tmpfile_stdout 06:21:56 INFO - Current package versions: 06:21:56 INFO - argparse == 1.2.1 06:21:56 INFO - blessings == 1.6 06:21:56 INFO - blobuploader == 1.2.4 06:21:56 INFO - docopt == 0.6.1 06:21:56 INFO - functools32 == 3.2.3-2 06:21:56 INFO - jsonschema == 2.5.1 06:21:56 INFO - manifestparser == 1.1 06:21:56 INFO - mozInstall == 1.12 06:21:56 INFO - mozcrash == 0.17 06:21:56 INFO - mozdebug == 0.1 06:21:56 INFO - mozdevice == 0.48 06:21:56 INFO - mozfile == 1.2 06:21:56 INFO - mozhttpd == 0.7 06:21:56 INFO - mozinfo == 0.9 06:21:56 INFO - mozleak == 0.1 06:21:56 INFO - mozlog == 3.2 06:21:56 INFO - moznetwork == 0.27 06:21:56 INFO - mozprocess == 0.22 06:21:56 INFO - mozprofile == 0.28 06:21:56 INFO - mozrunner == 6.11 06:21:56 INFO - mozscreenshot == 0.1 06:21:56 INFO - mozsystemmonitor == 0.3 06:21:56 INFO - moztest == 0.7 06:21:56 INFO - mozversion == 1.4 06:21:56 INFO - psutil == 3.1.1 06:21:56 INFO - requests == 1.2.3 06:21:56 INFO - wsgiref == 0.1.2 06:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:56 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 06:21:56 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 06:21:56 INFO - Using env: {'DISPLAY': ':0', 06:21:56 INFO - 'HOME': '/home/cltbld', 06:21:56 INFO - 'LANG': 'en_US.UTF-8', 06:21:56 INFO - 'LANGUAGE': 'en_US:en', 06:21:56 INFO - 'LOGNAME': 'cltbld', 06:21:56 INFO - 'MAIL': '/var/mail/cltbld', 06:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:56 INFO - 'MOZ_NO_REMOTE': '1', 06:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:56 INFO - 'NO_EM_RESTART': '1', 06:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:56 INFO - 'PWD': '/builds/slave/test', 06:21:56 INFO - 'SHELL': '/bin/bash', 06:21:56 INFO - 'SHLVL': '1', 06:21:56 INFO - 'TERM': 'linux', 06:21:56 INFO - 'TMOUT': '86400', 06:21:56 INFO - 'USER': 'cltbld', 06:21:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:56 INFO - '_': '/tools/buildbot/bin/python'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 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)) 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:56 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 06:21:56 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 06:21:56 INFO - Using env: {'DISPLAY': ':0', 06:21:56 INFO - 'HOME': '/home/cltbld', 06:21:56 INFO - 'LANG': 'en_US.UTF-8', 06:21:56 INFO - 'LANGUAGE': 'en_US:en', 06:21:56 INFO - 'LOGNAME': 'cltbld', 06:21:56 INFO - 'MAIL': '/var/mail/cltbld', 06:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:56 INFO - 'MOZ_NO_REMOTE': '1', 06:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:56 INFO - 'NO_EM_RESTART': '1', 06:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:56 INFO - 'PWD': '/builds/slave/test', 06:21:56 INFO - 'SHELL': '/bin/bash', 06:21:56 INFO - 'SHLVL': '1', 06:21:56 INFO - 'TERM': 'linux', 06:21:56 INFO - 'TMOUT': '86400', 06:21:56 INFO - 'USER': 'cltbld', 06:21:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:56 INFO - '_': '/tools/buildbot/bin/python'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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 0x7f368f3f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', '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 06:21:56 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 06:21:56 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 06:21:56 INFO - Using env: {'DISPLAY': ':0', 06:21:56 INFO - 'HOME': '/home/cltbld', 06:21:56 INFO - 'LANG': 'en_US.UTF-8', 06:21:56 INFO - 'LANGUAGE': 'en_US:en', 06:21:56 INFO - 'LOGNAME': 'cltbld', 06:21:56 INFO - 'MAIL': '/var/mail/cltbld', 06:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:56 INFO - 'MOZ_NO_REMOTE': '1', 06:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:56 INFO - 'NO_EM_RESTART': '1', 06:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:56 INFO - 'PWD': '/builds/slave/test', 06:21:56 INFO - 'SHELL': '/bin/bash', 06:21:56 INFO - 'SHLVL': '1', 06:21:56 INFO - 'TERM': 'linux', 06:21:56 INFO - 'TMOUT': '86400', 06:21:56 INFO - 'USER': 'cltbld', 06:21:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:56 INFO - '_': '/tools/buildbot/bin/python'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 INFO - Downloading/unpacking flake8 06:21:56 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 06:21:56 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 06:21:56 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 06:21:56 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 06:21:56 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 06:21:56 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 06:21:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:21:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:21:58 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 06:21:58 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 06:21:58 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 06:21:58 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 06:21:58 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 06:21:58 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 06:21:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:21:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:59 INFO - no previously-included directories found matching 'docs/_build' 06:21:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:59 INFO - Running setup.py install for pep8 06:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:59 INFO - no previously-included directories found matching 'docs/_build' 06:21:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:59 INFO - Cleaning up... 06:21:59 INFO - Return code: 0 06:21:59 INFO - Running post-action listener: _resource_record_post_action 06:21:59 INFO - Running post-action listener: _start_resource_monitoring 06:21:59 INFO - Starting resource monitoring. 06:21:59 INFO - ##### 06:21:59 INFO - ##### Finished create-virtualenv step (success) 06:21:59 INFO - ##### 06:21:59 INFO - ##### 06:21:59 INFO - ##### Running install step. 06:21:59 INFO - ##### 06:21:59 INFO - Running pre-action listener: _resource_record_pre_action 06:21:59 INFO - Running main action method: install 06:21:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:00 INFO - Reading from file tmpfile_stdout 06:22:00 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:00 INFO - Reading from file tmpfile_stdout 06:22:00 INFO - Output received: 06:22:00 INFO - Usage: mozinstall [options] installer 06:22:00 INFO - Options: 06:22:00 INFO - -h, --help show this help message and exit 06:22:00 INFO - -d DEST, --destination=DEST 06:22:00 INFO - Directory to install application into. [default: 06:22:00 INFO - "/builds/slave/test"] 06:22:00 INFO - --app=APP Application being installed. [default: firefox] 06:22:00 INFO - mkdir: /builds/slave/test/build/application 06:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:22:16 INFO - Reading from file tmpfile_stdout 06:22:16 INFO - Output received: 06:22:16 INFO - /builds/slave/test/build/application/firefox/firefox 06:22:16 INFO - Running post-action listener: _resource_record_post_action 06:22:16 INFO - ##### 06:22:16 INFO - ##### Finished install step (success) 06:22:16 INFO - ##### 06:22:16 INFO - ##### 06:22:16 INFO - ##### Running run-tests step. 06:22:16 INFO - ##### 06:22:16 INFO - Running pre-action listener: _resource_record_pre_action 06:22:16 INFO - Running main action method: run_tests 06:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:16 INFO - Python 2.7.3 06:22:16 INFO - Return code: 0 06:22:16 INFO - grabbing minidump binary from tooltool 06:22:16 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')]} 06:22:16 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 0x277b1c0>, '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 0x277c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:16 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 06:22:16 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 06:22:16 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 06:22:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:16 INFO - Return code: 0 06:22:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:22:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:22:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:17 INFO - Return code: 0 06:22:17 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/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 06:22:17 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/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 06:22:17 INFO - Using env: {'DISPLAY': ':0', 06:22:17 INFO - 'HOME': '/home/cltbld', 06:22:17 INFO - 'LANG': 'en_US.UTF-8', 06:22:17 INFO - 'LANGUAGE': 'en_US:en', 06:22:17 INFO - 'LOGNAME': 'cltbld', 06:22:17 INFO - 'MAIL': '/var/mail/cltbld', 06:22:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:17 INFO - 'MOZ_NO_REMOTE': '1', 06:22:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:17 INFO - 'NO_EM_RESTART': '1', 06:22:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:17 INFO - 'PWD': '/builds/slave/test', 06:22:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:17 INFO - 'SHELL': '/bin/bash', 06:22:17 INFO - 'SHLVL': '1', 06:22:17 INFO - 'TERM': 'linux', 06:22:17 INFO - 'TMOUT': '86400', 06:22:17 INFO - 'USER': 'cltbld', 06:22:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191', 06:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:17 INFO - '_': '/tools/buildbot/bin/python'} 06:22:17 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/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 06:22:17 INFO - mozversion application_buildid: 20160604051025 06:22:17 INFO - mozversion application_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 06:22:17 INFO - mozversion application_display_name: Nightly 06:22:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:17 INFO - mozversion application_name: Firefox 06:22:17 INFO - mozversion application_remotingname: firefox 06:22:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:22:17 INFO - mozversion application_vendor: Mozilla 06:22:17 INFO - mozversion application_version: 49.0a1 06:22:17 INFO - mozversion platform_buildid: 20160604051025 06:22:17 INFO - mozversion platform_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 06:22:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:22:17 INFO - mozversion platform_version: 49.0a1 06:22:17 INFO - using testdate: 1465046537 06:22:17 INFO - actual date: 1465046537 06:22:17 INFO - starting webserver on 'localhost:58798' 06:22:17 INFO - SUITE-START | Running 2 tests 06:22:17 INFO - TEST-START | dromaeo_css 06:22:17 INFO - operating with platform_type : linux_ 06:22:17 INFO - Initialising browser for dromaeo_css test... 06:22:17 INFO - TEST-INFO | started process 21616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8ZTHu/profile http://localhost:58798/getInfo.html) 06:22:22 INFO - PROCESS | 21616 | __metrics Screen width/height:1600/1200 06:22:22 INFO - PROCESS | 21616 | colorDepth:24 06:22:22 INFO - PROCESS | 21616 | Browser inner width/height: 1024/697 06:22:22 INFO - PROCESS | 21616 | __metrics 06:22:23 ERROR - PROCESS | 21616 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:22:24 INFO - TEST-INFO | 21616: exit 0 06:22:24 INFO - Browser initialized. 06:22:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:24 INFO - TEST-INFO | started process 21736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8ZTHu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:36 INFO - PROCESS | 21736 | RSS: Main: 168128512 06:22:36 INFO - PROCESS | 21736 | 06:23:25 INFO - PROCESS | 21736 | 1465046605868 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] 06:25:37 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58798/tests/dromaeo/cssquery-ext.html) 06:25:38 INFO - PROCESS | 21736 | RSS: Main: 170127360 06:25:38 INFO - PROCESS | 21736 | 06:28:40 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-ext.html (next: http://localhost:58798/tests/dromaeo/cssquery-jquery.html) 06:28:41 INFO - PROCESS | 21736 | RSS: Main: 170254336 06:28:41 INFO - PROCESS | 21736 | 06:31:43 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58798/tests/dromaeo/cssquery-mootools.html) 06:31:44 INFO - PROCESS | 21736 | RSS: Main: 170950656 06:31:44 INFO - PROCESS | 21736 | 06:34:46 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58798/tests/dromaeo/cssquery-prototype.html) 06:34:46 INFO - PROCESS | 21736 | RSS: Main: 168787968 06:34:46 INFO - PROCESS | 21736 | 06:37:49 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58798/tests/dromaeo/cssquery-yui.html) 06:37:50 INFO - PROCESS | 21736 | RSS: Main: 170319872 06:37:50 INFO - PROCESS | 21736 | 06:40:52 INFO - PROCESS | 21736 | Cycle 1(1): loaded http://localhost:58798/tests/dromaeo/cssquery-yui.html (next: http://localhost:58798/tests/dromaeo/cssquery-dojo.html) 06:40:53 INFO - PROCESS | 21736 | RSS: Main: 171757568 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | __start_tp_report 06:40:53 INFO - PROCESS | 21736 | _x_x_mozilla_page_load 06:40:53 INFO - PROCESS | 21736 | _x_x_mozilla_page_load_details 06:40:53 INFO - PROCESS | 21736 | |i|pagename|runs| 06:40:53 INFO - PROCESS | 21736 | |0;dojo.html;2659.9069032583857;2688.798340124491;2705.9323516912073;2707.539718247897;2714.55209890368;4764.737939413331;4845.030993801236;4856.8785780355465;4864.513548645138;4875.902481950359;4723.787429565669;4784.952150478494;4804.351412559304;4871.683340582859;4889.413270407547;4372.8032238549185;4438.666911440009;4546.818127274905;4552.8861778455475;4580.244259697146;593.4372818245288;4321.719088259253;4380.802863871133;4411.316245981878;4461.910761784762;4428.737809724229;4443.4445694288215;4470.530594287618;4481.955180448186;4490.3937968374175;4485.887852803673;4495.213337665896;4495.235809912323;4502.122086193193;4540.477845047829;4395.428594282755;4455.977720111411;4461;4478.8880277992985;4478.96983693749;4686;4724.622030237607;4730.840943968749;4733.810647574093;4768.47546769855;5107.4892510749;5189.870253243661;5266.289050978107;5281.577473802086;5315.335583052119;5234.555062819627;5260.158374660036;5299.4435584263865;5331;5371.4897084776885;4947.356843610343;4955.702657840541;4956.3804524434445;4958.355413796219;5009.223570346639;5268.683878967197;5295.364556253197;5314.2825718528275;5421.295231619864;5425.674459532362;5097.796088156432;5125.564327032244;5130.281760553526;5132.076226279306;5163.251328557338;5206.7917283309;5207.7916883325;5216.1393370094265;5217.50433708797;5284.022455845681;5031.572316353151;5148.691078535225;5156.8968620627375;5171.612129090258;5180.1711726124395;5109.463506331856;5148.794048238028;5152.92270615941;5162.6386152968935;5191.896162076738;4414.161309351213;4414.823407063745;4418.337249412614;4442.800073996678;4469.508354081114;3733.570639376452;3782.981085094557;3802.334591446486;3814.8855534334016;3834.194819087967;4453.688241823042;4486.68593198473;4531.13908357411;4534.59188673021;4629.65277604181;5245.134552798745;5246.134387826042;5260.316158899319;5261.0793111205385;5277.208418737144;4493.932591011137;4517.81928722854;4575.0392417592675;4593.356930029799;4610.815567377334;4696.060787842377;4697.177993851063;4704.835330763407;4721.693089949143;4747.881302967385;4943.72809495474;4979.402471703346;4983.177775666974;5006.974965125079;5033.395992480926;5065.8733531662;5137.820176293962;5230.424653288059;5268.683878967274;5278.155495120763;4998.700077995332;5019.121653710513;5023.547880690755;5039.521245481674;5046.9747651261505;5193.480651934777;5203.869903252449;5204;5233.842984710464;5239.947600524099;5108.821191258288;5127.6410651254055;5179.741012949413;5289.259503669567;5308.442613525524;5016.097102521581;5112.3865136183895;5141.485851414828;5143.6399452037995;5191.480851914929;5124.79500819978;5138.254953031864;5143.4085080216255;5164.509371609691;5203.505666961632;4831.371921650163;4902.1911384621135;4991;5035.144025515744;5077.92383114261;5139.383274007143;5180.48195180479;5188.662736922088;5197.376314842092;5224.242484839601;5025.170846810382;5056.595472362129;5072.594192464668;5074.67014644047;5087.058894104603 06:40:53 INFO - PROCESS | 21736 | |1;ext.html;539.7664163196629;578.4851482180859;585.2771826793911;596.955228357873;610.3865615056867;34253.657463425356;37847.05382365439;38081.61918380815;38132.80933595335;38324.61675383249;38588.80705596475;38610.80694596523;38905.22189556207;38940.22119557607;39029.21941561167;7698.114716807569;7828.099768526636;7843;7882.172371900954;7901.525908445512;7808.297253247207;7860.253275938805;7869.842603147934;7876.881846772303;7895;7858.882116768253;7898.842023159534;7911.564863932482;7915.525068495908;7929.326007289387;7850.214978502133;7881.645325960289;7900.881486777703;7906.248906353887;7914.683412663487;7779.222077792232;7841.05907291123;7853.685852565947;7853.8821917671285;7867.6852925882895;36483.63516364829;36579.634203658155;36644.26711465782;36763.63236367629;36838;3254.2027203335333;3348.8995330140133;3431.759776815624;3629.8185090745355;3853.9229215415817;28392;28934.42131157386;29060.27349316263;29179.41641167186;29369;2867.842268675222;2894.276430892277;2907.2877145099374;2983.970530167089;3000.699930007004;260491;261166.9999999981;262394;263232;263803;32281.51577726336;33357;33379.3324133516;50629.49370506248;51874.48125518772;34842.65157348445;34900.301993959976;34977.30045399129;34989;35101.824490877385;12720;12820.871791282154;12829.871701283055;12841.871581284067;12871.806922896165;10243.07812296897;10282.845757313646;10356.792864142675;10380.532876020598;10420.374777513374;7847.215278472221;7890.250426209501;7897.526148431112;7966.960165199137;7967.760967170994;3122.7345675617826;3150;3159.684031596868;3161.4151381994407;3186.729128024144;893.5487578772678;933.5285680731323;955.2358113509304;955.3360414511986;1007.1489591295343;26912;27237.863810681218;27760.30599234995;27900.441991160467;27953.161405157876;990.3463713948903;999.7300728803328;1033.5504055735778;1037.8391349340864;1082.4209048159355;14785.852141478448;15002.174880381466;15021.173835439156;15208.619784505254;15273.159976201194;389031;395029;395484;396151;397160;48720.756396217796;49531;49544.75227623839;49557.752211239436;49658;1182.7274945108563;1224.2042672262921;1228.1341654133994;1244.458660482693;1258.8615252322054;26757.197284081507;27535.586966195922;27821.721782782723;28269.57595636108;28301.433971320046;41159.58840411557;41420.1715965685;41786;41857.16285674331;41858.37212441755;267595;269531;271269;273265;273547;24486.142984996153;24661.87669061715;24782.256532304058;24825;25295.241142765746;42004.57995420007;42549.78725106355;42741.78629106835;42865.35701964535;43165.352519712855;35871.82064089663;36421.635783641825;36778;36975.07562310856;37208.6279137216;35518.289634207686;35575.82212088923;35827;36639.26721465609;36906;29860.701392985793;34978.125546860516;35428;35710;38773.80613096916;30698.386032279675;32215.516767248042;32480.512792308607;32495;32708.182295441853;24821.255362339158;25348.366290842878;25447.745522544537;25584;25733.485330292915 06:40:53 INFO - PROCESS | 21736 | |2;jquery.html;379.1488109194857;379.78847476549805;382.8372941499863;391.0614525139663;395.4720448201651;15084.698306033873;16658.916705416486;17162.828371716278;17209.91395043023;17239.31042758288;9520.476373799438;10038.949805250983;10049.64826231082;10335.328203666775;10350;4627.537246275362;4809.879753006167;4883.340748998893;5305.098133317326;5311.309529761125;5218.321618189649;5259.894802103956;5272.288241087443;5278.815241466549;5287.629865909388;5000.274960130779;5204.505571970657;5223.268742376071;5228.372595288571;5253.133233016567;5166.4575219601775;5176.637635365526;5199.584033277329;5213.817516386927;5214.634975551713;4511.6165125964335;4656.092062047902;4703.388559487279;4808.663393562452;4845.103655823684;11752.353620550866;12020.218685785483;12104.515819367214;12198.817017744741;20166.084221999034;1862.2923289150172;1914.2917120665304;1916.0802814649046;1961.1861077652757;1977.2684106880401;12744.36278186087;13628.591142265648;13703.520376786864;13977.72044559103;14461.349239284258;1799.379214171122;1879.3140503716045;1899.4871384726046;1907.1417861962034;1931.7875033746277;57072;59914.40085599132;67716;76262.61868690676;77017.22982770157;16343.26455309514;16569.502914912573;17114.400995965083;17136.314547417962;17144.228509717093;29619;29728.108156755334;29748.40503189924;29806.55290170649;30073.849630752145;8308.376871734645;8655.956720216358;8701.26039286655;8721.912780872237;8763.605637746317;6810.31896810315;6811;6820.31796820314;6834.384905358542;6911.827204319831;8239.917600824036;8359.665613375519;8475.74572762818;8552.144785521397;8594.269487093543;3247.610286765556;3363;3405.489176623477;3519.665631764978;3554.498818663614;855.7261676263536;861.4228466927049;915.1763412928285;930.8324501589778;973.8587904753913;15886.841131588537;16623.83376166247;16661.166941652868;16669.083200424095;16849.15754212309;848.6817443458702;856.6102423397339;887.7381172554112;897.371839712191;914.8856392950881;9156.897254621317;9219.953900230455;9340.906590934004;9504.38221515613;9685.564149613285;364977;375460;377564;377568;381672;50594.49405505972;54964;66980;74519.62740186373;78430.21569784229;878.7934835313696;896.2113340260529;910.5538286239695;924.4360939826701;929.865169550425;15276.923615381851;15279.61800954985;15321.387144514094;15429.382824687336;15811.841881581036;35072.12319691926;35123;35139;35608;35738.463923041694;44110.33834492421;48983.26525102055;49890;50172.24741628805;50410.49589504205;7040.964795175992;7484.288992545699;7556.962215188889;7560.659770310239;7616.0860696716745;11171.832422513506;11306.208565400342;11759.235649682743;11823.586174483851;12330.321832299309;10050.8492372613;10070.093691567794;10123.64567240143;10217.846732298873;10443.164546836082;8339.874901876598;9277.304202184998;9520.143187113194;10137.239707021856;10185.439800811026;10207.489625518843;10271.897281027093;10426.374417534973;10433.843492347469;10580.735481613021;6586.209654841258;6882.139732533434;7115;7579.658915348712;7645.770626881203;7943.523388596703;10095.44475053879;10176.491175441346;10255.7436064099;10394.740131496774 06:40:53 INFO - PROCESS | 21736 | |3;mootools.html;1384.4808196926153;1413.3639862062073;1507.4271776724843;1728.222299965016;1747.6766798142353;6467.320931302216;6780.72877084916;7146.249643787405;7266.164391095019;7266.63666816659;7130.572165670063;7338.926610733904;7360.043194384736;7386.261373862611;7388.298111679395;2103.7054812326246;2147.5704859028256;2153.9461513462134;2156.493224092337;2160.924367647133;2142.2502124256544;2149.3981685128188;2156.5040040790627;2157.320444060124;2158.859674121185;2103.610831996078;2119.9258025969093;2120.6818977153475;2140.1118535807623;2141.7858214178614;2081.2091405266056;2081.8022287882704;2086.54096098858;2086.9269575564936;2094.643910535213;2050.712900193974;2118.5339225370394;2120.236714782677;2149.570085982794;2154.310620601408;7320.0483937088375;7388.482806203568;7390.778276651709;7443.2184620615135;7461.664225109883;4125.628693417607;4191.434156388879;4206.558311377323;4214.220369231702;4219.725717828332;2736.151792944174;2847.786416018786;2890.306326481629;2902.085842959461;2906.1862678449857;869.100481002166;874.6457684637732;885.4554449013874;903.1510380242551;1558.7817705521236;9495.05049495052;9894.505274736235;9965.252606054575;9967.252456065824;9989.051040151247;3741.6071312511795;3813.046738315421;3857.556381016163;3872.0513474199;3915.6280153385383;7909.6836126555445;7916.683332666744;7954.721584744506;7966.0440747110715;7983.68065277394;4066.430699702044;4118.567550407224;4124.360724087771;4165.937510937339;4181.707280490397;3507.2810073934784;3810.6379893910034;3850.3261929162845;3884.5726970033274;3954.8220330085214;3111.7510599152015;3211.6627754085953;3266.575345205156;3306.966930330666;3312.9171770705925;912.8219997100501;914.6112902016616;925.9675911343071;929.8605209218535;932.137772560379;727.989080163798;853.7652145659869;865.731623196811;866.8873046504041;882.3867412148495;4925.482824303468;5094.159463688524;5164.741762911839;5176.120059589879;5231.3199284092825;877.2192748453881;880.4717169698258;926.2312280806914;939;961.2502248246379;3499.702525285328;3638.909027274339;3645.2162785000824;3658.140337020798;3664.2671465706967;9181.770455738526;9342.90657093434;9420.62317507292;9489.952550237205;9512.048795120432;8833.734987950373;8868.512231827182;8929.955350223207;8933.46399216049;9308.301877359225;6819.31806819324;6979.336962988508;6992.300769922967;7001.684924178526;7007.929920700728;4932.260160975882;5000.124978128885;5046.369203849519;5050.469700681376;5055.848324550269;8244.628991695268;8264.132266112212;8307;8332.833343332979;8335.08314085438;7911.960440197762;8167.3466122711225;8187.181281871765;8348.749537513884;8477.915220847712;5709.314882214161;5880.588358814842;5996.1005849122985;6100.908486372619;6145.201123853871;6863.725450981905;7069.681864316221;7078.292170782881;7098.538594991309;7105.928940710527;6299.338569450142;6457.967710161419;6500.934990650222;6505.902411463737;6553.574017689026;6303.306636270098;6308.306086330408;6375.4262116409745;6430.710618022106;6458.1281526995135;5765.8558536036935;5840.269966254218;5843.94156058451;5844.94155058444;5877.500412464989;4403.801828917771;4418.4918734345965;4455.398521199726;4474.284114541658;4503.842365517191;4337.5011873633675;4426.026274219666;4426.734395936254;4517.457905051283;4530.796114174804 06:40:53 INFO - PROCESS | 21736 | |4;prototype.html;281.8548447549512;297.21535147211364;302.401245533843;303.8632615323105;303.89515617112096;4819.638527110472;4994.250862370646;5009.797648564346;5062.6709263897865;5064.493550644938;4729.314249433839;4866.270059491069;4899.608031357492;4940.481249468808;4943.876403089925;3887.591802860701;3912.726109172359;3915;3919.529656441231;3923.3134201514763;3626.4741612466178;3896.045468860133;3908.355121404965;3920.9019774505723;3929.5284565851994;3770.302494038598;3802.885913422602;3805.448210009547;3817.7709337439705;3820.7516511426807;3811.2568049230413;3814.771113733171;3823.1780167264033;3829.5447729862753;3836.7122465814896;3301.422251106047;3319.867205311785;3334;3334.8832790852202;3341.1790574137153;4702.717836929795;4743.667943243974;4749.168895443284;4835.85492435224;4864.440589332236;4351.891202719926;4367.519572846984;4374.409454723604;4386.8903277418;4406.889827754299;5214.739263036871;5216.26972223889;5224.712640804754;5228.2680424740565;5238.423773384925;3577.624349443323;3645.1251699591908;3664.230511592542;3676.981615091934;3680.815959202056;5452.2094296327205;5501.807436739695;5506.587005974568;5510.897820435929;5534.584906132056;3658.2500587379523;3665.193657395369;3683.244934788362;3707.14735610811;3717.9218026772473;3736.75711078779;3765.811709414573;3773.622627740855;3776.8866933992026;3780.281746468162;4163.75017498951;4367.344898265285;4387.451568553931;4389.1660584488845;4399.934000989988;5247.239150323258;5275.20871869215;5297;5302.946970530323;5329.520343169133;1247.2454165230088;1275.8213850061;1305.2560040776857;1308.5943357559188;1312.7571399291162;809.271655510034;814.5967745965785;841.1966571923798;843.9957800210959;847.7287268074157;4143.4199212110325;4152.43942067823;4187.350960601112;4205.894852628709;4284.3145096784365;4800.53583656981;4872.3909511311085;4874.488178741181;4876.7808047988;4909.607231421478;4235;4248.681348898783;4255.787210639455;4264.637505811978;4264.765437900884;2515.962260566093;2564.384547708574;2607.739226077377;2618.7691784861086;2624.973750262473;4515.2324104902245;4588.587027167571;4625.236835922035;4628.907421851544;4634.25851863707;4798.736069516141;4889.657723959289;4901.387326584177;4903.714511277452;4919.409670839522;4588.403507543998;4808.35087263222;5229.816956406507;5246.921296180561;5259.447757985509;5440.646357986719;5482.259894914295;5489.313835770528;5520.641158324696;5524.281843360337;5156.5561642740095;5411.918821217606;5417.133258678593;5423.755930983037;5443.755031023535;5167.560757335668;5168.58651307887;5188.351456067991;5188.403333616531;5198.2202669599865;3735.6451137141926;3763;3774.4527043577978;3794.089418539586;3806.3719486284454;4893.241547560134;5452.182172674131;5504.422035686195;5507.531859791962;5534.778608855761;5239.423663396947;5272.7045596502185;5301.761420736153;5346.97326513365;5356.357237131413;5297.284866542967;5304.151335786256;5304.363476382859;5306.522412982696;5348.117560602457;5051.924221136613;5138.717370544656;5147.150720131286;5179.974100129475;5211.895762084661;5300.734963251899;5305.469453054664;5316.867078322918;5347.796745732179;5359.437259087739;5205.6616319939085;5232.189010703347;5254.60590455725;5255.973720131375;5299.205119231991 06:40:53 INFO - PROCESS | 21736 | |5;yui.html;640.9967950160249;709.3757493405809;711.9549095223967;730.6858051038054;771.2172145272548;12046.819297710541;12549.184303020298;12837.48650053999;12995.740085198291;13019.414126364312;13013.08908376414;13184.604461866136;13211.6697082573;13220;13252.138610990303;778.992210077899;796.8087658961837;796.8605494038549;802.7029998900385;804.6700852650414;631.3339426904614;780.5628847845225;796.2316364708056;802.8073262417037;807.7940125268049;846.5682501924001;847.9279261262769;851.2083762101244;854.0818619983512;854.6965827131372;843.6583183810567;849.8767678686587;850.6087199888059;852.9744107676748;853.5049671190694;611.2573223533428;611.6391329115798;615.2678312807744;615.5598746895946;616.46675625584;12140.514379424812;12177.634670959796;12227.816582751266;12236;12257.14200006;13257;13285.73428531424;13616.795748063787;13620.863791362059;13909.652258693512;10135.797284054352;10166.371470078973;10208;10327.277090603586;10402.063814256677;2994.2215024093675;3013.5027720426106;3014.6533148687963;3021.0634703242067;3051.9847400763074;51629.96740065215;61083;63713.681431592544;63877.361226387606;63926;10411.427371494488;10503.894961050291;10587.788244235073;10603.57585696579;10706.46467676613;18401.81598184028;18462.44612661622;18473.261069557066;18483.630327393646;18497.445076647724;6978.441724662015;6997.545159564612;7004.789856304319;7106.786796396116;7125.42996560274;3727.869524566627;3779.7354185206773;3831.4635950966886;3850.403187505941;3905.1408690088133;2932.501474749298;3079.0916679579577;3081.383723255358;3085.41377138343;3086.6450358208645;531.4685314685315;534.5830252403132;541.9729013549306;542.7259234086761;549.4807407000346;620.0698951572641;624.0496862416834;624.1480379282337;625.9624422534663;627.8995360742259;8555.486670799772;8718.825623487495;8870.822583548294;8919.866202006975;8938.776530586787;624.2851934535023;630.4704048599107;634.9807611794446;643.1767337807614;647.6049609738056;4120.7321524100835;4168.812403441852;4242.830286788494;4251.766152861561;4334.089841133335;56756.43243567594;56843.43156568464;95037;95133;95169;52439.73780131075;64185.03722444167;79478.60260698776;80985.19014809895;82679.5866020666;73148;73398.63300683463;74310.25689743033;74779;75025.62487187638;7759.456838021284;7932;7974.684177110712;7986.84026319482;7992.360611150978;37423.25153496969;37899.863004109924;43505.34741978936;44820.55179448294;44930.55069449264;49665.50334496753;51851;52485.737571311896;59880;61393;11269.943650281695;11575.189736718687;11641.5343386267;11754.353510557;11877.762444750884;12302.200356976768;12415.193012454161;12647.620571382873;13183;13563.660908477366;12080.51677932873;12254.87745122573;12263;12332.50669973191;12670.493180272686;11798.233114847508;12823.807642885551;12866.389412480397;13009.739805204032;13397.196168229937;11973.700657483632;12141.271523708605;12247.448864801283;12544.435500402686;12548.623541293775;9533.904660953302;9888.653897113567;10202.846957295498;10229.539670714687;10274.640387586698;10227.795444090927;10381.688549343531;10398.116160126474;10443.268971171945;10445.634402795866 06:40:53 INFO - PROCESS | 21736 | __end_tp_report 06:40:53 INFO - PROCESS | 21736 | __start_cc_report 06:40:53 INFO - PROCESS | 21736 | _x_x_mozilla_cycle_collect,384 06:40:53 INFO - PROCESS | 21736 | __end_cc_report 06:40:53 INFO - PROCESS | 21736 | __startTimestamp1465047653208__endTimestamp 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | ------- Summary: start ------- 06:40:53 INFO - PROCESS | 21736 | Number of tests: 6 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#0] dojo.html Cycles:165 Average:4803.83 Median:5016.10 stddev:615.63 (12.3%) stddev-sans-first:594.10 06:40:53 INFO - PROCESS | 21736 | Values: 2659.9 2688.8 2705.9 2707.5 2714.6 4764.7 4845.0 4856.9 4864.5 4875.9 4723.8 4785.0 4804.4 4871.7 4889.4 4372.8 4438.7 4546.8 4552.9 4580.2 593.4 4321.7 4380.8 4411.3 4461.9 4428.7 4443.4 4470.5 4482.0 4490.4 4485.9 4495.2 4495.2 4502.1 4540.5 4395.4 4456.0 4461.0 4478.9 4479.0 4686.0 4724.6 4730.8 4733.8 4768.5 5107.5 5189.9 5266.3 5281.6 5315.3 5234.6 5260.2 5299.4 5331.0 5371.5 4947.4 4955.7 4956.4 4958.4 5009.2 5268.7 5295.4 5314.3 5421.3 5425.7 5097.8 5125.6 5130.3 5132.1 5163.3 5206.8 5207.8 5216.1 5217.5 5284.0 5031.6 5148.7 5156.9 5171.6 5180.2 5109.5 5148.8 5152.9 5162.6 5191.9 4414.2 4414.8 4418.3 4442.8 4469.5 3733.6 3783.0 3802.3 3814.9 3834.2 4453.7 4486.7 4531.1 4534.6 4629.7 5245.1 5246.1 5260.3 5261.1 5277.2 4493.9 4517.8 4575.0 4593.4 4610.8 4696.1 4697.2 4704.8 4721.7 4747.9 4943.7 4979.4 4983.2 5007.0 5033.4 5065.9 5137.8 5230.4 5268.7 5278.2 4998.7 5019.1 5023.5 5039.5 5047.0 5193.5 5203.9 5204.0 5233.8 5239.9 5108.8 5127.6 5179.7 5289.3 5308.4 5016.1 5112.4 5141.5 5143.6 5191.5 5124.8 5138.3 5143.4 5164.5 5203.5 4831.4 4902.2 4991.0 5035.1 5077.9 5139.4 5180.5 5188.7 5197.4 5224.2 5025.2 5056.6 5072.6 5074.7 5087.1 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#1] ext.html Cycles:180 Average:45075.06 Median:35642.91 stddev:83128.16 (233.2%) stddev-sans-first:83294.10 06:40:53 INFO - PROCESS | 21736 | Values: 539.8 578.5 585.3 597.0 610.4 34253.7 37847.1 38081.6 38132.8 38324.6 38588.8 38610.8 38905.2 38940.2 39029.2 7698.1 7828.1 7843.0 7882.2 7901.5 7808.3 7860.3 7869.8 7876.9 7895.0 7858.9 7898.8 7911.6 7915.5 7929.3 7850.2 7881.6 7900.9 7906.2 7914.7 7779.2 7841.1 7853.7 7853.9 7867.7 36483.6 36579.6 36644.3 36763.6 36838.0 3254.2 3348.9 3431.8 3629.8 3853.9 28392.0 28934.4 29060.3 29179.4 29369.0 2867.8 2894.3 2907.3 2984.0 3000.7 260491.0 261167.0 262394.0 263232.0 263803.0 32281.5 33357.0 33379.3 50629.5 51874.5 34842.7 34900.3 34977.3 34989.0 35101.8 12720.0 12820.9 12829.9 12841.9 12871.8 10243.1 10282.8 10356.8 10380.5 10420.4 7847.2 7890.3 7897.5 7967.0 7967.8 3122.7 3150.0 3159.7 3161.4 3186.7 893.5 933.5 955.2 955.3 1007.1 26912.0 27237.9 27760.3 27900.4 27953.2 990.3 999.7 1033.6 1037.8 1082.4 14785.9 15002.2 15021.2 15208.6 15273.2 389031.0 395029.0 395484.0 396151.0 397160.0 48720.8 49531.0 49544.8 49557.8 49658.0 1182.7 1224.2 1228.1 1244.5 1258.9 26757.2 27535.6 27821.7 28269.6 28301.4 41159.6 41420.2 41786.0 41857.2 41858.4 267595.0 269531.0 271269.0 273265.0 273547.0 24486.1 24661.9 24782.3 24825.0 25295.2 42004.6 42549.8 42741.8 42865.4 43165.4 35871.8 36421.6 36778.0 36975.1 37208.6 35518.3 35575.8 35827.0 36639.3 36906.0 29860.7 34978.1 35428.0 35710.0 38773.8 30698.4 32215.5 32480.5 32495.0 32708.2 24821.3 25348.4 25447.7 25584.0 25733.5 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#2] jquery.html Cycles:180 Average:23887.48 Median:24310.98 stddev:61768.59 (254.1%) stddev-sans-first:61916.65 06:40:53 INFO - PROCESS | 21736 | Values: 379.1 379.8 382.8 391.1 395.5 15084.7 16658.9 17162.8 17209.9 17239.3 9520.5 10038.9 10049.6 10335.3 10350.0 4627.5 4809.9 4883.3 5305.1 5311.3 5218.3 5259.9 5272.3 5278.8 5287.6 5000.3 5204.5 5223.3 5228.4 5253.1 5166.5 5176.6 5199.6 5213.8 5214.6 4511.6 4656.1 4703.4 4808.7 4845.1 11752.4 12020.2 12104.5 12198.8 20166.1 1862.3 1914.3 1916.1 1961.2 1977.3 12744.4 13628.6 13703.5 13977.7 14461.3 1799.4 1879.3 1899.5 1907.1 1931.8 57072.0 59914.4 67716.0 76262.6 77017.2 16343.3 16569.5 17114.4 17136.3 17144.2 29619.0 29728.1 29748.4 29806.6 30073.8 8308.4 8656.0 8701.3 8721.9 8763.6 6810.3 6811.0 6820.3 6834.4 6911.8 8239.9 8359.7 8475.7 8552.1 8594.3 3247.6 3363.0 3405.5 3519.7 3554.5 855.7 861.4 915.2 930.8 973.9 15886.8 16623.8 16661.2 16669.1 16849.2 848.7 856.6 887.7 897.4 914.9 9156.9 9220.0 9340.9 9504.4 9685.6 364977.0 375460.0 377564.0 377568.0 381672.0 50594.5 54964.0 66980.0 74519.6 78430.2 878.8 896.2 910.6 924.4 929.9 15276.9 15279.6 15321.4 15429.4 15811.8 35072.1 35123.0 35139.0 35608.0 35738.5 44110.3 48983.3 49890.0 50172.2 50410.5 7041.0 7484.3 7557.0 7560.7 7616.1 11171.8 11306.2 11759.2 11823.6 12330.3 10050.8 10070.1 10123.6 10217.8 10443.2 8339.9 9277.3 9520.1 10137.2 10185.4 10207.5 10271.9 10426.4 10433.8 10580.7 6586.2 6882.1 7115.0 7579.7 7645.8 7943.5 10095.4 10176.5 10255.7 10394.7 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#3] mootools.html Cycles:180 Average:4823.27 Median:5861.22 stddev:2646.49 (45.2%) stddev-sans-first:2641.30 06:40:53 INFO - PROCESS | 21736 | Values: 1384.5 1413.4 1507.4 1728.2 1747.7 6467.3 6780.7 7146.2 7266.2 7266.6 7130.6 7338.9 7360.0 7386.3 7388.3 2103.7 2147.6 2153.9 2156.5 2160.9 2142.3 2149.4 2156.5 2157.3 2158.9 2103.6 2119.9 2120.7 2140.1 2141.8 2081.2 2081.8 2086.5 2086.9 2094.6 2050.7 2118.5 2120.2 2149.6 2154.3 7320.0 7388.5 7390.8 7443.2 7461.7 4125.6 4191.4 4206.6 4214.2 4219.7 2736.2 2847.8 2890.3 2902.1 2906.2 869.1 874.6 885.5 903.2 1558.8 9495.1 9894.5 9965.3 9967.3 9989.1 3741.6 3813.0 3857.6 3872.1 3915.6 7909.7 7916.7 7954.7 7966.0 7983.7 4066.4 4118.6 4124.4 4165.9 4181.7 3507.3 3810.6 3850.3 3884.6 3954.8 3111.8 3211.7 3266.6 3307.0 3312.9 912.8 914.6 926.0 929.9 932.1 728.0 853.8 865.7 866.9 882.4 4925.5 5094.2 5164.7 5176.1 5231.3 877.2 880.5 926.2 939.0 961.3 3499.7 3638.9 3645.2 3658.1 3664.3 9181.8 9342.9 9420.6 9490.0 9512.0 8833.7 8868.5 8930.0 8933.5 9308.3 6819.3 6979.3 6992.3 7001.7 7007.9 4932.3 5000.1 5046.4 5050.5 5055.8 8244.6 8264.1 8307.0 8332.8 8335.1 7912.0 8167.3 8187.2 8348.7 8477.9 5709.3 5880.6 5996.1 6100.9 6145.2 6863.7 7069.7 7078.3 7098.5 7105.9 6299.3 6458.0 6500.9 6505.9 6553.6 6303.3 6308.3 6375.4 6430.7 6458.1 5765.9 5840.3 5843.9 5844.9 5877.5 4403.8 4418.5 4455.4 4474.3 4503.8 4337.5 4426.0 4426.7 4517.5 4530.8 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#4] prototype.html Cycles:180 Average:4265.72 Median:4799.64 stddev:1274.68 (26.6%) stddev-sans-first:1242.69 06:40:53 INFO - PROCESS | 21736 | Values: 281.9 297.2 302.4 303.9 303.9 4819.6 4994.3 5009.8 5062.7 5064.5 4729.3 4866.3 4899.6 4940.5 4943.9 3887.6 3912.7 3915.0 3919.5 3923.3 3626.5 3896.0 3908.4 3920.9 3929.5 3770.3 3802.9 3805.4 3817.8 3820.8 3811.3 3814.8 3823.2 3829.5 3836.7 3301.4 3319.9 3334.0 3334.9 3341.2 4702.7 4743.7 4749.2 4835.9 4864.4 4351.9 4367.5 4374.4 4386.9 4406.9 5214.7 5216.3 5224.7 5228.3 5238.4 3577.6 3645.1 3664.2 3677.0 3680.8 5452.2 5501.8 5506.6 5510.9 5534.6 3658.3 3665.2 3683.2 3707.1 3717.9 3736.8 3765.8 3773.6 3776.9 3780.3 4163.8 4367.3 4387.5 4389.2 4399.9 5247.2 5275.2 5297.0 5302.9 5329.5 1247.2 1275.8 1305.3 1308.6 1312.8 809.3 814.6 841.2 844.0 847.7 4143.4 4152.4 4187.4 4205.9 4284.3 4800.5 4872.4 4874.5 4876.8 4909.6 4235.0 4248.7 4255.8 4264.6 4264.8 2516.0 2564.4 2607.7 2618.8 2625.0 4515.2 4588.6 4625.2 4628.9 4634.3 4798.7 4889.7 4901.4 4903.7 4919.4 4588.4 4808.4 5229.8 5246.9 5259.4 5440.6 5482.3 5489.3 5520.6 5524.3 5156.6 5411.9 5417.1 5423.8 5443.8 5167.6 5168.6 5188.4 5188.4 5198.2 3735.6 3763.0 3774.5 3794.1 3806.4 4893.2 5452.2 5504.4 5507.5 5534.8 5239.4 5272.7 5301.8 5347.0 5356.4 5297.3 5304.2 5304.4 5306.5 5348.1 5051.9 5138.7 5147.2 5180.0 5211.9 5300.7 5305.5 5316.9 5347.8 5359.4 5205.7 5232.2 5254.6 5256.0 5299.2 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - PROCESS | 21736 | [#5] yui.html Cycles:180 Average:16691.50 Median:44162.95 stddev:22716.81 (51.4%) stddev-sans-first:22748.57 06:40:53 INFO - PROCESS | 21736 | Values: 641.0 709.4 712.0 730.7 771.2 12046.8 12549.2 12837.5 12995.7 13019.4 13013.1 13184.6 13211.7 13220.0 13252.1 779.0 796.8 796.9 802.7 804.7 631.3 780.6 796.2 802.8 807.8 846.6 847.9 851.2 854.1 854.7 843.7 849.9 850.6 853.0 853.5 611.3 611.6 615.3 615.6 616.5 12140.5 12177.6 12227.8 12236.0 12257.1 13257.0 13285.7 13616.8 13620.9 13909.7 10135.8 10166.4 10208.0 10327.3 10402.1 2994.2 3013.5 3014.7 3021.1 3052.0 51630.0 61083.0 63713.7 63877.4 63926.0 10411.4 10503.9 10587.8 10603.6 10706.5 18401.8 18462.4 18473.3 18483.6 18497.4 6978.4 6997.5 7004.8 7106.8 7125.4 3727.9 3779.7 3831.5 3850.4 3905.1 2932.5 3079.1 3081.4 3085.4 3086.6 531.5 534.6 542.0 542.7 549.5 620.1 624.0 624.1 626.0 627.9 8555.5 8718.8 8870.8 8919.9 8938.8 624.3 630.5 635.0 643.2 647.6 4120.7 4168.8 4242.8 4251.8 4334.1 56756.4 56843.4 95037.0 95133.0 95169.0 52439.7 64185.0 79478.6 80985.2 82679.6 73148.0 73398.6 74310.3 74779.0 75025.6 7759.5 7932.0 7974.7 7986.8 7992.4 37423.3 37899.9 43505.3 44820.6 44930.6 49665.5 51851.0 52485.7 59880.0 61393.0 11269.9 11575.2 11641.5 11754.4 11877.8 12302.2 12415.2 12647.6 13183.0 13563.7 12080.5 12254.9 12263.0 12332.5 12670.5 11798.2 12823.8 12866.4 13009.7 13397.2 11973.7 12141.3 12247.4 12544.4 12548.6 9533.9 9888.7 10202.8 10229.5 10274.6 10227.8 10381.7 10398.1 10443.3 10445.6 06:40:53 INFO - PROCESS | 21736 | -------- Summary: end -------- 06:40:53 INFO - PROCESS | 21736 | 06:40:53 INFO - TEST-INFO | 21736: exit 0 06:40:53 INFO - TEST-OK | dromaeo_css | took 1116650ms 06:40:53 INFO - TEST-START | kraken 06:40:53 INFO - operating with platform_type : linux_ 06:40:53 INFO - Initialising browser for kraken test... 06:40:53 INFO - TEST-INFO | started process 21973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvQaRnX/profile http://localhost:58798/getInfo.html) 06:40:59 INFO - PROCESS | 21973 | __metrics Screen width/height:1600/1200 06:40:59 INFO - PROCESS | 21973 | colorDepth:24 06:40:59 INFO - PROCESS | 21973 | Browser inner width/height: 1024/697 06:40:59 INFO - PROCESS | 21973 | __metrics 06:41:00 ERROR - PROCESS | 21973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:41:00 INFO - TEST-INFO | 21973: exit 0 06:41:00 INFO - Browser initialized. 06:41:00 INFO - Running cycle 1/1 for kraken test... 06:41:00 INFO - TEST-INFO | started process 22093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvQaRnX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:13 INFO - PROCESS | 22093 | RSS: Main: 168124416 06:41:13 INFO - PROCESS | 22093 | 06:41:15 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58798/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:16 INFO - PROCESS | 22093 | RSS: Main: 172376064 06:41:16 INFO - PROCESS | 22093 | 06:41:19 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58798/tests/kraken/driver.html?testName=audio-dft) 06:41:20 INFO - PROCESS | 22093 | RSS: Main: 171962368 06:41:20 INFO - PROCESS | 22093 | 06:41:23 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58798/tests/kraken/driver.html?testName=audio-fft) 06:41:23 INFO - PROCESS | 22093 | RSS: Main: 167485440 06:41:23 INFO - PROCESS | 22093 | 06:41:25 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58798/tests/kraken/driver.html?testName=audio-oscillator) 06:41:26 INFO - PROCESS | 22093 | RSS: Main: 167800832 06:41:26 INFO - PROCESS | 22093 | 06:41:28 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:29 INFO - PROCESS | 22093 | RSS: Main: 168476672 06:41:29 INFO - PROCESS | 22093 | 06:41:32 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58798/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:33 INFO - PROCESS | 22093 | RSS: Main: 168783872 06:41:33 INFO - PROCESS | 22093 | 06:41:36 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58798/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:37 INFO - PROCESS | 22093 | RSS: Main: 166453248 06:41:37 INFO - PROCESS | 22093 | 06:41:40 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58798/tests/kraken/driver.html?testName=json-parse-financial) 06:41:40 INFO - PROCESS | 22093 | RSS: Main: 167620608 06:41:40 INFO - PROCESS | 22093 | 06:41:42 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:43 INFO - PROCESS | 22093 | RSS: Main: 167923712 06:41:43 INFO - PROCESS | 22093 | 06:41:45 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:45 INFO - PROCESS | 22093 | RSS: Main: 167989248 06:41:45 INFO - PROCESS | 22093 | 06:41:48 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:48 INFO - PROCESS | 22093 | RSS: Main: 168312832 06:41:48 INFO - PROCESS | 22093 | 06:41:51 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:52 INFO - PROCESS | 22093 | RSS: Main: 168673280 06:41:52 INFO - PROCESS | 22093 | 06:41:55 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:55 INFO - PROCESS | 22093 | RSS: Main: 168542208 06:41:55 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | Cycle 1(1): loaded http://localhost:58798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58798/tests/kraken/driver.html?testName=ai-astar) 06:41:57 INFO - PROCESS | 22093 | RSS: Main: 169398272 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | __start_tp_report 06:41:57 INFO - PROCESS | 22093 | _x_x_mozilla_page_load 06:41:57 INFO - PROCESS | 22093 | _x_x_mozilla_page_load_details 06:41:57 INFO - PROCESS | 22093 | |i|pagename|runs| 06:41:57 INFO - PROCESS | 22093 | |0;ai-astar;113;109;116;115;116;114;117;113;114;113 06:41:57 INFO - PROCESS | 22093 | |1;audio-beat-detection;166;131;163;178;132;161;154;135;195;132 06:41:57 INFO - PROCESS | 22093 | |2;audio-dft;164;162;168;175;162;163;164;165;162;162 06:41:57 INFO - PROCESS | 22093 | |3;audio-fft;77;75;75;165;77;78;76;77;180;77 06:41:57 INFO - PROCESS | 22093 | |4;audio-oscillator;86;88;150;88;87;86;126;87;87;130 06:41:57 INFO - PROCESS | 22093 | |5;imaging-gaussian-blur;118;117;118;117;117;120;118;118;118;118 06:41:57 INFO - PROCESS | 22093 | |6;imaging-darkroom;148;148;147;148;147;148;147;148;147;147 06:41:57 INFO - PROCESS | 22093 | |7;imaging-desaturate;95;96;95;95;96;96;96;96;95;95 06:41:57 INFO - PROCESS | 22093 | |8;json-parse-financial;64;65;65;66;65;66;65;67;65;67 06:41:57 INFO - PROCESS | 22093 | |9;json-stringify-tinderbox;65;66;65;65;66;65;66;65;66;65 06:41:57 INFO - PROCESS | 22093 | |10;stanford-crypto-aes;83;83;84;84;84;85;86;86;109;91 06:41:57 INFO - PROCESS | 22093 | |11;stanford-crypto-ccm;133;150;134;133;138;134;133;141;135;133 06:41:57 INFO - PROCESS | 22093 | |12;stanford-crypto-pbkdf2;176;175;170;168;172;171;169;170;171;171 06:41:57 INFO - PROCESS | 22093 | |13;stanford-crypto-sha256-iterative;70;69;71;67;68;67;66;71;68;68 06:41:57 INFO - PROCESS | 22093 | __end_tp_report 06:41:57 INFO - PROCESS | 22093 | __start_cc_report 06:41:57 INFO - PROCESS | 22093 | _x_x_mozilla_cycle_collect,977 06:41:57 INFO - PROCESS | 22093 | __end_cc_report 06:41:57 INFO - PROCESS | 22093 | __startTimestamp1465047717810__endTimestamp 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | ------- Summary: start ------- 06:41:57 INFO - PROCESS | 22093 | Number of tests: 14 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:2.26 (2.0%) stddev-sans-first:2.37 06:41:57 INFO - PROCESS | 22093 | Values: 113.0 109.0 116.0 115.0 116.0 114.0 117.0 113.0 114.0 113.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:162.00 stddev:22.07 (13.6%) stddev-sans-first:23.03 06:41:57 INFO - PROCESS | 22093 | Values: 166.0 131.0 163.0 178.0 132.0 161.0 154.0 135.0 195.0 132.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:4.08 (2.5%) stddev-sans-first:4.32 06:41:57 INFO - PROCESS | 22093 | Values: 164.0 162.0 168.0 175.0 162.0 163.0 164.0 165.0 162.0 162.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#3] audio-fft Cycles:10 Average:95.70 Median:77.00 stddev:40.64 (52.8%) stddev-sans-first:42.54 06:41:57 INFO - PROCESS | 22093 | Values: 77.0 75.0 75.0 165.0 77.0 78.0 76.0 77.0 180.0 77.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:87.00 stddev:24.13 (27.7%) stddev-sans-first:24.93 06:41:57 INFO - PROCESS | 22093 | Values: 86.0 88.0 150.0 88.0 87.0 86.0 126.0 87.0 87.0 130.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 06:41:57 INFO - PROCESS | 22093 | Values: 118.0 117.0 118.0 117.0 117.0 120.0 118.0 118.0 118.0 118.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:41:57 INFO - PROCESS | 22093 | Values: 148.0 148.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:41:57 INFO - PROCESS | 22093 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:0.87 06:41:57 INFO - PROCESS | 22093 | Values: 64.0 65.0 65.0 66.0 65.0 66.0 65.0 67.0 65.0 67.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:41:57 INFO - PROCESS | 22093 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.50 stddev:7.91 (9.4%) stddev-sans-first:8.22 06:41:57 INFO - PROCESS | 22093 | Values: 83.0 83.0 84.0 84.0 84.0 85.0 86.0 86.0 109.0 91.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:134.50 stddev:5.46 (4.1%) stddev-sans-first:5.65 06:41:57 INFO - PROCESS | 22093 | Values: 133.0 150.0 134.0 133.0 138.0 134.0 133.0 141.0 135.0 133.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.00 stddev:2.50 (1.5%) stddev-sans-first:1.99 06:41:57 INFO - PROCESS | 22093 | Values: 176.0 175.0 170.0 168.0 172.0 171.0 169.0 170.0 171.0 171.0 06:41:57 INFO - PROCESS | 22093 | 06:41:57 INFO - PROCESS | 22093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.72 (2.5%) stddev-sans-first:1.73 06:41:57 INFO - PROCESS | 22093 | Values: 70.0 69.0 71.0 67.0 68.0 67.0 66.0 71.0 68.0 68.0 06:41:57 INFO - PROCESS | 22093 | -------- Summary: end -------- 06:41:57 INFO - PROCESS | 22093 | 06:41:58 INFO - TEST-INFO | 22093: exit 0 06:41:58 INFO - TEST-OK | kraken | took 65036ms 06:41:59 INFO - SUITE-END | took 1181s 06:41:59 INFO - Completed test suite (00:19:42) 06:41:59 INFO - javascript benchmark 06:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6362.928223044088, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.9069032583857, 2688.798340124491, 2705.9323516912073, 2707.539718247897, 2714.55209890368, 4764.737939413331, 4845.030993801236, 4856.8785780355465, 4864.513548645138, 4875.902481950359, 4723.787429565669, 4784.952150478494, 4804.351412559304, 4871.683340582859, 4889.413270407547, 4372.8032238549185, 4438.666911440009, 4546.818127274905, 4552.8861778455475, 4580.244259697146, 593.4372818245288, 4321.719088259253, 4380.802863871133, 4411.316245981878, 4461.910761784762, 4428.737809724229, 4443.4445694288215, 4470.530594287618, 4481.955180448186, 4490.3937968374175, 4485.887852803673, 4495.213337665896, 4495.235809912323, 4502.122086193193, 4540.477845047829, 4395.428594282755, 4455.977720111411, 4461.0, 4478.8880277992985, 4478.96983693749, 4686.0, 4724.622030237607, 4730.840943968749, 4733.810647574093, 4768.47546769855, 5107.4892510749, 5189.870253243661, 5266.289050978107, 5281.577473802086, 5315.335583052119, 5234.555062819627, 5260.158374660036, 5299.4435584263865, 5331.0, 5371.4897084776885, 4947.356843610343, 4955.702657840541, 4956.3804524434445, 4958.355413796219, 5009.223570346639, 5268.683878967197, 5295.364556253197, 5314.2825718528275, 5421.295231619864, 5425.674459532362, 5097.796088156432, 5125.564327032244, 5130.281760553526, 5132.076226279306, 5163.251328557338, 5206.7917283309, 5207.7916883325, 5216.1393370094265, 5217.50433708797, 5284.022455845681, 5031.572316353151, 5148.691078535225, 5156.8968620627375, 5171.612129090258, 5180.1711726124395, 5109.463506331856, 5148.794048238028, 5152.92270615941, 5162.6386152968935, 5191.896162076738, 4414.161309351213, 4414.823407063745, 4418.337249412614, 4442.800073996678, 4469.508354081114, 3733.570639376452, 3782.981085094557, 3802.334591446486, 3814.8855534334016, 3834.194819087967, 4453.688241823042, 4486.68593198473, 4531.13908357411, 4534.59188673021, 4629.65277604181, 5245.134552798745, 5246.134387826042, 5260.316158899319, 5261.0793111205385, 5277.208418737144, 4493.932591011137, 4517.81928722854, 4575.0392417592675, 4593.356930029799, 4610.815567377334, 4696.060787842377, 4697.177993851063, 4704.835330763407, 4721.693089949143, 4747.881302967385, 4943.72809495474, 4979.402471703346, 4983.177775666974, 5006.974965125079, 5033.395992480926, 5065.8733531662, 5137.820176293962, 5230.424653288059, 5268.683878967274, 5278.155495120763, 4998.700077995332, 5019.121653710513, 5023.547880690755, 5039.521245481674, 5046.9747651261505, 5193.480651934777, 5203.869903252449, 5204.0, 5233.842984710464, 5239.947600524099, 5108.821191258288, 5127.6410651254055, 5179.741012949413, 5289.259503669567, 5308.442613525524, 5016.097102521581, 5112.3865136183895, 5141.485851414828, 5143.6399452037995, 5191.480851914929, 5124.79500819978, 5138.254953031864, 5143.4085080216255, 5164.509371609691, 5203.505666961632, 4831.371921650163, 4902.1911384621135, 4991.0, 5035.144025515744, 5077.92383114261, 5139.383274007143, 5180.48195180479, 5188.662736922088, 5197.376314842092, 5224.242484839601, 5025.170846810382, 5056.595472362129, 5072.594192464668, 5074.67014644047, 5087.058894104603], "value": 4765.004274679456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.7664163196629, 578.4851482180859, 585.2771826793911, 596.955228357873, 610.3865615056867, 34253.657463425356, 37847.05382365439, 38081.61918380815, 38132.80933595335, 38324.61675383249, 38588.80705596475, 38610.80694596523, 38905.22189556207, 38940.22119557607, 39029.21941561167, 7698.114716807569, 7828.099768526636, 7843.0, 7882.172371900954, 7901.525908445512, 7808.297253247207, 7860.253275938805, 7869.842603147934, 7876.881846772303, 7895.0, 7858.882116768253, 7898.842023159534, 7911.564863932482, 7915.525068495908, 7929.326007289387, 7850.214978502133, 7881.645325960289, 7900.881486777703, 7906.248906353887, 7914.683412663487, 7779.222077792232, 7841.05907291123, 7853.685852565947, 7853.8821917671285, 7867.6852925882895, 36483.63516364829, 36579.634203658155, 36644.26711465782, 36763.63236367629, 36838.0, 3254.2027203335333, 3348.8995330140133, 3431.759776815624, 3629.8185090745355, 3853.9229215415817, 28392.0, 28934.42131157386, 29060.27349316263, 29179.41641167186, 29369.0, 2867.842268675222, 2894.276430892277, 2907.2877145099374, 2983.970530167089, 3000.699930007004, 260491.0, 261166.9999999981, 262394.0, 263232.0, 263803.0, 32281.51577726336, 33357.0, 33379.3324133516, 50629.49370506248, 51874.48125518772, 34842.65157348445, 34900.301993959976, 34977.30045399129, 34989.0, 35101.824490877385, 12720.0, 12820.871791282154, 12829.871701283055, 12841.871581284067, 12871.806922896165, 10243.07812296897, 10282.845757313646, 10356.792864142675, 10380.532876020598, 10420.374777513374, 7847.215278472221, 7890.250426209501, 7897.526148431112, 7966.960165199137, 7967.760967170994, 3122.7345675617826, 3150.0, 3159.684031596868, 3161.4151381994407, 3186.729128024144, 893.5487578772678, 933.5285680731323, 955.2358113509304, 955.3360414511986, 1007.1489591295343, 26912.0, 27237.863810681218, 27760.30599234995, 27900.441991160467, 27953.161405157876, 990.3463713948903, 999.7300728803328, 1033.5504055735778, 1037.8391349340864, 1082.4209048159355, 14785.852141478448, 15002.174880381466, 15021.173835439156, 15208.619784505254, 15273.159976201194, 389031.0, 395029.0, 395484.0, 396151.0, 397160.0, 48720.756396217796, 49531.0, 49544.75227623839, 49557.752211239436, 49658.0, 1182.7274945108563, 1224.2042672262921, 1228.1341654133994, 1244.458660482693, 1258.8615252322054, 26757.197284081507, 27535.586966195922, 27821.721782782723, 28269.57595636108, 28301.433971320046, 41159.58840411557, 41420.1715965685, 41786.0, 41857.16285674331, 41858.37212441755, 267595.0, 269531.0, 271269.0, 273265.0, 273547.0, 24486.142984996153, 24661.87669061715, 24782.256532304058, 24825.0, 25295.241142765746, 42004.57995420007, 42549.78725106355, 42741.78629106835, 42865.35701964535, 43165.352519712855, 35871.82064089663, 36421.635783641825, 36778.0, 36975.07562310856, 37208.6279137216, 35518.289634207686, 35575.82212088923, 35827.0, 36639.26721465609, 36906.0, 29860.701392985793, 34978.125546860516, 35428.0, 35710.0, 38773.80613096916, 30698.386032279675, 32215.516767248042, 32480.512792308607, 32495.0, 32708.182295441853, 24821.255362339158, 25348.366290842878, 25447.745522544537, 25584.0, 25733.485330292915], "value": 16275.042128403882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.1488109194857, 379.78847476549805, 382.8372941499863, 391.0614525139663, 395.4720448201651, 15084.698306033873, 16658.916705416486, 17162.828371716278, 17209.91395043023, 17239.31042758288, 9520.476373799438, 10038.949805250983, 10049.64826231082, 10335.328203666775, 10350.0, 4627.537246275362, 4809.879753006167, 4883.340748998893, 5305.098133317326, 5311.309529761125, 5218.321618189649, 5259.894802103956, 5272.288241087443, 5278.815241466549, 5287.629865909388, 5000.274960130779, 5204.505571970657, 5223.268742376071, 5228.372595288571, 5253.133233016567, 5166.4575219601775, 5176.637635365526, 5199.584033277329, 5213.817516386927, 5214.634975551713, 4511.6165125964335, 4656.092062047902, 4703.388559487279, 4808.663393562452, 4845.103655823684, 11752.353620550866, 12020.218685785483, 12104.515819367214, 12198.817017744741, 20166.084221999034, 1862.2923289150172, 1914.2917120665304, 1916.0802814649046, 1961.1861077652757, 1977.2684106880401, 12744.36278186087, 13628.591142265648, 13703.520376786864, 13977.72044559103, 14461.349239284258, 1799.379214171122, 1879.3140503716045, 1899.4871384726046, 1907.1417861962034, 1931.7875033746277, 57072.0, 59914.40085599132, 67716.0, 76262.61868690676, 77017.22982770157, 16343.26455309514, 16569.502914912573, 17114.400995965083, 17136.314547417962, 17144.228509717093, 29619.0, 29728.108156755334, 29748.40503189924, 29806.55290170649, 30073.849630752145, 8308.376871734645, 8655.956720216358, 8701.26039286655, 8721.912780872237, 8763.605637746317, 6810.31896810315, 6811.0, 6820.31796820314, 6834.384905358542, 6911.827204319831, 8239.917600824036, 8359.665613375519, 8475.74572762818, 8552.144785521397, 8594.269487093543, 3247.610286765556, 3363.0, 3405.489176623477, 3519.665631764978, 3554.498818663614, 855.7261676263536, 861.4228466927049, 915.1763412928285, 930.8324501589778, 973.8587904753913, 15886.841131588537, 16623.83376166247, 16661.166941652868, 16669.083200424095, 16849.15754212309, 848.6817443458702, 856.6102423397339, 887.7381172554112, 897.371839712191, 914.8856392950881, 9156.897254621317, 9219.953900230455, 9340.906590934004, 9504.38221515613, 9685.564149613285, 364977.0, 375460.0, 377564.0, 377568.0, 381672.0, 50594.49405505972, 54964.0, 66980.0, 74519.62740186373, 78430.21569784229, 878.7934835313696, 896.2113340260529, 910.5538286239695, 924.4360939826701, 929.865169550425, 15276.923615381851, 15279.61800954985, 15321.387144514094, 15429.382824687336, 15811.841881581036, 35072.12319691926, 35123.0, 35139.0, 35608.0, 35738.463923041694, 44110.33834492421, 48983.26525102055, 49890.0, 50172.24741628805, 50410.49589504205, 7040.964795175992, 7484.288992545699, 7556.962215188889, 7560.659770310239, 7616.0860696716745, 11171.832422513506, 11306.208565400342, 11759.235649682743, 11823.586174483851, 12330.321832299309, 10050.8492372613, 10070.093691567794, 10123.64567240143, 10217.846732298873, 10443.164546836082, 8339.874901876598, 9277.304202184998, 9520.143187113194, 10137.239707021856, 10185.439800811026, 10207.489625518843, 10271.897281027093, 10426.374417534973, 10433.843492347469, 10580.735481613021, 6586.209654841258, 6882.139732533434, 7115.0, 7579.658915348712, 7645.770626881203, 7943.523388596703, 10095.44475053879, 10176.491175441346, 10255.7436064099, 10394.740131496774], "value": 8565.343324203066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.4808196926153, 1413.3639862062073, 1507.4271776724843, 1728.222299965016, 1747.6766798142353, 6467.320931302216, 6780.72877084916, 7146.249643787405, 7266.164391095019, 7266.63666816659, 7130.572165670063, 7338.926610733904, 7360.043194384736, 7386.261373862611, 7388.298111679395, 2103.7054812326246, 2147.5704859028256, 2153.9461513462134, 2156.493224092337, 2160.924367647133, 2142.2502124256544, 2149.3981685128188, 2156.5040040790627, 2157.320444060124, 2158.859674121185, 2103.610831996078, 2119.9258025969093, 2120.6818977153475, 2140.1118535807623, 2141.7858214178614, 2081.2091405266056, 2081.8022287882704, 2086.54096098858, 2086.9269575564936, 2094.643910535213, 2050.712900193974, 2118.5339225370394, 2120.236714782677, 2149.570085982794, 2154.310620601408, 7320.0483937088375, 7388.482806203568, 7390.778276651709, 7443.2184620615135, 7461.664225109883, 4125.628693417607, 4191.434156388879, 4206.558311377323, 4214.220369231702, 4219.725717828332, 2736.151792944174, 2847.786416018786, 2890.306326481629, 2902.085842959461, 2906.1862678449857, 869.100481002166, 874.6457684637732, 885.4554449013874, 903.1510380242551, 1558.7817705521236, 9495.05049495052, 9894.505274736235, 9965.252606054575, 9967.252456065824, 9989.051040151247, 3741.6071312511795, 3813.046738315421, 3857.556381016163, 3872.0513474199, 3915.6280153385383, 7909.6836126555445, 7916.683332666744, 7954.721584744506, 7966.0440747110715, 7983.68065277394, 4066.430699702044, 4118.567550407224, 4124.360724087771, 4165.937510937339, 4181.707280490397, 3507.2810073934784, 3810.6379893910034, 3850.3261929162845, 3884.5726970033274, 3954.8220330085214, 3111.7510599152015, 3211.6627754085953, 3266.575345205156, 3306.966930330666, 3312.9171770705925, 912.8219997100501, 914.6112902016616, 925.9675911343071, 929.8605209218535, 932.137772560379, 727.989080163798, 853.7652145659869, 865.731623196811, 866.8873046504041, 882.3867412148495, 4925.482824303468, 5094.159463688524, 5164.741762911839, 5176.120059589879, 5231.3199284092825, 877.2192748453881, 880.4717169698258, 926.2312280806914, 939.0, 961.2502248246379, 3499.702525285328, 3638.909027274339, 3645.2162785000824, 3658.140337020798, 3664.2671465706967, 9181.770455738526, 9342.90657093434, 9420.62317507292, 9489.952550237205, 9512.048795120432, 8833.734987950373, 8868.512231827182, 8929.955350223207, 8933.46399216049, 9308.301877359225, 6819.31806819324, 6979.336962988508, 6992.300769922967, 7001.684924178526, 7007.929920700728, 4932.260160975882, 5000.124978128885, 5046.369203849519, 5050.469700681376, 5055.848324550269, 8244.628991695268, 8264.132266112212, 8307.0, 8332.833343332979, 8335.08314085438, 7911.960440197762, 8167.3466122711225, 8187.181281871765, 8348.749537513884, 8477.915220847712, 5709.314882214161, 5880.588358814842, 5996.1005849122985, 6100.908486372619, 6145.201123853871, 6863.725450981905, 7069.681864316221, 7078.292170782881, 7098.538594991309, 7105.928940710527, 6299.338569450142, 6457.967710161419, 6500.934990650222, 6505.902411463737, 6553.574017689026, 6303.306636270098, 6308.306086330408, 6375.4262116409745, 6430.710618022106, 6458.1281526995135, 5765.8558536036935, 5840.269966254218, 5843.94156058451, 5844.94155058444, 5877.500412464989, 4403.801828917771, 4418.4918734345965, 4455.398521199726, 4474.284114541658, 4503.842365517191, 4337.5011873633675, 4426.026274219666, 4426.734395936254, 4517.457905051283, 4530.796114174804], "value": 3931.2054819522928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.8548447549512, 297.21535147211364, 302.401245533843, 303.8632615323105, 303.89515617112096, 4819.638527110472, 4994.250862370646, 5009.797648564346, 5062.6709263897865, 5064.493550644938, 4729.314249433839, 4866.270059491069, 4899.608031357492, 4940.481249468808, 4943.876403089925, 3887.591802860701, 3912.726109172359, 3915.0, 3919.529656441231, 3923.3134201514763, 3626.4741612466178, 3896.045468860133, 3908.355121404965, 3920.9019774505723, 3929.5284565851994, 3770.302494038598, 3802.885913422602, 3805.448210009547, 3817.7709337439705, 3820.7516511426807, 3811.2568049230413, 3814.771113733171, 3823.1780167264033, 3829.5447729862753, 3836.7122465814896, 3301.422251106047, 3319.867205311785, 3334.0, 3334.8832790852202, 3341.1790574137153, 4702.717836929795, 4743.667943243974, 4749.168895443284, 4835.85492435224, 4864.440589332236, 4351.891202719926, 4367.519572846984, 4374.409454723604, 4386.8903277418, 4406.889827754299, 5214.739263036871, 5216.26972223889, 5224.712640804754, 5228.2680424740565, 5238.423773384925, 3577.624349443323, 3645.1251699591908, 3664.230511592542, 3676.981615091934, 3680.815959202056, 5452.2094296327205, 5501.807436739695, 5506.587005974568, 5510.897820435929, 5534.584906132056, 3658.2500587379523, 3665.193657395369, 3683.244934788362, 3707.14735610811, 3717.9218026772473, 3736.75711078779, 3765.811709414573, 3773.622627740855, 3776.8866933992026, 3780.281746468162, 4163.75017498951, 4367.344898265285, 4387.451568553931, 4389.1660584488845, 4399.934000989988, 5247.239150323258, 5275.20871869215, 5297.0, 5302.946970530323, 5329.520343169133, 1247.2454165230088, 1275.8213850061, 1305.2560040776857, 1308.5943357559188, 1312.7571399291162, 809.271655510034, 814.5967745965785, 841.1966571923798, 843.9957800210959, 847.7287268074157, 4143.4199212110325, 4152.43942067823, 4187.350960601112, 4205.894852628709, 4284.3145096784365, 4800.53583656981, 4872.3909511311085, 4874.488178741181, 4876.7808047988, 4909.607231421478, 4235.0, 4248.681348898783, 4255.787210639455, 4264.637505811978, 4264.765437900884, 2515.962260566093, 2564.384547708574, 2607.739226077377, 2618.7691784861086, 2624.973750262473, 4515.2324104902245, 4588.587027167571, 4625.236835922035, 4628.907421851544, 4634.25851863707, 4798.736069516141, 4889.657723959289, 4901.387326584177, 4903.714511277452, 4919.409670839522, 4588.403507543998, 4808.35087263222, 5229.816956406507, 5246.921296180561, 5259.447757985509, 5440.646357986719, 5482.259894914295, 5489.313835770528, 5520.641158324696, 5524.281843360337, 5156.5561642740095, 5411.918821217606, 5417.133258678593, 5423.755930983037, 5443.755031023535, 5167.560757335668, 5168.58651307887, 5188.351456067991, 5188.403333616531, 5198.2202669599865, 3735.6451137141926, 3763.0, 3774.4527043577978, 3794.089418539586, 3806.3719486284454, 4893.241547560134, 5452.182172674131, 5504.422035686195, 5507.531859791962, 5534.778608855761, 5239.423663396947, 5272.7045596502185, 5301.761420736153, 5346.97326513365, 5356.357237131413, 5297.284866542967, 5304.151335786256, 5304.363476382859, 5306.522412982696, 5348.117560602457, 5051.924221136613, 5138.717370544656, 5147.150720131286, 5179.974100129475, 5211.895762084661, 5300.734963251899, 5305.469453054664, 5316.867078322918, 5347.796745732179, 5359.437259087739, 5205.6616319939085, 5232.189010703347, 5254.60590455725, 5255.973720131375, 5299.205119231991], "value": 3856.6412910621016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9967950160249, 709.3757493405809, 711.9549095223967, 730.6858051038054, 771.2172145272548, 12046.819297710541, 12549.184303020298, 12837.48650053999, 12995.740085198291, 13019.414126364312, 13013.08908376414, 13184.604461866136, 13211.6697082573, 13220.0, 13252.138610990303, 778.992210077899, 796.8087658961837, 796.8605494038549, 802.7029998900385, 804.6700852650414, 631.3339426904614, 780.5628847845225, 796.2316364708056, 802.8073262417037, 807.7940125268049, 846.5682501924001, 847.9279261262769, 851.2083762101244, 854.0818619983512, 854.6965827131372, 843.6583183810567, 849.8767678686587, 850.6087199888059, 852.9744107676748, 853.5049671190694, 611.2573223533428, 611.6391329115798, 615.2678312807744, 615.5598746895946, 616.46675625584, 12140.514379424812, 12177.634670959796, 12227.816582751266, 12236.0, 12257.14200006, 13257.0, 13285.73428531424, 13616.795748063787, 13620.863791362059, 13909.652258693512, 10135.797284054352, 10166.371470078973, 10208.0, 10327.277090603586, 10402.063814256677, 2994.2215024093675, 3013.5027720426106, 3014.6533148687963, 3021.0634703242067, 3051.9847400763074, 51629.96740065215, 61083.0, 63713.681431592544, 63877.361226387606, 63926.0, 10411.427371494488, 10503.894961050291, 10587.788244235073, 10603.57585696579, 10706.46467676613, 18401.81598184028, 18462.44612661622, 18473.261069557066, 18483.630327393646, 18497.445076647724, 6978.441724662015, 6997.545159564612, 7004.789856304319, 7106.786796396116, 7125.42996560274, 3727.869524566627, 3779.7354185206773, 3831.4635950966886, 3850.403187505941, 3905.1408690088133, 2932.501474749298, 3079.0916679579577, 3081.383723255358, 3085.41377138343, 3086.6450358208645, 531.4685314685315, 534.5830252403132, 541.9729013549306, 542.7259234086761, 549.4807407000346, 620.0698951572641, 624.0496862416834, 624.1480379282337, 625.9624422534663, 627.8995360742259, 8555.486670799772, 8718.825623487495, 8870.822583548294, 8919.866202006975, 8938.776530586787, 624.2851934535023, 630.4704048599107, 634.9807611794446, 643.1767337807614, 647.6049609738056, 4120.7321524100835, 4168.812403441852, 4242.830286788494, 4251.766152861561, 4334.089841133335, 56756.43243567594, 56843.43156568464, 95037.0, 95133.0, 95169.0, 52439.73780131075, 64185.03722444167, 79478.60260698776, 80985.19014809895, 82679.5866020666, 73148.0, 73398.63300683463, 74310.25689743033, 74779.0, 75025.62487187638, 7759.456838021284, 7932.0, 7974.684177110712, 7986.84026319482, 7992.360611150978, 37423.25153496969, 37899.863004109924, 43505.34741978936, 44820.55179448294, 44930.55069449264, 49665.50334496753, 51851.0, 52485.737571311896, 59880.0, 61393.0, 11269.943650281695, 11575.189736718687, 11641.5343386267, 11754.353510557, 11877.762444750884, 12302.200356976768, 12415.193012454161, 12647.620571382873, 13183.0, 13563.660908477366, 12080.51677932873, 12254.87745122573, 12263.0, 12332.50669973191, 12670.493180272686, 11798.233114847508, 12823.807642885551, 12866.389412480397, 13009.739805204032, 13397.196168229937, 11973.700657483632, 12141.271523708605, 12247.448864801283, 12544.435500402686, 12548.623541293775, 9533.904660953302, 9888.653897113567, 10202.846957295498, 10229.539670714687, 10274.640387586698, 10227.795444090927, 10381.688549343531, 10398.116160126474, 10443.268971171945, 10445.634402795866], "value": 6589.14365056511, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 116.0, 115.0, 116.0, 114.0, 117.0, 113.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 131.0, 163.0, 178.0, 132.0, 161.0, 154.0, 135.0, 195.0, 132.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 168.0, 175.0, 162.0, 163.0, 164.0, 165.0, 162.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 165.0, 77.0, 78.0, 76.0, 77.0, 180.0, 77.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 150.0, 88.0, 87.0, 86.0, 126.0, 87.0, 87.0, 130.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 120.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 65.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 84.0, 85.0, 86.0, 86.0, 109.0, 91.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 150.0, 134.0, 133.0, 138.0, 134.0, 133.0, 141.0, 135.0, 133.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 170.0, 168.0, 172.0, 171.0, 169.0, 170.0, 171.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 67.0, 68.0, 67.0, 66.0, 71.0, 68.0, 68.0], "value": 68.5, "unit": "score"}]}]} 06:41:59 INFO - Return code: 0 06:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:41:59 ERROR - # TBPL SUCCESS # 06:41:59 INFO - Running post-action listener: _resource_record_post_action 06:41:59 INFO - ##### 06:41:59 INFO - ##### Finished run-tests step (success) 06:41:59 INFO - ##### 06:41:59 INFO - Running post-run listener: _resource_record_post_run 06:41:59 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533123072; Read time: 8; Write time: 540740 06:41:59 INFO - TinderboxPrint: CPU usage
13.5% 06:41:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:41:59 INFO - TinderboxPrint: I/O write bytes / time
533,123,072 / 540,740 06:41:59 INFO - TinderboxPrint: CPU idle
8,275.6 (86.5%) 06:41:59 INFO - TinderboxPrint: CPU user
1,232.6 (12.9%) 06:41:59 INFO - TinderboxPrint: Swap in / out
0 / 0 06:41:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237469696; Read time: 0; Write time: 312288 06:41:59 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295067648; Read time: 8; Write time: 228444 06:42:00 INFO - Running post-run listener: _upload_blobber_files 06:42:00 INFO - Blob upload gear active. 06:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:42:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:42:00 INFO - (blobuploader) - INFO - Open directory for files ... 06:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:01 INFO - (blobuploader) - INFO - Done attempting. 06:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:05 INFO - (blobuploader) - INFO - Done attempting. 06:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:06 INFO - (blobuploader) - INFO - Done attempting. 06:42:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:42:06 INFO - Return code: 0 06:42:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:42:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:42:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d93faf184b5bb890c0d2c4bce7be82608901832d2312e15abc4df5ceb25275aae695ee17bf837ad3d6476064cd4ab7cf3dadb5c64c2da8e2219d59d6490c8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f69a409bd4862a989aa11062915126835e912f7c9c6d2f24219b63faa83e8c4de27b4d6a78503d44272987c3f63344b6a795a59afc9a0e723ffd99ecca11071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d708222afeb39d5e56d75c885d1ca7dce1f03e80019eb811f1813f60736060c3ab3271e647d9ef11c718430f0e159db8677d23c71a6908ab0943ef852ae402ff"} 06:42:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:42:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:42:06 INFO - Contents: 06:42:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d93faf184b5bb890c0d2c4bce7be82608901832d2312e15abc4df5ceb25275aae695ee17bf837ad3d6476064cd4ab7cf3dadb5c64c2da8e2219d59d6490c8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f69a409bd4862a989aa11062915126835e912f7c9c6d2f24219b63faa83e8c4de27b4d6a78503d44272987c3f63344b6a795a59afc9a0e723ffd99ecca11071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d708222afeb39d5e56d75c885d1ca7dce1f03e80019eb811f1813f60736060c3ab3271e647d9ef11c718430f0e159db8677d23c71a6908ab0943ef852ae402ff"} 06:42:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:42:06 INFO - Copying logs to upload dir... 06:42:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:42:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.708208 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-04 06:42:04.602511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 06:42:04.605927) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 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/43d93faf184b5bb890c0d2c4bce7be82608901832d2312e15abc4df5ceb25275aae695ee17bf837ad3d6476064cd4ab7cf3dadb5c64c2da8e2219d59d6490c8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f69a409bd4862a989aa11062915126835e912f7c9c6d2f24219b63faa83e8c4de27b4d6a78503d44272987c3f63344b6a795a59afc9a0e723ffd99ecca11071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d708222afeb39d5e56d75c885d1ca7dce1f03e80019eb811f1813f60736060c3ab3271e647d9ef11c718430f0e159db8677d23c71a6908ab0943ef852ae402ff"} build_url:https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/bpZ7DX-5QUW8ui8lTG_e-Q/artifacts/public/build/firefox-49.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/43d93faf184b5bb890c0d2c4bce7be82608901832d2312e15abc4df5ceb25275aae695ee17bf837ad3d6476064cd4ab7cf3dadb5c64c2da8e2219d59d6490c8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f69a409bd4862a989aa11062915126835e912f7c9c6d2f24219b63faa83e8c4de27b4d6a78503d44272987c3f63344b6a795a59afc9a0e723ffd99ecca11071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d708222afeb39d5e56d75c885d1ca7dce1f03e80019eb811f1813f60736060c3ab3271e647d9ef11c718430f0e159db8677d23c71a6908ab0943ef852ae402ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 06:42:04.631041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:42:04.631394) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465042376.237959-1080450191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:42:04.716729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 06:42:04.717085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 06:42:04.717419) ========= ========= Total master_lag: 0.16 =========