builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1466085805.28 results: success (0) buildid: 20160616043034 builduid: 6ff710ea46a64791b8be11309e1efc5d revision: b9f4f38063951cd5a8b249911aea61869f40fd1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.277828) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.278251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.278798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.310841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.311147) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 07:03:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-16 07:03:25 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067912 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.429965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.430273) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:25.471343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 07:03:25.474757) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b9f4f38063951cd5a8b249911aea61869f40fd1f --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 b9f4f38063951cd5a8b249911aea61869f40fd1f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 07:03:25,650 truncating revision to first 12 chars 2016-06-16 07:03:25,650 Setting DEBUG logging. 2016-06-16 07:03:25,650 attempt 1/10 2016-06-16 07:03:25,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b9f4f3806395?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 07:03:25,941 unpacking tar archive at: mozilla-central-b9f4f3806395/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619442 ========= master_lag: 1.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 07:03:27.276036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:27.276361) ========= script_repo_revision: b9f4f38063951cd5a8b249911aea61869f40fd1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:27.279827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:27.280114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 07:03:27.360088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 07:03:27.360368) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:27 INFO - MultiFileLogger online at 20160616 07:03:27 in /builds/slave/test 07:03:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:03:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:27 INFO - {'append_to_log': False, 07:03:27 INFO - 'base_work_dir': '/builds/slave/test', 07:03:27 INFO - 'blob_upload_branch': 'Firefox', 07:03:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:27 INFO - 'branch': 'Firefox', 07:03:27 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:27 INFO - 'config_files': ('talos/linux_config.py',), 07:03:27 INFO - 'default_actions': ('clobber', 07:03:27 INFO - 'read-buildbot-config', 07:03:27 INFO - 'download-and-extract', 07:03:27 INFO - 'populate-webroot', 07:03:27 INFO - 'create-virtualenv', 07:03:27 INFO - 'install', 07:03:27 INFO - 'run-tests'), 07:03:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:27 INFO - 'download_minidump_stackwalk': True, 07:03:27 INFO - 'download_symbols': 'ondemand', 07:03:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:27 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:27 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:27 INFO - 'installer_path': 'installer.exe', 07:03:27 INFO - 'log_level': 'info', 07:03:27 INFO - 'log_name': 'talos', 07:03:27 INFO - 'log_to_console': True, 07:03:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:27 INFO - 'opt_config_files': (), 07:03:27 INFO - 'pip_index': False, 07:03:27 INFO - 'sps_profile': False, 07:03:27 INFO - 'sps_profile_interval': 0, 07:03:27 INFO - 'suite': 'dromaeojs-e10s', 07:03:27 INFO - 'system_bits': '32', 07:03:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:27 INFO - 'title': 'talos-linux64-ix-051', 07:03:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:27 INFO - 'use_talos_json': True, 07:03:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:27 INFO - 'work_dir': 'build'} 07:03:27 INFO - ##### 07:03:27 INFO - ##### Running clobber step. 07:03:27 INFO - ##### 07:03:27 INFO - Running pre-action listener: _resource_record_pre_action 07:03:27 INFO - Running main action method: clobber 07:03:27 INFO - rmtree: /builds/slave/test/build 07:03:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:28 INFO - Running post-action listener: _resource_record_post_action 07:03:28 INFO - ##### 07:03:28 INFO - ##### Finished clobber step (success) 07:03:28 INFO - ##### 07:03:28 INFO - ##### 07:03:28 INFO - ##### Running read-buildbot-config step. 07:03:28 INFO - ##### 07:03:28 INFO - Running pre-action listener: _resource_record_pre_action 07:03:28 INFO - Running main action method: read_buildbot_config 07:03:28 INFO - Using buildbot properties: 07:03:28 INFO - { 07:03:28 INFO - "project": "", 07:03:28 INFO - "product": "firefox", 07:03:28 INFO - "script_repo_revision": "production", 07:03:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:03:28 INFO - "repository": "", 07:03:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:03:28 INFO - "buildid": "20160616043034", 07:03:28 INFO - "pgo_build": "True", 07:03:28 INFO - "basedir": "/builds/slave/test", 07:03:28 INFO - "buildnumber": 252, 07:03:28 INFO - "slavename": "talos-linux64-ix-051", 07:03:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:03:28 INFO - "platform": "ubuntu64_hw", 07:03:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:03:28 INFO - "branch": "mozilla-central", 07:03:28 INFO - "repo_path": "mozilla-central", 07:03:28 INFO - "revision": "b9f4f38063951cd5a8b249911aea61869f40fd1f", 07:03:28 INFO - "stage_platform": "linux64-pgo", 07:03:28 INFO - "builduid": "6ff710ea46a64791b8be11309e1efc5d", 07:03:28 INFO - "slavebuilddir": "test" 07:03:28 INFO - } 07:03:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:03:28 INFO - Running post-action listener: _resource_record_post_action 07:03:28 INFO - ##### 07:03:28 INFO - ##### Finished read-buildbot-config step (success) 07:03:28 INFO - ##### 07:03:28 INFO - ##### 07:03:28 INFO - ##### Running download-and-extract step. 07:03:28 INFO - ##### 07:03:28 INFO - Running pre-action listener: _resource_record_pre_action 07:03:28 INFO - Running main action method: download_and_extract 07:03:28 INFO - mkdir: /builds/slave/test/build/tests 07:03: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')]} 07:03:28 INFO - https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:03:36 INFO - Downloaded 1361 bytes. 07:03:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:36 INFO - Using the following test package requirements: 07:03:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:03:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:03:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:03:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'jsshell-linux-x86_64.zip'], 07:03:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:03:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:03:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:03:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:03:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:03:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:03:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:36 INFO - https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:03:37 INFO - Downloaded 24220589 bytes. 07:03:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:03:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:03:39 INFO - Return code: 0 07:03:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:39 INFO - https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:03:40 INFO - Downloaded 24220589 bytes. 07:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:03:42 INFO - Return code: 0 07:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:42 INFO - https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:03:44 INFO - Downloaded 14405384 bytes. 07:03:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:03:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:03:44 INFO - Return code: 0 07:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:44 INFO - https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:03:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:03:46 INFO - Downloaded 59386208 bytes. 07:03:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:46 INFO - mkdir: /builds/slave/test/properties 07:03:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:46 INFO - Contents: 07:03:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:47 INFO - Running post-action listener: _resource_record_post_action 07:03:47 INFO - Running post-action listener: set_extra_try_arguments 07:03:47 INFO - ##### 07:03:47 INFO - ##### Finished download-and-extract step (success) 07:03:47 INFO - ##### 07:03:47 INFO - ##### 07:03:47 INFO - ##### Running populate-webroot step. 07:03:47 INFO - ##### 07:03:47 INFO - Running pre-action listener: _resource_record_pre_action 07:03:47 INFO - Running main action method: populate_webroot 07:03:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:47 INFO - '--tppagecycles', 07:03:47 INFO - '7'], 07:03:47 INFO - 'tests': ['tsvgm']}}, 07:03:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:03:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['damp', 'tps']}, 07:03:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'tests': ['damp', 'tps']}, 07:03:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['dromaeo_dom']}, 07:03:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['basic_compositor_video']}, 07:03:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:03:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['a11yr', 07:03:47 INFO - 'ts_paint', 07:03:47 INFO - 'tpaint', 07:03:47 INFO - 'sessionrestore', 07:03:47 INFO - 'sessionrestore_no_auto_restore', 07:03:47 INFO - 'tabpaint']}, 07:03:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['tsvgx', 07:03:47 INFO - 'tsvgr_opacity', 07:03:47 INFO - 'tart', 07:03:47 INFO - 'tscrollx', 07:03:47 INFO - 'cart']}, 07:03:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:47 INFO - 'tsvgr_opacity', 07:03:47 INFO - 'tart', 07:03:47 INFO - 'tscrollx', 07:03:47 INFO - 'cart']}, 07:03:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'talos_options': ['--disable-e10s'], 07:03:47 INFO - 'tests': ['tp5o']}, 07:03:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'tests': ['tp5o']}, 07:03:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'talos_options': ['--disable-e10s', 07:03:47 INFO - '--xperf_path', 07:03:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:47 INFO - 'tests': ['tp5n']}, 07:03:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:47 INFO - 'talos_options': ['--xperf_path', 07:03:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:47 INFO - 'tests': ['tp5n']}}, 07:03:47 INFO - 'talos.zip': {'path': '', 07:03:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:47 INFO - Running post-action listener: _resource_record_post_action 07:03:47 INFO - ##### 07:03:47 INFO - ##### Finished populate-webroot step (success) 07:03:47 INFO - ##### 07:03:47 INFO - ##### 07:03:47 INFO - ##### Running create-virtualenv step. 07:03:47 INFO - ##### 07:03:47 INFO - Running pre-action listener: _resource_record_pre_action 07:03:47 INFO - Running main action method: create_virtualenv 07:03:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:03:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:47 INFO - Using real prefix '/usr' 07:03:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:49 INFO - Installing pip.................done. 07:03:49 INFO - Return code: 0 07:03:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:49 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:03:49 INFO - Using env: {'DISPLAY': ':0', 07:03:49 INFO - 'HOME': '/home/cltbld', 07:03:49 INFO - 'LANG': 'en_US.UTF-8', 07:03:49 INFO - 'LANGUAGE': 'en_US:en', 07:03:49 INFO - 'LOGNAME': 'cltbld', 07:03:49 INFO - 'MAIL': '/var/mail/cltbld', 07:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:49 INFO - 'MOZ_NO_REMOTE': '1', 07:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:49 INFO - 'NO_EM_RESTART': '1', 07:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:49 INFO - 'PWD': '/builds/slave/test', 07:03:49 INFO - 'SHELL': '/bin/bash', 07:03:49 INFO - 'SHLVL': '1', 07:03:49 INFO - 'TERM': 'linux', 07:03:49 INFO - 'TMOUT': '86400', 07:03:49 INFO - 'USER': 'cltbld', 07:03:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:49 INFO - '_': '/tools/buildbot/bin/python'} 07:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:03:49 INFO - Cleaning up... 07:03:49 INFO - Return code: 0 07:03:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:49 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:03:49 INFO - Using env: {'DISPLAY': ':0', 07:03:49 INFO - 'HOME': '/home/cltbld', 07:03:49 INFO - 'LANG': 'en_US.UTF-8', 07:03:49 INFO - 'LANGUAGE': 'en_US:en', 07:03:49 INFO - 'LOGNAME': 'cltbld', 07:03:49 INFO - 'MAIL': '/var/mail/cltbld', 07:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:49 INFO - 'MOZ_NO_REMOTE': '1', 07:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:49 INFO - 'NO_EM_RESTART': '1', 07:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:49 INFO - 'PWD': '/builds/slave/test', 07:03:49 INFO - 'SHELL': '/bin/bash', 07:03:49 INFO - 'SHLVL': '1', 07:03:49 INFO - 'TERM': 'linux', 07:03:49 INFO - 'TMOUT': '86400', 07:03:49 INFO - 'USER': 'cltbld', 07:03:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:49 INFO - '_': '/tools/buildbot/bin/python'} 07:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:50 INFO - Downloading/unpacking psutil>=3.1.1 07:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:03:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:52 INFO - Installing collected packages: psutil 07:03:52 INFO - Running setup.py install for psutil 07:03:52 INFO - building 'psutil._psutil_linux' extension 07:03:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:03:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:03:52 INFO - building 'psutil._psutil_posix' extension 07:03:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:03:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:03:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:52 INFO - Successfully installed psutil 07:03:52 INFO - Cleaning up... 07:03:52 INFO - Return code: 0 07:03:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:03:52 INFO - Using env: {'DISPLAY': ':0', 07:03:52 INFO - 'HOME': '/home/cltbld', 07:03:52 INFO - 'LANG': 'en_US.UTF-8', 07:03:52 INFO - 'LANGUAGE': 'en_US:en', 07:03:52 INFO - 'LOGNAME': 'cltbld', 07:03:52 INFO - 'MAIL': '/var/mail/cltbld', 07:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:52 INFO - 'MOZ_NO_REMOTE': '1', 07:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:52 INFO - 'NO_EM_RESTART': '1', 07:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:52 INFO - 'PWD': '/builds/slave/test', 07:03:52 INFO - 'SHELL': '/bin/bash', 07:03:52 INFO - 'SHLVL': '1', 07:03:52 INFO - 'TERM': 'linux', 07:03:52 INFO - 'TMOUT': '86400', 07:03:52 INFO - 'USER': 'cltbld', 07:03:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:52 INFO - '_': '/tools/buildbot/bin/python'} 07:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:03:54 INFO - Installing collected packages: mozsystemmonitor 07:03:54 INFO - Running setup.py install for mozsystemmonitor 07:03:54 INFO - Successfully installed mozsystemmonitor 07:03:54 INFO - Cleaning up... 07:03:54 INFO - Return code: 0 07:03:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:03:54 INFO - Using env: {'DISPLAY': ':0', 07:03:54 INFO - 'HOME': '/home/cltbld', 07:03:54 INFO - 'LANG': 'en_US.UTF-8', 07:03:54 INFO - 'LANGUAGE': 'en_US:en', 07:03:54 INFO - 'LOGNAME': 'cltbld', 07:03:54 INFO - 'MAIL': '/var/mail/cltbld', 07:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:54 INFO - 'MOZ_NO_REMOTE': '1', 07:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:54 INFO - 'NO_EM_RESTART': '1', 07:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:54 INFO - 'PWD': '/builds/slave/test', 07:03:54 INFO - 'SHELL': '/bin/bash', 07:03:54 INFO - 'SHLVL': '1', 07:03:54 INFO - 'TERM': 'linux', 07:03:54 INFO - 'TMOUT': '86400', 07:03:54 INFO - 'USER': 'cltbld', 07:03:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:54 INFO - '_': '/tools/buildbot/bin/python'} 07:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:03:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:03:58 INFO - warning: no files found matching '*.txt' 07:03:58 INFO - no previously-included directories found matching 'build' 07:03:58 INFO - no previously-included directories found matching 'dist' 07:03:58 INFO - no previously-included directories found matching '.git*' 07:03:58 INFO - Installing collected packages: jsonschema, functools32 07:03:58 INFO - Running setup.py install for functools32 07:03:58 INFO - warning: no files found matching '*.txt' 07:03:58 INFO - no previously-included directories found matching 'build' 07:03:58 INFO - no previously-included directories found matching 'dist' 07:03:58 INFO - no previously-included directories found matching '.git*' 07:03:58 INFO - Successfully installed jsonschema functools32 07:03:58 INFO - Cleaning up... 07:03:58 INFO - Return code: 0 07:03:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:04:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:01 INFO - Downloading docopt-0.6.1.tar.gz 07:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:01 INFO - Running setup.py install for blobuploader 07:04:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:01 INFO - Running setup.py install for requests 07:04:01 INFO - Running setup.py install for docopt 07:04:01 INFO - Successfully installed blobuploader requests docopt 07:04:01 INFO - Cleaning up... 07:04:01 INFO - Return code: 0 07:04:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:01 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:01 INFO - Using env: {'DISPLAY': ':0', 07:04:01 INFO - 'HOME': '/home/cltbld', 07:04:01 INFO - 'LANG': 'en_US.UTF-8', 07:04:01 INFO - 'LANGUAGE': 'en_US:en', 07:04:01 INFO - 'LOGNAME': 'cltbld', 07:04:01 INFO - 'MAIL': '/var/mail/cltbld', 07:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:01 INFO - 'MOZ_NO_REMOTE': '1', 07:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:01 INFO - 'NO_EM_RESTART': '1', 07:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:01 INFO - 'PWD': '/builds/slave/test', 07:04:01 INFO - 'SHELL': '/bin/bash', 07:04:01 INFO - 'SHLVL': '1', 07:04:01 INFO - 'TERM': 'linux', 07:04:01 INFO - 'TMOUT': '86400', 07:04:01 INFO - 'USER': 'cltbld', 07:04:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:01 INFO - '_': '/tools/buildbot/bin/python'} 07:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:02 INFO - Running setup.py (path:/tmp/pip-M4ymhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:02 INFO - Running setup.py (path:/tmp/pip-px8YJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:02 INFO - Running setup.py (path:/tmp/pip-Zp8wmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:02 INFO - Running setup.py (path:/tmp/pip-inkpSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:02 INFO - Running setup.py (path:/tmp/pip-4G1NZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:02 INFO - Running setup.py (path:/tmp/pip-Z9FfwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:02 INFO - Running setup.py (path:/tmp/pip-oUzMnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:02 INFO - Running setup.py (path:/tmp/pip-qSt9Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:02 INFO - Running setup.py (path:/tmp/pip-wRkKWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:02 INFO - Running setup.py (path:/tmp/pip-AcliB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:02 INFO - Running setup.py (path:/tmp/pip-cURQvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:02 INFO - Running setup.py (path:/tmp/pip-eLEiez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:03 INFO - Running setup.py (path:/tmp/pip-xBdTSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:03 INFO - Running setup.py (path:/tmp/pip-YnW6DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:03 INFO - Running setup.py (path:/tmp/pip-cNgLXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:03 INFO - Running setup.py (path:/tmp/pip-N5jBhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:03 INFO - Running setup.py (path:/tmp/pip-b1Bwv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:03 INFO - Running setup.py install for manifestparser 07:04:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:03 INFO - Running setup.py install for mozcrash 07:04:03 INFO - Running setup.py install for mozdebug 07:04:03 INFO - Running setup.py install for mozdevice 07:04:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:04:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:03 INFO - Running setup.py install for mozfile 07:04:03 INFO - Running setup.py install for mozhttpd 07:04:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozinfo 07:04:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozInstall 07:04:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozleak 07:04:04 INFO - Running setup.py install for mozlog 07:04:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for moznetwork 07:04:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozprocess 07:04:04 INFO - Running setup.py install for mozprofile 07:04:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozrunner 07:04:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:04 INFO - Running setup.py install for mozscreenshot 07:04:04 INFO - Running setup.py install for moztest 07:04:05 INFO - Running setup.py install for mozversion 07:04:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:05 INFO - Cleaning up... 07:04:05 INFO - Return code: 0 07:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:05 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:05 INFO - Using env: {'DISPLAY': ':0', 07:04:05 INFO - 'HOME': '/home/cltbld', 07:04:05 INFO - 'LANG': 'en_US.UTF-8', 07:04:05 INFO - 'LANGUAGE': 'en_US:en', 07:04:05 INFO - 'LOGNAME': 'cltbld', 07:04:05 INFO - 'MAIL': '/var/mail/cltbld', 07:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:05 INFO - 'MOZ_NO_REMOTE': '1', 07:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:05 INFO - 'NO_EM_RESTART': '1', 07:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:05 INFO - 'PWD': '/builds/slave/test', 07:04:05 INFO - 'SHELL': '/bin/bash', 07:04:05 INFO - 'SHLVL': '1', 07:04:05 INFO - 'TERM': 'linux', 07:04:05 INFO - 'TMOUT': '86400', 07:04:05 INFO - 'USER': 'cltbld', 07:04:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:05 INFO - '_': '/tools/buildbot/bin/python'} 07:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:05 INFO - Running setup.py (path:/tmp/pip-NuUZPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:05 INFO - Running setup.py (path:/tmp/pip-y2bVCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:05 INFO - Running setup.py (path:/tmp/pip-RelTzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:05 INFO - Running setup.py (path:/tmp/pip-wJB9Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:05 INFO - Running setup.py (path:/tmp/pip-vTTn6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:05 INFO - Running setup.py (path:/tmp/pip-nV__EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:05 INFO - Running setup.py (path:/tmp/pip-yHYvSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:05 INFO - Running setup.py (path:/tmp/pip-z74KRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:06 INFO - Running setup.py (path:/tmp/pip-DW_3sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:06 INFO - Running setup.py (path:/tmp/pip-dbhneJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:06 INFO - Running setup.py (path:/tmp/pip-75lirt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:06 INFO - Running setup.py (path:/tmp/pip-JM02Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:06 INFO - Running setup.py (path:/tmp/pip-aVaESj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:06 INFO - Running setup.py (path:/tmp/pip-NvawHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:06 INFO - Running setup.py (path:/tmp/pip-cCFGDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:06 INFO - Running setup.py (path:/tmp/pip-LskJvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:06 INFO - Running setup.py (path:/tmp/pip-x14jZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - Downloading blessings-1.6.tar.gz 07:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:08 INFO - Installing collected packages: blessings 07:04:08 INFO - Running setup.py install for blessings 07:04:08 INFO - Successfully installed blessings 07:04:08 INFO - Cleaning up... 07:04:08 INFO - Return code: 0 07:04:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:04:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:09 INFO - Reading from file tmpfile_stdout 07:04:09 INFO - Current package versions: 07:04:09 INFO - argparse == 1.2.1 07:04:09 INFO - blessings == 1.6 07:04:09 INFO - blobuploader == 1.2.4 07:04:09 INFO - docopt == 0.6.1 07:04:09 INFO - functools32 == 3.2.3-2 07:04:09 INFO - jsonschema == 2.5.1 07:04:09 INFO - manifestparser == 1.1 07:04:09 INFO - mozInstall == 1.12 07:04:09 INFO - mozcrash == 0.17 07:04:09 INFO - mozdebug == 0.1 07:04:09 INFO - mozdevice == 0.48 07:04:09 INFO - mozfile == 1.2 07:04:09 INFO - mozhttpd == 0.7 07:04:09 INFO - mozinfo == 0.9 07:04:09 INFO - mozleak == 0.1 07:04:09 INFO - mozlog == 3.2 07:04:09 INFO - moznetwork == 0.27 07:04:09 INFO - mozprocess == 0.22 07:04:09 INFO - mozprofile == 0.28 07:04:09 INFO - mozrunner == 6.11 07:04:09 INFO - mozscreenshot == 0.1 07:04:09 INFO - mozsystemmonitor == 0.3 07:04:09 INFO - moztest == 0.7 07:04:09 INFO - mozversion == 1.4 07:04:09 INFO - psutil == 3.1.1 07:04:09 INFO - requests == 1.2.3 07:04:09 INFO - wsgiref == 0.1.2 07:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:09 INFO - Using env: {'DISPLAY': ':0', 07:04:09 INFO - 'HOME': '/home/cltbld', 07:04:09 INFO - 'LANG': 'en_US.UTF-8', 07:04:09 INFO - 'LANGUAGE': 'en_US:en', 07:04:09 INFO - 'LOGNAME': 'cltbld', 07:04:09 INFO - 'MAIL': '/var/mail/cltbld', 07:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:09 INFO - 'MOZ_NO_REMOTE': '1', 07:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:09 INFO - 'NO_EM_RESTART': '1', 07:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:09 INFO - 'PWD': '/builds/slave/test', 07:04:09 INFO - 'SHELL': '/bin/bash', 07:04:09 INFO - 'SHLVL': '1', 07:04:09 INFO - 'TERM': 'linux', 07:04:09 INFO - 'TMOUT': '86400', 07:04:09 INFO - 'USER': 'cltbld', 07:04:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:09 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:04:09 INFO - Cleaning up... 07:04:09 INFO - Return code: 0 07:04:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:04:09 INFO - Using env: {'DISPLAY': ':0', 07:04:09 INFO - 'HOME': '/home/cltbld', 07:04:09 INFO - 'LANG': 'en_US.UTF-8', 07:04:09 INFO - 'LANGUAGE': 'en_US:en', 07:04:09 INFO - 'LOGNAME': 'cltbld', 07:04:09 INFO - 'MAIL': '/var/mail/cltbld', 07:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:09 INFO - 'MOZ_NO_REMOTE': '1', 07:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:09 INFO - 'NO_EM_RESTART': '1', 07:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:09 INFO - 'PWD': '/builds/slave/test', 07:04:09 INFO - 'SHELL': '/bin/bash', 07:04:09 INFO - 'SHLVL': '1', 07:04:09 INFO - 'TERM': 'linux', 07:04:09 INFO - 'TMOUT': '86400', 07:04:09 INFO - 'USER': 'cltbld', 07:04:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:09 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:04:09 INFO - Cleaning up... 07:04:09 INFO - Return code: 0 07:04:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:09 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 0x7ffde6e98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:04:09 INFO - Using env: {'DISPLAY': ':0', 07:04:09 INFO - 'HOME': '/home/cltbld', 07:04:09 INFO - 'LANG': 'en_US.UTF-8', 07:04:09 INFO - 'LANGUAGE': 'en_US:en', 07:04:09 INFO - 'LOGNAME': 'cltbld', 07:04:09 INFO - 'MAIL': '/var/mail/cltbld', 07:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:09 INFO - 'MOZ_NO_REMOTE': '1', 07:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:09 INFO - 'NO_EM_RESTART': '1', 07:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:09 INFO - 'PWD': '/builds/slave/test', 07:04:09 INFO - 'SHELL': '/bin/bash', 07:04:09 INFO - 'SHLVL': '1', 07:04:09 INFO - 'TERM': 'linux', 07:04:09 INFO - 'TMOUT': '86400', 07:04:09 INFO - 'USER': 'cltbld', 07:04:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:09 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Downloading/unpacking flake8 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:04:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:04:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:04:12 INFO - no previously-included directories found matching 'docs/_build' 07:04:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:04:12 INFO - Running setup.py install for pep8 07:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:04:12 INFO - no previously-included directories found matching 'docs/_build' 07:04:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:04:12 INFO - Cleaning up... 07:04:12 INFO - Return code: 0 07:04:12 INFO - Running post-action listener: _resource_record_post_action 07:04:12 INFO - Running post-action listener: _start_resource_monitoring 07:04:12 INFO - Starting resource monitoring. 07:04:12 INFO - ##### 07:04:12 INFO - ##### Finished create-virtualenv step (success) 07:04:12 INFO - ##### 07:04:12 INFO - ##### 07:04:12 INFO - ##### Running install step. 07:04:12 INFO - ##### 07:04:12 INFO - Running pre-action listener: _resource_record_pre_action 07:04:12 INFO - Running main action method: install 07:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:12 INFO - Reading from file tmpfile_stdout 07:04:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:04:12 INFO - Reading from file tmpfile_stdout 07:04:12 INFO - Output received: 07:04:12 INFO - Usage: mozinstall [options] installer 07:04:12 INFO - Options: 07:04:12 INFO - -h, --help show this help message and exit 07:04:12 INFO - -d DEST, --destination=DEST 07:04:12 INFO - Directory to install application into. [default: 07:04:12 INFO - "/builds/slave/test"] 07:04:12 INFO - --app=APP Application being installed. [default: firefox] 07:04:12 INFO - mkdir: /builds/slave/test/build/application 07:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:04:29 INFO - Reading from file tmpfile_stdout 07:04:29 INFO - Output received: 07:04:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:29 INFO - Running post-action listener: _resource_record_post_action 07:04:29 INFO - ##### 07:04:29 INFO - ##### Finished install step (success) 07:04:29 INFO - ##### 07:04:29 INFO - ##### 07:04:29 INFO - ##### Running run-tests step. 07:04:29 INFO - ##### 07:04:29 INFO - Running pre-action listener: _resource_record_pre_action 07:04:29 INFO - Running main action method: run_tests 07:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:29 INFO - Python 2.7.3 07:04:29 INFO - Return code: 0 07:04:29 INFO - grabbing minidump binary from tooltool 07:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:29 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 0x1f431c0>, '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 0x1f440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:04:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:04:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:04:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:29 INFO - Return code: 0 07:04:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:04:30 INFO - Return code: 0 07:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:04:30 INFO - Using env: {'DISPLAY': ':0', 07:04:30 INFO - 'HOME': '/home/cltbld', 07:04:30 INFO - 'LANG': 'en_US.UTF-8', 07:04:30 INFO - 'LANGUAGE': 'en_US:en', 07:04:30 INFO - 'LOGNAME': 'cltbld', 07:04:30 INFO - 'MAIL': '/var/mail/cltbld', 07:04:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:30 INFO - 'MOZ_NO_REMOTE': '1', 07:04:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:30 INFO - 'NO_EM_RESTART': '1', 07:04:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:30 INFO - 'PWD': '/builds/slave/test', 07:04:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:30 INFO - 'SHELL': '/bin/bash', 07:04:30 INFO - 'SHLVL': '1', 07:04:30 INFO - 'TERM': 'linux', 07:04:30 INFO - 'TMOUT': '86400', 07:04:30 INFO - 'USER': 'cltbld', 07:04:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063', 07:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:30 INFO - '_': '/tools/buildbot/bin/python'} 07:04:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:04:30 INFO - mozversion application_buildid: 20160616043034 07:04:30 INFO - mozversion application_changeset: b9f4f38063951cd5a8b249911aea61869f40fd1f 07:04:30 INFO - mozversion application_display_name: Nightly 07:04:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:30 INFO - mozversion application_name: Firefox 07:04:30 INFO - mozversion application_remotingname: firefox 07:04:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:30 INFO - mozversion application_vendor: Mozilla 07:04:30 INFO - mozversion application_version: 50.0a1 07:04:30 INFO - mozversion platform_buildid: 20160616043034 07:04:30 INFO - mozversion platform_changeset: b9f4f38063951cd5a8b249911aea61869f40fd1f 07:04:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:30 INFO - mozversion platform_version: 50.0a1 07:04:30 INFO - using testdate: 1466085870 07:04:30 INFO - actual date: 1466085870 07:04:30 INFO - starting webserver on 'localhost:36290' 07:04:30 INFO - SUITE-START | Running 2 tests 07:04:30 INFO - TEST-START | dromaeo_css 07:04:30 INFO - operating with platform_type : linux_ 07:04:30 INFO - Initialising browser for dromaeo_css test... 07:04:30 INFO - TEST-INFO | started process 6600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKIJ26/profile http://localhost:36290/getInfo.html) 07:04:35 INFO - PROCESS | 6600 | __metrics Screen width/height:1600/1200 07:04:35 INFO - PROCESS | 6600 | colorDepth:24 07:04:35 INFO - PROCESS | 6600 | Browser inner width/height: 1024/697 07:04:35 INFO - PROCESS | 6600 | __metrics 07:04:35 ERROR - PROCESS | 6600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:04:36 INFO - TEST-INFO | 6600: exit 0 07:04:36 INFO - Browser initialized. 07:04:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:36 INFO - TEST-INFO | started process 6723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKIJ26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:48 INFO - PROCESS | 6723 | RSS: Main: 184922112 07:04:48 INFO - PROCESS | 6723 | 07:05:38 INFO - PROCESS | 6723 | 1466085938403 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:07:45 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36290/tests/dromaeo/cssquery-ext.html) 07:07:47 INFO - PROCESS | 6723 | RSS: Main: 188854272 07:07:47 INFO - PROCESS | 6723 | 07:10:49 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-ext.html (next: http://localhost:36290/tests/dromaeo/cssquery-jquery.html) 07:10:49 INFO - PROCESS | 6723 | RSS: Main: 187101184 07:10:49 INFO - PROCESS | 6723 | 07:13:51 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36290/tests/dromaeo/cssquery-mootools.html) 07:13:52 INFO - PROCESS | 6723 | RSS: Main: 188657664 07:13:52 INFO - PROCESS | 6723 | 07:16:53 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36290/tests/dromaeo/cssquery-prototype.html) 07:16:54 INFO - PROCESS | 6723 | RSS: Main: 186167296 07:16:54 INFO - PROCESS | 6723 | 07:19:56 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36290/tests/dromaeo/cssquery-yui.html) 07:19:57 INFO - PROCESS | 6723 | RSS: Main: 187805696 07:19:57 INFO - PROCESS | 6723 | 07:22:59 INFO - PROCESS | 6723 | Cycle 1(1): loaded http://localhost:36290/tests/dromaeo/cssquery-yui.html (next: http://localhost:36290/tests/dromaeo/cssquery-dojo.html) 07:23:00 INFO - PROCESS | 6723 | RSS: Main: 189640704 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | __start_tp_report 07:23:00 INFO - PROCESS | 6723 | _x_x_mozilla_page_load 07:23:00 INFO - PROCESS | 6723 | _x_x_mozilla_page_load_details 07:23:00 INFO - PROCESS | 6723 | |i|pagename|runs| 07:23:00 INFO - PROCESS | 6723 | |0;dojo.html;3101.2556986323284;3118.79727817692;3150.4014237294914;3152.7793054486197;3156.463401221792;5288.471152884709;5372.838814835556;5421.21392398102;5447.400785913556;5498.395176530588;5358.732063396834;5495.53287970522;5497.862553436166;5513.862153446166;5540.778368865251;4953.851384458463;4979.1784355581285;5081.542661160494;5111.591072714174;5121.155009423441;471.22324260198405;4849.563539281464;4915.434725006634;4969;5037.319961805164;4940.802367905279;4984.8753781155765;5004.899902001957;5011.924821127686;5022.246663000543;5005.799768009275;5023.095842748304;5031.6729412588065;5035.597152227813;5058.342415485963;4966.925496117561;4985.850424487271;5017.247412888096;5019.447860735316;5037.596992240612;5470.64440811346;5485.149801780731;5502.394736578973;5554.1391084381985;5624.71876406178;5759.395263497315;5833.883322333572;5916.911246331309;5946.435088666613;5958.344582095966;5937.7921772737745;5975.820725378246;5995.490383317423;5999.700014999233;6010.57925945184;5572.832815015556;5576.665400076008;5588.497035266845;5598.999999999959;5602.971985140089;5802.4197580241635;5973.133895585116;6017.398260174035;6039.909401358983;6070.392960703983;5662.773489060474;5662.858428539237;5668.234788303526;5683.374828768915;5685.914711279334;5839.299284085937;5840.3575606683235;5841.211436456109;5841.211436456109;5844.707764611752;5762.827115186551;5781.8554536136935;5788.102844059177;5831.067029275296;5891.175235467038;5850.736716847752;5887.087501437284;5915.881682366415;5919.704014799243;5938.465538101505;4401.427814384109;4503.279475284005;4505.031418245093;4508.0533088051225;4545.431821022372;3930.8820735377985;3934.6852251819787;3961.603839616073;4003.3594624859884;4004.3993400989502;5560.082586373284;5603.3836278009385;5632.324121105494;5637.351704554028;5663.575231857627;5885.852853678693;5925.792597259161;5936.317323507766;5947.791827286024;5957.1362152487645;5550.7779688812;5557.888842223133;5595.104783234744;5622.943770562324;5642.633228840113;4999.550040496373;5053.140966035783;5056.191009438546;5057.645964782503;5125.769340379692;5946.762129514857;6007.609505382136;6047.244094488189;6052;6071.666058366833;5873.735681894325;5919.792807251725;5946.048632218824;5958.285005799332;5962.284525856925;6124.265088189446;6126.111713801385;6131.540134489842;6140.324564298013;6143.109249158936;5691.089425691869;5806.9419305806405;5808.244928159313;5837.912431313449;5846.619969701956;5955.583109182316;6011.549133814894;6012.068129439944;6013.458788709037;6053.757849685963;5840.182374467663;5851.034579294369;5851.853703657443;5853.151293062568;5854.531637469077;5569.164625306074;5583.916241256466;5600.915986260128;5633;5804.912926306193;5539.972300138474;5548.916766248591;5564.970480461127;5587.888242235052;5588.6646801192055;5609.831705048855;5681.602287839977;5692.402297758841;5699.7435115419075;5700.942990570207;5578.721063946868;5617.494425501724;5636.661800291996;5643.576731745054;5658.745356458887 07:23:00 INFO - PROCESS | 6723 | |1;ext.html;587.7120211096563;614.0788816774838;632.2539403503864;635.9173307470027;646.8221239159234;40376.192476150456;41055.38416923745;45216;45303;45304.54695453049;45696.77151614246;45727.771361143234;46125.30812037814;46213.30680039802;46660.76669616647;8971.596278167483;9173.128552787475;9185.081491850828;9196.448213107202;9226.26189904806;8904.287656987457;9004;9008.774780630503;9017.684381046665;9043.366964312469;9053.185213330798;9078.228350590207;9104.544772761335;9109.590068446936;9119.179273865351;8968.327375446836;8978.640854365818;9014.323925705532;9047.457152570834;9065.818683626356;9024.593893274818;9029.051949545268;9038.819223615557;9045.095490450967;9129.543522823898;38975.805120974495;39089.21821563581;39143.8042809787;39188;39376.80311598453;3614.1868079682126;3719.7210209234145;3740.6259374062374;3856.5950575189763;4119.217348703766;33276.33447331064;33496;33612;33658.66341336604;33854.49218261728;4324.13517296542;4435.889102772424;4436.423264975565;4471.485779135409;4482.7982740776415;326342;328020.3984701133;330788;331192.34403828066;331660;44711;44954.3256851141;45110.323345149845;45120;46997.76501117541;35876.103097422776;36710.449343259876;36860.262794743954;38562.421563676566;63068;14457;14603.488877889224;14686.118832870063;14743;14770.039947403384;11480.253783504046;11760.764784704257;11832.408379580986;11840.585579504675;11841.940790295994;20172.19311227564;20350;20372.89813550923;20655.586888262453;20656.690149647766;7343.706251749977;7417.703291868264;7505.136909255396;7505.286997735207;7569.583672898044;942.1473566422399;1030.299396410433;1127.179817924742;1139.1114930354338;1158.7798318319492;32677.34645307128;33170;33508.32983340319;33777.49333759995;33925.83037084799;1057.7320511735265;1064.8455973883742;1105.5301496863801;1229.538922903911;1239.0768877186554;17098.487045388658;17634.735478967825;17740.822591774177;17791.55521111957;17816;533240;577657;592060;592562;898423;62106.68946655238;62456.68771656113;62658;62844.371556284765;63376;1354.9119307244998;1376.9655758606116;1379.544750232421;1390.4924702483722;1400.1249219237977;32088.83955580207;34337.88502709685;34344.31311373709;34600.82699586486;34736;53312;53383.73308133434;53707.731461342446;53736.73131634317;53862;491279;491844;492461;492570;494627;29378.853105734335;29409.705902941554;29803;30137.698623014367;30277;49969.75015124901;50204.49795501998;51003.74498127485;51357;51650.48349516457;41905;42155;42287.36568951407;42594.5740542603;43529;41366.58633413627;41907.58092419037;42268.154636907704;42483.57516424796;43611.345829811944;41750.79124604358;42336.364954526325;42386.152276954905;43475.34786978135;43583.34624980691;36228.27543449169;37305.25389492249;37524;38380.42429363618;38858.61141388663;28968.42063158683;29160.854195728887;29446.326671740808;29536.704632954254;29902.401951961274 07:23:00 INFO - PROCESS | 6723 | |2;jquery.html;375.38999126419566;378.12086897962234;382.96026288626393;403.1413090118048;405.0663221274964;17330.74003889943;20016.199352025902;20339.084741186645;20363.99999999998;20481.59036819263;18713.157907894143;18745.15646795894;18806.717899231488;18812.15345309461;19769.209231630753;5698.202251684757;5822;5867.559933005042;5914.970425147868;5929.851753706149;5645.294338207724;5761.769529218826;5780.50865676418;5789.507891829199;5820.796272130477;5716.599838011341;5767.682777447239;5789.942100578983;5864.472197502224;5872.941270587282;5777.797777077803;5823.242978412822;5847.678377689225;5856.765729370842;5876.559258055663;4943.901121977577;5175.974120129413;5218.817341393033;5224.190250511177;5244.318238628992;22731.431714207112;23029.424264393358;23211.767882321128;23235.186768463023;23328.766712333;2440.825450045896;2455.2143314139485;2499.287703004653;2499.5875680512695;3039.0578920534485;14404;14530.418783248762;14667.47435426362;15156;15176.392944282215;1964.7936966618586;2038.6126635939272;2043;2059.2792522617115;2065.473304307407;47345;71394;71681.64159179223;80092.19907800906;81521;10485;10793.67618971432;10913.890861091446;11150.888491114985;11238.606648767254;15111.244437778067;15139.394424222908;15258.313375898111;15267.541973740805;15318.080915144905;7917;7963;8034.477758945767;8188.426810123353;8210.630521626541;7672.539647621161;7710.34462070719;7720.961395192988;7855.332296754726;7867.370610351159;6632.844325594201;6802.761903333359;6851.725930962805;6886.311368863174;6900.447964162855;1898.2691663709572;1950.6781381072249;1967.9828176119306;1973.1416833677397;2050.9692354614695;936.8969413364524;1000.0249756487367;1002.3935519010894;1060.5121644043672;1133.070881876853;19777.505562361057;20676.689849652266;20695.17219311241;20773.376798696063;20789.79210207909;1006.2000709436016;1025.2413214221422;1028.6091285311534;1038.8909164537765;1069.844872493484;10962.890371096346;11523;11545.134114941413;11607.071434285237;11608.43286156375;451667;452273;452514;454122;455249;77162.22837771663;82664;84746.57626711827;85074.5746271277;87274;931.5249222896236;1033.2405681823852;1052.7841792432532;1058.4601853054996;1060.48566445274;18296.26814927388;18374.81625183731;18853.528661783566;18857.71713424327;18869.71695424542;38477.80761096177;38753.2249355017;39540.80229598834;39879.40180897347;40400;51872.221916670525;51952;52045.47954520558;52385.47614523806;53138.734306328224;8372.581370931308;8700.521471319138;8749.245797659385;8892.199702026848;8997.550122493718;7639.579823109782;11641.76716465649;13119;13825.446982120602;14106.365213565208;11540.24988375753;11910.464029118537;12029.21810082377;12103.394830258629;12713.17364371313;11329.71675708114;11751.647450576496;12024.098192635412;12243.32661703615;12444.066694998093;11134.33194008362;11330.433478326215;12318.692032699255;12642.115051946643;12770.361481926053;7676.616169191407;8902.59938302791;9025.458472491671;9167.954160229156;9189.540522973692;11473.483693233658;11614.12894032934;11831.844393319108;11967.64097077089;12314.322712250912 07:23:00 INFO - PROCESS | 6723 | |3;mootools.html;1479.1568805780703;1500.3998400639746;1621.6837716645252;1731.1344327836082;1746.5895514554077;7732.072151341833;8405.117462666423;8417.326613870891;8983.371164018521;9074.455532668037;8486.236238738513;8551.700690475835;8584.48493090415;8610.741677749662;8622.965244170708;2282.863028218308;2325.802306803924;2338.929832105031;2340.555294494049;2340.8127349811975;2209.326155522565;2260.0959616153505;2309.457277539777;2319.257837492003;2323.0939933425975;2267.637178051512;2296.494771150344;2298.8275879309035;2313.1210140146723;2347.3427440316655;2253.7746225377496;2260.2654137405325;2263.309690544383;2266.8526545774553;2277.87471689057;2261.8869056547105;2271.5456908618344;2273.158931195468;2278.7607301233465;2283.1666441748644;8551.230389264934;8692.782680432976;8764.824703505958;8823.514706691129;8826.470411775314;5057.064443078042;5153.6392452528335;5174.43081261061;5178.378594568639;5182.585393168538;3240.238543942172;3337.8831740888954;3540.150363912668;3562.287542491512;3569.1077230692326;1126.1947707389174;1146.4783523496872;1157.8610566731961;1161.7977081802417;1177.4760231696898;11628.592999244986;11704.765904681944;11733.941330293294;11737.765244695143;11762.059035277158;4410.360497727812;4475.172093162775;4516.277395616686;4565.543445655408;4583.060472603109;10038.196944244442;10043;10070.748231294276;10092.545835437422;10136.847947280796;5199.974000130051;5212.452692467312;5219.530242278213;5227.817026404134;5231.267622532849;4204.66362690984;4520.52534483881;4531.546845315508;4674.555917187861;4701.365315682339;3826.8277927492773;3868.3810590305416;3937.645611894886;3942.9211415771524;3944.4083387491532;1240;1241.962741117768;1247.9188852724544;1251.8998480121568;1265.9873401266054;814.1248158229927;879.9824003519893;887.7381172554112;896.1128482801979;906.410832958569;5538.196961440569;5803.593748437569;5854.063349864001;5950.761969521257;5969.462748352669;407.1896925118992;413.834466213511;426.3242760225016;430.2062694328958;439.25765456378616;3939.6651284641125;3942.8817135485983;4004.058031854548;4058.127502586958;4082.6733861291027;10349.172066234683;10731.946340268249;10732.087772539422;10748.301360411548;10766.56933722658;10596.576136954589;10597.099246563974;10601.098906592872;10622.309549879234;10664.733381665365;8039.35685145187;8115.918840811634;8134;8142.877856832152;8143.267105960492;5546.223528705904;5627;5693.519684881878;5734.598578099493;5805.651660900359;9644.469554174588;9791.804163916539;9800.607975680892;9828.213742900407;9897.406155630686;9663.226941844776;9949.353292035994;10004.599816007569;10066;10263.692089237335;7085.362317391459;7385.5937923412575;7634.083909930621;7744.070711514654;7820.452568320163;8193.754187374388;8273.958630206811;8274.544900030556;8288;8360.707375241838;7549.7357592483995;7849.097353804385;7874.173211812677;7876.56678882667;7911.367090632621;7510.549367037996;7749.380049596131;7755.185705500841;7817.413693973089;7873.881891771743;6536.607803531803;6564.9671751642845;6593.340665933369;6615.569987950767;6619.536632435684;5010.248462730474;5015;5072.188449848007;5127.230915362726;5175.482451754794;4994.875128121826;5029.1953287473825;5046.091703493406;5056.949430505648;5064.088464076354 07:23:00 INFO - PROCESS | 6723 | |4;prototype.html;312.14939290433574;317.2386272944932;320.14201938803996;332.55437713463954;337.3691197460749;5520.503154716075;5539.418361072085;5560.471755183251;5612.943870561293;5668.263125793641;5573.693446860431;5596.300462442195;5599.944000559994;5602.719864006804;5620.241267428896;4325.891852703676;4357.387766526382;4359.6948213625055;4366.5633436656235;4371.3661519079715;4053.729911249695;4253.489581250239;4271.9359209611885;4364.519902810688;4375.846845360413;4197.363028418919;4211.22092412903;4225.964638663531;4229.302165142763;4247.6601871850335;4253.957460425387;4260;4268.445102136718;4269.5730426957525;4273.358996150571;3516.929661406783;3741.3265612189794;3741.7006639468777;3743.494628225182;3749.6812770914503;5462.071447853875;5493.505584497374;5502.174673798922;5513.696746678931;5515.696636684981;4881.633877459205;4882.243252295864;4894.975525122387;4901.485344038861;4914.238293064581;5559.8888022239735;5811.941880581225;5819.476247137735;5882.205902203191;5917.467427931507;4060.8984775380554;4086.9591304086875;4091.2635725569385;4093.85671501496;4100.569440208765;5957.6127551709;6055.818325450199;6080.665563394012;6114.357992410777;6141.2671361244265;4106.609872062149;4173.937390939138;4180.874573762792;4194.601512856274;4227.196832601796;4223.472065991751;4234.666080184794;4237.8769626049125;4238.851640192578;4244.660427165819;4874.512548745097;4878.926636140114;4887.902241955141;4898.995705880286;4909.2881532177635;5766.942330576724;5882.617629854046;5930;5961.910571341346;6013.54898382623;1471.1687896338535;1471.9558413247619;1476.2618690654672;1487.9851201487847;1494.7518821783933;921.5530467723149;924.1682485762733;924.3113880159324;935.0322416299098;952.7951490429591;5058.595312375001;5074.898502030012;5112.258722485293;5133.717645529532;5142.76857541404;5303.681779093266;5384.973075134678;5401.541583772359;5458.672479651154;5519.69641669704;5075;5080.898382032413;5093.23601459784;5314.70769107695;5802.158686990363;3234.17528530228;3249.4800831866787;3253.7234335081785;3275.7543184261276;3289.980106167048;6135.141080248769;6152.446279834837;6257.749690012349;6266.592671476339;6313.40022697843;6084.30030546484;6106.6336019838955;6171.783987560414;6181.320054793969;6209.565330426827;6229.408206220402;6236.594621349688;6251.937480625317;6285.8742825143245;6290.295173075621;5816.70916454184;6024.277086749618;6042.8791424170395;6064.181335519648;6082.695865206633;5913.586048976703;5936.287645482397;5976.8804623908145;5984.970075149597;6007.189029481139;5919.91120133207;6214;6219.751209951552;6262;6262.1174871579915;4199.286121359315;4207.926978620432;4217.219814334358;4219.957800422079;4266.381374700713;5976.7908123215475;5983.760649573968;6003.6998150093195;6005.969970150121;6009.218801555945;5692.6299790513485;5854.590178687451;5911.349751527415;5936.732847021981;5948.524118070457;5790.305163380422;5850.23946886902;5851.385604511465;5870.207521984477;5882.117682347682;5472.726363681721;5799.652020878761;5803.419658034331;5814.186013958134;5854.443827836349;5876.44173803488;5882.382349853204;5889.555834328706;5955.255593050869;5985.461308482083;5851;5855.3266374365785;5860.326062502867;5887.1757953887345;5905.498032667271 07:23:00 INFO - PROCESS | 6723 | |5;yui.html;763.7937756805659;792.0455850699907;815.2784785464863;817.84460952419;865.1910463716424;14655.413783448663;14933;15053.92473037636;15256.084634921912;15280.312385942632;14664.266786660652;14998.175100369475;14999.175045372527;15026.474073407433;15043.473478428257;659.2188256915547;780.1418439716323;781.6248200863589;800.9479383840061;806.1938061938062;782.7103971530541;794.8529522038441;795.777182388932;797.027626295918;804.0953926832314;829.1459796409678;829.6473998550622;830.5224495914842;833.0503226321998;835.3317346123108;827.3339961331156;832.5254604875223;834.9332053435741;836.3267569606464;836.9707060252862;607.9544034197453;608.3186830749545;610.1031483718926;610.972506237216;612.5865041097286;14743.11541307525;14847.183404912725;14876.553703388916;14920.477783277533;14920.776188357075;14935.327910243956;15119.319630616648;15165.469208577646;15206.695866082617;15303.46437874669;12359.691007724789;12549.247045177319;12592.559260425933;12621;12783.29691866947;3975.3043217436834;3999.240144372589;4020.1758639478835;4072.1041370898356;4141.730787498833;70616.29383706149;71393.64303178503;73240;73441.89837152393;73554.2644573558;12001;12014.879851201551;12036.338001409831;12191.87808121925;12385.442655080544;19458;22533.549329013655;22540.774592254194;22646;22699.659505107436;8751.912480875237;8878.644854205888;8895.110488951053;9062.093790620886;9258.675946341846;4926.975365123151;4940.925886111711;4946.208606622995;4983.177775667047;5043.5712964398435;3501.072215862798;3593.3711600470338;3600.765950213228;3606.8737594184076;3611.5666120065234;646.5894157210112;648.9415952564292;650.8340373204802;651.2152855808739;659.6767583883862;647.847755777392;745.4371949178336;746.7871656577958;759.2217976573945;771.6681826814523;9749.512524373753;9822.116009559173;9902.60389584423;10036.598536058476;10308.536115874804;689.7551369263939;754.2985023927799;772.5171767645222;784.6547519091581;791.095484533647;4566.931496027562;4838.419389673261;4926.482719314492;4937.901241975141;5071.264666623319;66181.66909165423;66460;80939.59530202429;110171.44914275377;111008.44495777632;95803.52098239464;97265.51367243119;97720.67094967906;97882;98407.99999999857;64217;84647.5767621158;87476.5626171865;87672.56163719269;89565.55217223872;9277.224478447837;9359.906400935903;9413.877388138095;9503.477308748084;9582.90417095848;46958.29562556633;51299.8700129984;51504.48495514997;52193;52360.476395237085;67756.66121669557;75974;75985;77137.61431192808;77962;12158.088143389457;12302.753944920873;12355.814662779885;12380.938095309466;12469.625911222678;13836.515721949683;13973.301334933416;14138.08102473377;14209.289535523389;14317.498887538886;12828.230306181285;13122.475100995853;13170.341482926007;13261.58808537737;13488.5279015234;12691.496488920944;12859.742805144031;13146.40841162169;13147.671308217372;13262;12580.496780129059;12687.936560317139;13690.726185476435;13705.588832335046;14252.358643860844;11585.768284634429;11664.708382290512;11817.940910295394;11825.586104486301;11906.702332441759;11689.240199387013;12015.339156346485;12051.975582075622;12127.514899403925;12176.878231217928 07:23:00 INFO - PROCESS | 6723 | __end_tp_report 07:23:00 INFO - PROCESS | 6723 | __start_cc_report 07:23:00 INFO - PROCESS | 6723 | _x_x_mozilla_cycle_collect,358 07:23:00 INFO - PROCESS | 6723 | __end_cc_report 07:23:00 INFO - PROCESS | 6723 | __startTimestamp1466086980088__endTimestamp 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | ------- Summary: start ------- 07:23:00 INFO - PROCESS | 6723 | Number of tests: 6 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#0] dojo.html Cycles:165 Average:5432.08 Median:5632.32 stddev:739.60 (13.1%) stddev-sans-first:718.91 07:23:00 INFO - PROCESS | 6723 | Values: 3101.3 3118.8 3150.4 3152.8 3156.5 5288.5 5372.8 5421.2 5447.4 5498.4 5358.7 5495.5 5497.9 5513.9 5540.8 4953.9 4979.2 5081.5 5111.6 5121.2 471.2 4849.6 4915.4 4969.0 5037.3 4940.8 4984.9 5004.9 5011.9 5022.2 5005.8 5023.1 5031.7 5035.6 5058.3 4966.9 4985.9 5017.2 5019.4 5037.6 5470.6 5485.1 5502.4 5554.1 5624.7 5759.4 5833.9 5916.9 5946.4 5958.3 5937.8 5975.8 5995.5 5999.7 6010.6 5572.8 5576.7 5588.5 5599.0 5603.0 5802.4 5973.1 6017.4 6039.9 6070.4 5662.8 5662.9 5668.2 5683.4 5685.9 5839.3 5840.4 5841.2 5841.2 5844.7 5762.8 5781.9 5788.1 5831.1 5891.2 5850.7 5887.1 5915.9 5919.7 5938.5 4401.4 4503.3 4505.0 4508.1 4545.4 3930.9 3934.7 3961.6 4003.4 4004.4 5560.1 5603.4 5632.3 5637.4 5663.6 5885.9 5925.8 5936.3 5947.8 5957.1 5550.8 5557.9 5595.1 5622.9 5642.6 4999.6 5053.1 5056.2 5057.6 5125.8 5946.8 6007.6 6047.2 6052.0 6071.7 5873.7 5919.8 5946.0 5958.3 5962.3 6124.3 6126.1 6131.5 6140.3 6143.1 5691.1 5806.9 5808.2 5837.9 5846.6 5955.6 6011.5 6012.1 6013.5 6053.8 5840.2 5851.0 5851.9 5853.2 5854.5 5569.2 5583.9 5600.9 5633.0 5804.9 5540.0 5548.9 5565.0 5587.9 5588.7 5609.8 5681.6 5692.4 5699.7 5700.9 5578.7 5617.5 5636.7 5643.6 5658.7 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#1] ext.html Cycles:180 Average:63873.88 Median:42277.76 stddev:136006.85 (321.7%) stddev-sans-first:136305.38 07:23:00 INFO - PROCESS | 6723 | Values: 587.7 614.1 632.3 635.9 646.8 40376.2 41055.4 45216.0 45303.0 45304.5 45696.8 45727.8 46125.3 46213.3 46660.8 8971.6 9173.1 9185.1 9196.4 9226.3 8904.3 9004.0 9008.8 9017.7 9043.4 9053.2 9078.2 9104.5 9109.6 9119.2 8968.3 8978.6 9014.3 9047.5 9065.8 9024.6 9029.1 9038.8 9045.1 9129.5 38975.8 39089.2 39143.8 39188.0 39376.8 3614.2 3719.7 3740.6 3856.6 4119.2 33276.3 33496.0 33612.0 33658.7 33854.5 4324.1 4435.9 4436.4 4471.5 4482.8 326342.0 328020.4 330788.0 331192.3 331660.0 44711.0 44954.3 45110.3 45120.0 46997.8 35876.1 36710.4 36860.3 38562.4 63068.0 14457.0 14603.5 14686.1 14743.0 14770.0 11480.3 11760.8 11832.4 11840.6 11841.9 20172.2 20350.0 20372.9 20655.6 20656.7 7343.7 7417.7 7505.1 7505.3 7569.6 942.1 1030.3 1127.2 1139.1 1158.8 32677.3 33170.0 33508.3 33777.5 33925.8 1057.7 1064.8 1105.5 1229.5 1239.1 17098.5 17634.7 17740.8 17791.6 17816.0 533240.0 577657.0 592060.0 592562.0 898423.0 62106.7 62456.7 62658.0 62844.4 63376.0 1354.9 1377.0 1379.5 1390.5 1400.1 32088.8 34337.9 34344.3 34600.8 34736.0 53312.0 53383.7 53707.7 53736.7 53862.0 491279.0 491844.0 492461.0 492570.0 494627.0 29378.9 29409.7 29803.0 30137.7 30277.0 49969.8 50204.5 51003.7 51357.0 51650.5 41905.0 42155.0 42287.4 42594.6 43529.0 41366.6 41907.6 42268.2 42483.6 43611.3 41750.8 42336.4 42386.2 43475.3 43583.3 36228.3 37305.3 37524.0 38380.4 38858.6 28968.4 29160.9 29446.3 29536.7 29902.4 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#2] jquery.html Cycles:180 Average:27516.83 Median:23281.98 stddev:74452.76 (319.8%) stddev-sans-first:74633.73 07:23:00 INFO - PROCESS | 6723 | Values: 375.4 378.1 383.0 403.1 405.1 17330.7 20016.2 20339.1 20364.0 20481.6 18713.2 18745.2 18806.7 18812.2 19769.2 5698.2 5822.0 5867.6 5915.0 5929.9 5645.3 5761.8 5780.5 5789.5 5820.8 5716.6 5767.7 5789.9 5864.5 5872.9 5777.8 5823.2 5847.7 5856.8 5876.6 4943.9 5176.0 5218.8 5224.2 5244.3 22731.4 23029.4 23211.8 23235.2 23328.8 2440.8 2455.2 2499.3 2499.6 3039.1 14404.0 14530.4 14667.5 15156.0 15176.4 1964.8 2038.6 2043.0 2059.3 2065.5 47345.0 71394.0 71681.6 80092.2 81521.0 10485.0 10793.7 10913.9 11150.9 11238.6 15111.2 15139.4 15258.3 15267.5 15318.1 7917.0 7963.0 8034.5 8188.4 8210.6 7672.5 7710.3 7721.0 7855.3 7867.4 6632.8 6802.8 6851.7 6886.3 6900.4 1898.3 1950.7 1968.0 1973.1 2051.0 936.9 1000.0 1002.4 1060.5 1133.1 19777.5 20676.7 20695.2 20773.4 20789.8 1006.2 1025.2 1028.6 1038.9 1069.8 10962.9 11523.0 11545.1 11607.1 11608.4 451667.0 452273.0 452514.0 454122.0 455249.0 77162.2 82664.0 84746.6 85074.6 87274.0 931.5 1033.2 1052.8 1058.5 1060.5 18296.3 18374.8 18853.5 18857.7 18869.7 38477.8 38753.2 39540.8 39879.4 40400.0 51872.2 51952.0 52045.5 52385.5 53138.7 8372.6 8700.5 8749.2 8892.2 8997.6 7639.6 11641.8 13119.0 13825.4 14106.4 11540.2 11910.5 12029.2 12103.4 12713.2 11329.7 11751.6 12024.1 12243.3 12444.1 11134.3 11330.4 12318.7 12642.1 12770.4 7676.6 8902.6 9025.5 9168.0 9189.5 11473.5 11614.1 11831.8 11967.6 12314.3 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#3] mootools.html Cycles:180 Average:5664.01 Median:4628.81 stddev:3224.18 (69.7%) stddev-sans-first:3217.89 07:23:00 INFO - PROCESS | 6723 | Values: 1479.2 1500.4 1621.7 1731.1 1746.6 7732.1 8405.1 8417.3 8983.4 9074.5 8486.2 8551.7 8584.5 8610.7 8623.0 2282.9 2325.8 2338.9 2340.6 2340.8 2209.3 2260.1 2309.5 2319.3 2323.1 2267.6 2296.5 2298.8 2313.1 2347.3 2253.8 2260.3 2263.3 2266.9 2277.9 2261.9 2271.5 2273.2 2278.8 2283.2 8551.2 8692.8 8764.8 8823.5 8826.5 5057.1 5153.6 5174.4 5178.4 5182.6 3240.2 3337.9 3540.2 3562.3 3569.1 1126.2 1146.5 1157.9 1161.8 1177.5 11628.6 11704.8 11733.9 11737.8 11762.1 4410.4 4475.2 4516.3 4565.5 4583.1 10038.2 10043.0 10070.7 10092.5 10136.8 5200.0 5212.5 5219.5 5227.8 5231.3 4204.7 4520.5 4531.5 4674.6 4701.4 3826.8 3868.4 3937.6 3942.9 3944.4 1240.0 1242.0 1247.9 1251.9 1266.0 814.1 880.0 887.7 896.1 906.4 5538.2 5803.6 5854.1 5950.8 5969.5 407.2 413.8 426.3 430.2 439.3 3939.7 3942.9 4004.1 4058.1 4082.7 10349.2 10731.9 10732.1 10748.3 10766.6 10596.6 10597.1 10601.1 10622.3 10664.7 8039.4 8115.9 8134.0 8142.9 8143.3 5546.2 5627.0 5693.5 5734.6 5805.7 9644.5 9791.8 9800.6 9828.2 9897.4 9663.2 9949.4 10004.6 10066.0 10263.7 7085.4 7385.6 7634.1 7744.1 7820.5 8193.8 8274.0 8274.5 8288.0 8360.7 7549.7 7849.1 7874.2 7876.6 7911.4 7510.5 7749.4 7755.2 7817.4 7873.9 6536.6 6565.0 6593.3 6615.6 6619.5 5010.2 5015.0 5072.2 5127.2 5175.5 4994.9 5029.2 5046.1 5056.9 5064.1 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#4] prototype.html Cycles:180 Average:4877.44 Median:5529.96 stddev:1458.84 (26.4%) stddev-sans-first:1422.12 07:23:00 INFO - PROCESS | 6723 | Values: 312.1 317.2 320.1 332.6 337.4 5520.5 5539.4 5560.5 5612.9 5668.3 5573.7 5596.3 5599.9 5602.7 5620.2 4325.9 4357.4 4359.7 4366.6 4371.4 4053.7 4253.5 4271.9 4364.5 4375.8 4197.4 4211.2 4226.0 4229.3 4247.7 4254.0 4260.0 4268.4 4269.6 4273.4 3516.9 3741.3 3741.7 3743.5 3749.7 5462.1 5493.5 5502.2 5513.7 5515.7 4881.6 4882.2 4895.0 4901.5 4914.2 5559.9 5811.9 5819.5 5882.2 5917.5 4060.9 4087.0 4091.3 4093.9 4100.6 5957.6 6055.8 6080.7 6114.4 6141.3 4106.6 4173.9 4180.9 4194.6 4227.2 4223.5 4234.7 4237.9 4238.9 4244.7 4874.5 4878.9 4887.9 4899.0 4909.3 5766.9 5882.6 5930.0 5961.9 6013.5 1471.2 1472.0 1476.3 1488.0 1494.8 921.6 924.2 924.3 935.0 952.8 5058.6 5074.9 5112.3 5133.7 5142.8 5303.7 5385.0 5401.5 5458.7 5519.7 5075.0 5080.9 5093.2 5314.7 5802.2 3234.2 3249.5 3253.7 3275.8 3290.0 6135.1 6152.4 6257.7 6266.6 6313.4 6084.3 6106.6 6171.8 6181.3 6209.6 6229.4 6236.6 6251.9 6285.9 6290.3 5816.7 6024.3 6042.9 6064.2 6082.7 5913.6 5936.3 5976.9 5985.0 6007.2 5919.9 6214.0 6219.8 6262.0 6262.1 4199.3 4207.9 4217.2 4220.0 4266.4 5976.8 5983.8 6003.7 6006.0 6009.2 5692.6 5854.6 5911.3 5936.7 5948.5 5790.3 5850.2 5851.4 5870.2 5882.1 5472.7 5799.7 5803.4 5814.2 5854.4 5876.4 5882.4 5889.6 5955.3 5985.5 5851.0 5855.3 5860.3 5887.2 5905.5 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - PROCESS | 6723 | [#5] yui.html Cycles:180 Average:19845.11 Median:4943.57 stddev:27399.52 (554.2%) stddev-sans-first:27438.93 07:23:00 INFO - PROCESS | 6723 | Values: 763.8 792.0 815.3 817.8 865.2 14655.4 14933.0 15053.9 15256.1 15280.3 14664.3 14998.2 14999.2 15026.5 15043.5 659.2 780.1 781.6 800.9 806.2 782.7 794.9 795.8 797.0 804.1 829.1 829.6 830.5 833.1 835.3 827.3 832.5 834.9 836.3 837.0 608.0 608.3 610.1 611.0 612.6 14743.1 14847.2 14876.6 14920.5 14920.8 14935.3 15119.3 15165.5 15206.7 15303.5 12359.7 12549.2 12592.6 12621.0 12783.3 3975.3 3999.2 4020.2 4072.1 4141.7 70616.3 71393.6 73240.0 73441.9 73554.3 12001.0 12014.9 12036.3 12191.9 12385.4 19458.0 22533.5 22540.8 22646.0 22699.7 8751.9 8878.6 8895.1 9062.1 9258.7 4927.0 4940.9 4946.2 4983.2 5043.6 3501.1 3593.4 3600.8 3606.9 3611.6 646.6 648.9 650.8 651.2 659.7 647.8 745.4 746.8 759.2 771.7 9749.5 9822.1 9902.6 10036.6 10308.5 689.8 754.3 772.5 784.7 791.1 4566.9 4838.4 4926.5 4937.9 5071.3 66181.7 66460.0 80939.6 110171.4 111008.4 95803.5 97265.5 97720.7 97882.0 98408.0 64217.0 84647.6 87476.6 87672.6 89565.6 9277.2 9359.9 9413.9 9503.5 9582.9 46958.3 51299.9 51504.5 52193.0 52360.5 67756.7 75974.0 75985.0 77137.6 77962.0 12158.1 12302.8 12355.8 12380.9 12469.6 13836.5 13973.3 14138.1 14209.3 14317.5 12828.2 13122.5 13170.3 13261.6 13488.5 12691.5 12859.7 13146.4 13147.7 13262.0 12580.5 12687.9 13690.7 13705.6 14252.4 11585.8 11664.7 11817.9 11825.6 11906.7 11689.2 12015.3 12052.0 12127.5 12176.9 07:23:00 INFO - PROCESS | 6723 | -------- Summary: end -------- 07:23:00 INFO - PROCESS | 6723 | 07:23:00 INFO - TEST-INFO | 6723: exit 0 07:23:00 INFO - TEST-OK | dromaeo_css | took 1109962ms 07:23:00 INFO - TEST-START | kraken 07:23:00 INFO - operating with platform_type : linux_ 07:23:00 INFO - Initialising browser for kraken test... 07:23:00 INFO - TEST-INFO | started process 6959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_1Hiq/profile http://localhost:36290/getInfo.html) 07:23:05 INFO - PROCESS | 6959 | __metrics Screen width/height:1600/1200 07:23:05 INFO - PROCESS | 6959 | colorDepth:24 07:23:05 INFO - PROCESS | 6959 | Browser inner width/height: 1024/697 07:23:05 INFO - PROCESS | 6959 | __metrics 07:23:05 ERROR - PROCESS | 6959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:23:06 INFO - TEST-INFO | 6959: exit 0 07:23:06 INFO - Browser initialized. 07:23:06 INFO - Running cycle 1/1 for kraken test... 07:23:06 INFO - TEST-INFO | started process 7078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_1Hiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:18 INFO - PROCESS | 7078 | RSS: Main: 185360384 07:23:18 INFO - PROCESS | 7078 | 07:23:21 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36290/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:22 INFO - PROCESS | 7078 | RSS: Main: 191115264 07:23:22 INFO - PROCESS | 7078 | 07:23:24 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36290/tests/kraken/driver.html?testName=audio-dft) 07:23:25 INFO - PROCESS | 7078 | RSS: Main: 190103552 07:23:25 INFO - PROCESS | 7078 | 07:23:28 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36290/tests/kraken/driver.html?testName=audio-fft) 07:23:29 INFO - PROCESS | 7078 | RSS: Main: 185327616 07:23:29 INFO - PROCESS | 7078 | 07:23:31 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36290/tests/kraken/driver.html?testName=audio-oscillator) 07:23:31 INFO - PROCESS | 7078 | RSS: Main: 186269696 07:23:31 INFO - PROCESS | 7078 | 07:23:33 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:34 INFO - PROCESS | 7078 | RSS: Main: 186748928 07:23:34 INFO - PROCESS | 7078 | 07:23:37 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36290/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:38 INFO - PROCESS | 7078 | RSS: Main: 187559936 07:23:38 INFO - PROCESS | 7078 | 07:23:41 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36290/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:42 INFO - PROCESS | 7078 | RSS: Main: 184188928 07:23:42 INFO - PROCESS | 7078 | 07:23:45 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36290/tests/kraken/driver.html?testName=json-parse-financial) 07:23:45 INFO - PROCESS | 7078 | RSS: Main: 185950208 07:23:45 INFO - PROCESS | 7078 | 07:23:47 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:48 INFO - PROCESS | 7078 | RSS: Main: 186437632 07:23:48 INFO - PROCESS | 7078 | 07:23:49 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:23:50 INFO - PROCESS | 7078 | RSS: Main: 186834944 07:23:50 INFO - PROCESS | 7078 | 07:23:52 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:23:53 INFO - PROCESS | 7078 | RSS: Main: 187031552 07:23:53 INFO - PROCESS | 7078 | 07:23:55 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:56 INFO - PROCESS | 7078 | RSS: Main: 186429440 07:23:56 INFO - PROCESS | 7078 | 07:23:59 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:59 INFO - PROCESS | 7078 | RSS: Main: 186486784 07:23:59 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:36290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36290/tests/kraken/driver.html?testName=ai-astar) 07:24:01 INFO - PROCESS | 7078 | RSS: Main: 187838464 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | __start_tp_report 07:24:01 INFO - PROCESS | 7078 | _x_x_mozilla_page_load 07:24:01 INFO - PROCESS | 7078 | _x_x_mozilla_page_load_details 07:24:01 INFO - PROCESS | 7078 | |i|pagename|runs| 07:24:01 INFO - PROCESS | 7078 | |0;ai-astar;110;104;111;109;111;111;109;109;111;114 07:24:01 INFO - PROCESS | 7078 | |1;audio-beat-detection;158;125;156;187;128;160;154;126;189;125 07:24:01 INFO - PROCESS | 7078 | |2;audio-dft;165;165;161;163;168;170;167;163;162;161 07:24:01 INFO - PROCESS | 7078 | |3;audio-fft;75;74;73;160;76;75;75;76;160;75 07:24:01 INFO - PROCESS | 7078 | |4;audio-oscillator;85;86;149;86;85;86;140;86;85;154 07:24:01 INFO - PROCESS | 7078 | |5;imaging-gaussian-blur;118;118;118;117;116;117;117;117;117;118 07:24:01 INFO - PROCESS | 7078 | |6;imaging-darkroom;148;148;147;146;147;149;148;148;149;146 07:24:01 INFO - PROCESS | 7078 | |7;imaging-desaturate;96;96;95;95;96;95;95;96;97;96 07:24:01 INFO - PROCESS | 7078 | |8;json-parse-financial;58;60;57;57;58;57;59;59;58;58 07:24:01 INFO - PROCESS | 7078 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;62;61;62 07:24:01 INFO - PROCESS | 7078 | |10;stanford-crypto-aes;82;80;80;81;80;80;80;81;106;80 07:24:01 INFO - PROCESS | 7078 | |11;stanford-crypto-ccm;128;122;124;141;129;132;130;133;135;138 07:24:01 INFO - PROCESS | 7078 | |12;stanford-crypto-pbkdf2;161;162;162;159;159;158;163;163;162;158 07:24:01 INFO - PROCESS | 7078 | |13;stanford-crypto-sha256-iterative;64;67;65;65;64;65;63;65;70;61 07:24:01 INFO - PROCESS | 7078 | __end_tp_report 07:24:01 INFO - PROCESS | 7078 | __start_cc_report 07:24:01 INFO - PROCESS | 7078 | _x_x_mozilla_cycle_collect,920 07:24:01 INFO - PROCESS | 7078 | __end_cc_report 07:24:01 INFO - PROCESS | 7078 | __startTimestamp1466087041755__endTimestamp 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | ------- Summary: start ------- 07:24:01 INFO - PROCESS | 7078 | Number of tests: 14 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.56 (2.3%) stddev-sans-first:2.71 07:24:01 INFO - PROCESS | 7078 | Values: 110.0 104.0 111.0 109.0 111.0 111.0 109.0 109.0 111.0 114.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:157.00 stddev:24.52 (15.6%) stddev-sans-first:25.87 07:24:01 INFO - PROCESS | 7078 | Values: 158.0 125.0 156.0 187.0 128.0 160.0 154.0 126.0 189.0 125.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 07:24:01 INFO - PROCESS | 7078 | Values: 165.0 165.0 161.0 163.0 168.0 170.0 167.0 163.0 162.0 161.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:35.90 (47.9%) stddev-sans-first:37.56 07:24:01 INFO - PROCESS | 7078 | Values: 75.0 74.0 73.0 160.0 76.0 75.0 75.0 76.0 160.0 75.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:85.50 stddev:30.18 (35.3%) stddev-sans-first:31.20 07:24:01 INFO - PROCESS | 7078 | Values: 85.0 86.0 149.0 86.0 85.0 86.0 140.0 86.0 85.0 154.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:24:01 INFO - PROCESS | 7078 | Values: 118.0 118.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 07:24:01 INFO - PROCESS | 7078 | Values: 148.0 148.0 147.0 146.0 147.0 149.0 148.0 148.0 149.0 146.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:24:01 INFO - PROCESS | 7078 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 97.0 96.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 07:24:01 INFO - PROCESS | 7078 | Values: 58.0 60.0 57.0 57.0 58.0 57.0 59.0 59.0 58.0 58.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:24:01 INFO - PROCESS | 7078 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:8.11 (10.1%) stddev-sans-first:8.59 07:24:01 INFO - PROCESS | 7078 | Values: 82.0 80.0 80.0 81.0 80.0 80.0 80.0 81.0 106.0 80.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.50 stddev:5.90 (4.5%) stddev-sans-first:6.15 07:24:01 INFO - PROCESS | 7078 | Values: 128.0 122.0 124.0 141.0 129.0 132.0 130.0 133.0 135.0 138.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:162.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 07:24:01 INFO - PROCESS | 7078 | Values: 161.0 162.0 162.0 159.0 159.0 158.0 163.0 163.0 162.0 158.0 07:24:01 INFO - PROCESS | 7078 | 07:24:01 INFO - PROCESS | 7078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.38 (3.7%) stddev-sans-first:2.50 07:24:01 INFO - PROCESS | 7078 | Values: 64.0 67.0 65.0 65.0 64.0 65.0 63.0 65.0 70.0 61.0 07:24:01 INFO - PROCESS | 7078 | -------- Summary: end -------- 07:24:01 INFO - PROCESS | 7078 | 07:24:02 INFO - TEST-INFO | 7078: exit 0 07:24:02 INFO - TEST-OK | kraken | took 61939ms 07:24:02 INFO - SUITE-END | took 1171s 07:24:02 INFO - Completed test suite (00:19:32) 07:24:02 INFO - javascript benchmark 07:24:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7311.566597041637, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.2556986323284, 3118.79727817692, 3150.4014237294914, 3152.7793054486197, 3156.463401221792, 5288.471152884709, 5372.838814835556, 5421.21392398102, 5447.400785913556, 5498.395176530588, 5358.732063396834, 5495.53287970522, 5497.862553436166, 5513.862153446166, 5540.778368865251, 4953.851384458463, 4979.1784355581285, 5081.542661160494, 5111.591072714174, 5121.155009423441, 471.22324260198405, 4849.563539281464, 4915.434725006634, 4969.0, 5037.319961805164, 4940.802367905279, 4984.8753781155765, 5004.899902001957, 5011.924821127686, 5022.246663000543, 5005.799768009275, 5023.095842748304, 5031.6729412588065, 5035.597152227813, 5058.342415485963, 4966.925496117561, 4985.850424487271, 5017.247412888096, 5019.447860735316, 5037.596992240612, 5470.64440811346, 5485.149801780731, 5502.394736578973, 5554.1391084381985, 5624.71876406178, 5759.395263497315, 5833.883322333572, 5916.911246331309, 5946.435088666613, 5958.344582095966, 5937.7921772737745, 5975.820725378246, 5995.490383317423, 5999.700014999233, 6010.57925945184, 5572.832815015556, 5576.665400076008, 5588.497035266845, 5598.999999999959, 5602.971985140089, 5802.4197580241635, 5973.133895585116, 6017.398260174035, 6039.909401358983, 6070.392960703983, 5662.773489060474, 5662.858428539237, 5668.234788303526, 5683.374828768915, 5685.914711279334, 5839.299284085937, 5840.3575606683235, 5841.211436456109, 5841.211436456109, 5844.707764611752, 5762.827115186551, 5781.8554536136935, 5788.102844059177, 5831.067029275296, 5891.175235467038, 5850.736716847752, 5887.087501437284, 5915.881682366415, 5919.704014799243, 5938.465538101505, 4401.427814384109, 4503.279475284005, 4505.031418245093, 4508.0533088051225, 4545.431821022372, 3930.8820735377985, 3934.6852251819787, 3961.603839616073, 4003.3594624859884, 4004.3993400989502, 5560.082586373284, 5603.3836278009385, 5632.324121105494, 5637.351704554028, 5663.575231857627, 5885.852853678693, 5925.792597259161, 5936.317323507766, 5947.791827286024, 5957.1362152487645, 5550.7779688812, 5557.888842223133, 5595.104783234744, 5622.943770562324, 5642.633228840113, 4999.550040496373, 5053.140966035783, 5056.191009438546, 5057.645964782503, 5125.769340379692, 5946.762129514857, 6007.609505382136, 6047.244094488189, 6052.0, 6071.666058366833, 5873.735681894325, 5919.792807251725, 5946.048632218824, 5958.285005799332, 5962.284525856925, 6124.265088189446, 6126.111713801385, 6131.540134489842, 6140.324564298013, 6143.109249158936, 5691.089425691869, 5806.9419305806405, 5808.244928159313, 5837.912431313449, 5846.619969701956, 5955.583109182316, 6011.549133814894, 6012.068129439944, 6013.458788709037, 6053.757849685963, 5840.182374467663, 5851.034579294369, 5851.853703657443, 5853.151293062568, 5854.531637469077, 5569.164625306074, 5583.916241256466, 5600.915986260128, 5633.0, 5804.912926306193, 5539.972300138474, 5548.916766248591, 5564.970480461127, 5587.888242235052, 5588.6646801192055, 5609.831705048855, 5681.602287839977, 5692.402297758841, 5699.7435115419075, 5700.942990570207, 5578.721063946868, 5617.494425501724, 5636.661800291996, 5643.576731745054, 5658.745356458887], "value": 5382.883818255526, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7120211096563, 614.0788816774838, 632.2539403503864, 635.9173307470027, 646.8221239159234, 40376.192476150456, 41055.38416923745, 45216.0, 45303.0, 45304.54695453049, 45696.77151614246, 45727.771361143234, 46125.30812037814, 46213.30680039802, 46660.76669616647, 8971.596278167483, 9173.128552787475, 9185.081491850828, 9196.448213107202, 9226.26189904806, 8904.287656987457, 9004.0, 9008.774780630503, 9017.684381046665, 9043.366964312469, 9053.185213330798, 9078.228350590207, 9104.544772761335, 9109.590068446936, 9119.179273865351, 8968.327375446836, 8978.640854365818, 9014.323925705532, 9047.457152570834, 9065.818683626356, 9024.593893274818, 9029.051949545268, 9038.819223615557, 9045.095490450967, 9129.543522823898, 38975.805120974495, 39089.21821563581, 39143.8042809787, 39188.0, 39376.80311598453, 3614.1868079682126, 3719.7210209234145, 3740.6259374062374, 3856.5950575189763, 4119.217348703766, 33276.33447331064, 33496.0, 33612.0, 33658.66341336604, 33854.49218261728, 4324.13517296542, 4435.889102772424, 4436.423264975565, 4471.485779135409, 4482.7982740776415, 326342.0, 328020.3984701133, 330788.0, 331192.34403828066, 331660.0, 44711.0, 44954.3256851141, 45110.323345149845, 45120.0, 46997.76501117541, 35876.103097422776, 36710.449343259876, 36860.262794743954, 38562.421563676566, 63068.0, 14457.0, 14603.488877889224, 14686.118832870063, 14743.0, 14770.039947403384, 11480.253783504046, 11760.764784704257, 11832.408379580986, 11840.585579504675, 11841.940790295994, 20172.19311227564, 20350.0, 20372.89813550923, 20655.586888262453, 20656.690149647766, 7343.706251749977, 7417.703291868264, 7505.136909255396, 7505.286997735207, 7569.583672898044, 942.1473566422399, 1030.299396410433, 1127.179817924742, 1139.1114930354338, 1158.7798318319492, 32677.34645307128, 33170.0, 33508.32983340319, 33777.49333759995, 33925.83037084799, 1057.7320511735265, 1064.8455973883742, 1105.5301496863801, 1229.538922903911, 1239.0768877186554, 17098.487045388658, 17634.735478967825, 17740.822591774177, 17791.55521111957, 17816.0, 533240.0, 577657.0, 592060.0, 592562.0, 898423.0, 62106.68946655238, 62456.68771656113, 62658.0, 62844.371556284765, 63376.0, 1354.9119307244998, 1376.9655758606116, 1379.544750232421, 1390.4924702483722, 1400.1249219237977, 32088.83955580207, 34337.88502709685, 34344.31311373709, 34600.82699586486, 34736.0, 53312.0, 53383.73308133434, 53707.731461342446, 53736.73131634317, 53862.0, 491279.0, 491844.0, 492461.0, 492570.0, 494627.0, 29378.853105734335, 29409.705902941554, 29803.0, 30137.698623014367, 30277.0, 49969.75015124901, 50204.49795501998, 51003.74498127485, 51357.0, 51650.48349516457, 41905.0, 42155.0, 42287.36568951407, 42594.5740542603, 43529.0, 41366.58633413627, 41907.58092419037, 42268.154636907704, 42483.57516424796, 43611.345829811944, 41750.79124604358, 42336.364954526325, 42386.152276954905, 43475.34786978135, 43583.34624980691, 36228.27543449169, 37305.25389492249, 37524.0, 38380.42429363618, 38858.61141388663, 28968.42063158683, 29160.854195728887, 29446.326671740808, 29536.704632954254, 29902.401951961274], "value": 20360.080882648013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.38999126419566, 378.12086897962234, 382.96026288626393, 403.1413090118048, 405.0663221274964, 17330.74003889943, 20016.199352025902, 20339.084741186645, 20363.99999999998, 20481.59036819263, 18713.157907894143, 18745.15646795894, 18806.717899231488, 18812.15345309461, 19769.209231630753, 5698.202251684757, 5822.0, 5867.559933005042, 5914.970425147868, 5929.851753706149, 5645.294338207724, 5761.769529218826, 5780.50865676418, 5789.507891829199, 5820.796272130477, 5716.599838011341, 5767.682777447239, 5789.942100578983, 5864.472197502224, 5872.941270587282, 5777.797777077803, 5823.242978412822, 5847.678377689225, 5856.765729370842, 5876.559258055663, 4943.901121977577, 5175.974120129413, 5218.817341393033, 5224.190250511177, 5244.318238628992, 22731.431714207112, 23029.424264393358, 23211.767882321128, 23235.186768463023, 23328.766712333, 2440.825450045896, 2455.2143314139485, 2499.287703004653, 2499.5875680512695, 3039.0578920534485, 14404.0, 14530.418783248762, 14667.47435426362, 15156.0, 15176.392944282215, 1964.7936966618586, 2038.6126635939272, 2043.0, 2059.2792522617115, 2065.473304307407, 47345.0, 71394.0, 71681.64159179223, 80092.19907800906, 81521.0, 10485.0, 10793.67618971432, 10913.890861091446, 11150.888491114985, 11238.606648767254, 15111.244437778067, 15139.394424222908, 15258.313375898111, 15267.541973740805, 15318.080915144905, 7917.0, 7963.0, 8034.477758945767, 8188.426810123353, 8210.630521626541, 7672.539647621161, 7710.34462070719, 7720.961395192988, 7855.332296754726, 7867.370610351159, 6632.844325594201, 6802.761903333359, 6851.725930962805, 6886.311368863174, 6900.447964162855, 1898.2691663709572, 1950.6781381072249, 1967.9828176119306, 1973.1416833677397, 2050.9692354614695, 936.8969413364524, 1000.0249756487367, 1002.3935519010894, 1060.5121644043672, 1133.070881876853, 19777.505562361057, 20676.689849652266, 20695.17219311241, 20773.376798696063, 20789.79210207909, 1006.2000709436016, 1025.2413214221422, 1028.6091285311534, 1038.8909164537765, 1069.844872493484, 10962.890371096346, 11523.0, 11545.134114941413, 11607.071434285237, 11608.43286156375, 451667.0, 452273.0, 452514.0, 454122.0, 455249.0, 77162.22837771663, 82664.0, 84746.57626711827, 85074.5746271277, 87274.0, 931.5249222896236, 1033.2405681823852, 1052.7841792432532, 1058.4601853054996, 1060.48566445274, 18296.26814927388, 18374.81625183731, 18853.528661783566, 18857.71713424327, 18869.71695424542, 38477.80761096177, 38753.2249355017, 39540.80229598834, 39879.40180897347, 40400.0, 51872.221916670525, 51952.0, 52045.47954520558, 52385.47614523806, 53138.734306328224, 8372.581370931308, 8700.521471319138, 8749.245797659385, 8892.199702026848, 8997.550122493718, 7639.579823109782, 11641.76716465649, 13119.0, 13825.446982120602, 14106.365213565208, 11540.24988375753, 11910.464029118537, 12029.21810082377, 12103.394830258629, 12713.17364371313, 11329.71675708114, 11751.647450576496, 12024.098192635412, 12243.32661703615, 12444.066694998093, 11134.33194008362, 11330.433478326215, 12318.692032699255, 12642.115051946643, 12770.361481926053, 7676.616169191407, 8902.59938302791, 9025.458472491671, 9167.954160229156, 9189.540522973692, 11473.483693233658, 11614.12894032934, 11831.844393319108, 11967.64097077089, 12314.322712250912], "value": 9400.231358780882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.1568805780703, 1500.3998400639746, 1621.6837716645252, 1731.1344327836082, 1746.5895514554077, 7732.072151341833, 8405.117462666423, 8417.326613870891, 8983.371164018521, 9074.455532668037, 8486.236238738513, 8551.700690475835, 8584.48493090415, 8610.741677749662, 8622.965244170708, 2282.863028218308, 2325.802306803924, 2338.929832105031, 2340.555294494049, 2340.8127349811975, 2209.326155522565, 2260.0959616153505, 2309.457277539777, 2319.257837492003, 2323.0939933425975, 2267.637178051512, 2296.494771150344, 2298.8275879309035, 2313.1210140146723, 2347.3427440316655, 2253.7746225377496, 2260.2654137405325, 2263.309690544383, 2266.8526545774553, 2277.87471689057, 2261.8869056547105, 2271.5456908618344, 2273.158931195468, 2278.7607301233465, 2283.1666441748644, 8551.230389264934, 8692.782680432976, 8764.824703505958, 8823.514706691129, 8826.470411775314, 5057.064443078042, 5153.6392452528335, 5174.43081261061, 5178.378594568639, 5182.585393168538, 3240.238543942172, 3337.8831740888954, 3540.150363912668, 3562.287542491512, 3569.1077230692326, 1126.1947707389174, 1146.4783523496872, 1157.8610566731961, 1161.7977081802417, 1177.4760231696898, 11628.592999244986, 11704.765904681944, 11733.941330293294, 11737.765244695143, 11762.059035277158, 4410.360497727812, 4475.172093162775, 4516.277395616686, 4565.543445655408, 4583.060472603109, 10038.196944244442, 10043.0, 10070.748231294276, 10092.545835437422, 10136.847947280796, 5199.974000130051, 5212.452692467312, 5219.530242278213, 5227.817026404134, 5231.267622532849, 4204.66362690984, 4520.52534483881, 4531.546845315508, 4674.555917187861, 4701.365315682339, 3826.8277927492773, 3868.3810590305416, 3937.645611894886, 3942.9211415771524, 3944.4083387491532, 1240.0, 1241.962741117768, 1247.9188852724544, 1251.8998480121568, 1265.9873401266054, 814.1248158229927, 879.9824003519893, 887.7381172554112, 896.1128482801979, 906.410832958569, 5538.196961440569, 5803.593748437569, 5854.063349864001, 5950.761969521257, 5969.462748352669, 407.1896925118992, 413.834466213511, 426.3242760225016, 430.2062694328958, 439.25765456378616, 3939.6651284641125, 3942.8817135485983, 4004.058031854548, 4058.127502586958, 4082.6733861291027, 10349.172066234683, 10731.946340268249, 10732.087772539422, 10748.301360411548, 10766.56933722658, 10596.576136954589, 10597.099246563974, 10601.098906592872, 10622.309549879234, 10664.733381665365, 8039.35685145187, 8115.918840811634, 8134.0, 8142.877856832152, 8143.267105960492, 5546.223528705904, 5627.0, 5693.519684881878, 5734.598578099493, 5805.651660900359, 9644.469554174588, 9791.804163916539, 9800.607975680892, 9828.213742900407, 9897.406155630686, 9663.226941844776, 9949.353292035994, 10004.599816007569, 10066.0, 10263.692089237335, 7085.362317391459, 7385.5937923412575, 7634.083909930621, 7744.070711514654, 7820.452568320163, 8193.754187374388, 8273.958630206811, 8274.544900030556, 8288.0, 8360.707375241838, 7549.7357592483995, 7849.097353804385, 7874.173211812677, 7876.56678882667, 7911.367090632621, 7510.549367037996, 7749.380049596131, 7755.185705500841, 7817.413693973089, 7873.881891771743, 6536.607803531803, 6564.9671751642845, 6593.340665933369, 6615.569987950767, 6619.536632435684, 5010.248462730474, 5015.0, 5072.188449848007, 5127.230915362726, 5175.482451754794, 4994.875128121826, 5029.1953287473825, 5046.091703493406, 5056.949430505648, 5064.088464076354], "value": 4456.225720934557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.14939290433574, 317.2386272944932, 320.14201938803996, 332.55437713463954, 337.3691197460749, 5520.503154716075, 5539.418361072085, 5560.471755183251, 5612.943870561293, 5668.263125793641, 5573.693446860431, 5596.300462442195, 5599.944000559994, 5602.719864006804, 5620.241267428896, 4325.891852703676, 4357.387766526382, 4359.6948213625055, 4366.5633436656235, 4371.3661519079715, 4053.729911249695, 4253.489581250239, 4271.9359209611885, 4364.519902810688, 4375.846845360413, 4197.363028418919, 4211.22092412903, 4225.964638663531, 4229.302165142763, 4247.6601871850335, 4253.957460425387, 4260.0, 4268.445102136718, 4269.5730426957525, 4273.358996150571, 3516.929661406783, 3741.3265612189794, 3741.7006639468777, 3743.494628225182, 3749.6812770914503, 5462.071447853875, 5493.505584497374, 5502.174673798922, 5513.696746678931, 5515.696636684981, 4881.633877459205, 4882.243252295864, 4894.975525122387, 4901.485344038861, 4914.238293064581, 5559.8888022239735, 5811.941880581225, 5819.476247137735, 5882.205902203191, 5917.467427931507, 4060.8984775380554, 4086.9591304086875, 4091.2635725569385, 4093.85671501496, 4100.569440208765, 5957.6127551709, 6055.818325450199, 6080.665563394012, 6114.357992410777, 6141.2671361244265, 4106.609872062149, 4173.937390939138, 4180.874573762792, 4194.601512856274, 4227.196832601796, 4223.472065991751, 4234.666080184794, 4237.8769626049125, 4238.851640192578, 4244.660427165819, 4874.512548745097, 4878.926636140114, 4887.902241955141, 4898.995705880286, 4909.2881532177635, 5766.942330576724, 5882.617629854046, 5930.0, 5961.910571341346, 6013.54898382623, 1471.1687896338535, 1471.9558413247619, 1476.2618690654672, 1487.9851201487847, 1494.7518821783933, 921.5530467723149, 924.1682485762733, 924.3113880159324, 935.0322416299098, 952.7951490429591, 5058.595312375001, 5074.898502030012, 5112.258722485293, 5133.717645529532, 5142.76857541404, 5303.681779093266, 5384.973075134678, 5401.541583772359, 5458.672479651154, 5519.69641669704, 5075.0, 5080.898382032413, 5093.23601459784, 5314.70769107695, 5802.158686990363, 3234.17528530228, 3249.4800831866787, 3253.7234335081785, 3275.7543184261276, 3289.980106167048, 6135.141080248769, 6152.446279834837, 6257.749690012349, 6266.592671476339, 6313.40022697843, 6084.30030546484, 6106.6336019838955, 6171.783987560414, 6181.320054793969, 6209.565330426827, 6229.408206220402, 6236.594621349688, 6251.937480625317, 6285.8742825143245, 6290.295173075621, 5816.70916454184, 6024.277086749618, 6042.8791424170395, 6064.181335519648, 6082.695865206633, 5913.586048976703, 5936.287645482397, 5976.8804623908145, 5984.970075149597, 6007.189029481139, 5919.91120133207, 6214.0, 6219.751209951552, 6262.0, 6262.1174871579915, 4199.286121359315, 4207.926978620432, 4217.219814334358, 4219.957800422079, 4266.381374700713, 5976.7908123215475, 5983.760649573968, 6003.6998150093195, 6005.969970150121, 6009.218801555945, 5692.6299790513485, 5854.590178687451, 5911.349751527415, 5936.732847021981, 5948.524118070457, 5790.305163380422, 5850.23946886902, 5851.385604511465, 5870.207521984477, 5882.117682347682, 5472.726363681721, 5799.652020878761, 5803.419658034331, 5814.186013958134, 5854.443827836349, 5876.44173803488, 5882.382349853204, 5889.555834328706, 5955.255593050869, 5985.461308482083, 5851.0, 5855.3266374365785, 5860.326062502867, 5887.1757953887345, 5905.498032667271], "value": 4403.21904473403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.7937756805659, 792.0455850699907, 815.2784785464863, 817.84460952419, 865.1910463716424, 14655.413783448663, 14933.0, 15053.92473037636, 15256.084634921912, 15280.312385942632, 14664.266786660652, 14998.175100369475, 14999.175045372527, 15026.474073407433, 15043.473478428257, 659.2188256915547, 780.1418439716323, 781.6248200863589, 800.9479383840061, 806.1938061938062, 782.7103971530541, 794.8529522038441, 795.777182388932, 797.027626295918, 804.0953926832314, 829.1459796409678, 829.6473998550622, 830.5224495914842, 833.0503226321998, 835.3317346123108, 827.3339961331156, 832.5254604875223, 834.9332053435741, 836.3267569606464, 836.9707060252862, 607.9544034197453, 608.3186830749545, 610.1031483718926, 610.972506237216, 612.5865041097286, 14743.11541307525, 14847.183404912725, 14876.553703388916, 14920.477783277533, 14920.776188357075, 14935.327910243956, 15119.319630616648, 15165.469208577646, 15206.695866082617, 15303.46437874669, 12359.691007724789, 12549.247045177319, 12592.559260425933, 12621.0, 12783.29691866947, 3975.3043217436834, 3999.240144372589, 4020.1758639478835, 4072.1041370898356, 4141.730787498833, 70616.29383706149, 71393.64303178503, 73240.0, 73441.89837152393, 73554.2644573558, 12001.0, 12014.879851201551, 12036.338001409831, 12191.87808121925, 12385.442655080544, 19458.0, 22533.549329013655, 22540.774592254194, 22646.0, 22699.659505107436, 8751.912480875237, 8878.644854205888, 8895.110488951053, 9062.093790620886, 9258.675946341846, 4926.975365123151, 4940.925886111711, 4946.208606622995, 4983.177775667047, 5043.5712964398435, 3501.072215862798, 3593.3711600470338, 3600.765950213228, 3606.8737594184076, 3611.5666120065234, 646.5894157210112, 648.9415952564292, 650.8340373204802, 651.2152855808739, 659.6767583883862, 647.847755777392, 745.4371949178336, 746.7871656577958, 759.2217976573945, 771.6681826814523, 9749.512524373753, 9822.116009559173, 9902.60389584423, 10036.598536058476, 10308.536115874804, 689.7551369263939, 754.2985023927799, 772.5171767645222, 784.6547519091581, 791.095484533647, 4566.931496027562, 4838.419389673261, 4926.482719314492, 4937.901241975141, 5071.264666623319, 66181.66909165423, 66460.0, 80939.59530202429, 110171.44914275377, 111008.44495777632, 95803.52098239464, 97265.51367243119, 97720.67094967906, 97882.0, 98407.99999999857, 64217.0, 84647.5767621158, 87476.5626171865, 87672.56163719269, 89565.55217223872, 9277.224478447837, 9359.906400935903, 9413.877388138095, 9503.477308748084, 9582.90417095848, 46958.29562556633, 51299.8700129984, 51504.48495514997, 52193.0, 52360.476395237085, 67756.66121669557, 75974.0, 75985.0, 77137.61431192808, 77962.0, 12158.088143389457, 12302.753944920873, 12355.814662779885, 12380.938095309466, 12469.625911222678, 13836.515721949683, 13973.301334933416, 14138.08102473377, 14209.289535523389, 14317.498887538886, 12828.230306181285, 13122.475100995853, 13170.341482926007, 13261.58808537737, 13488.5279015234, 12691.496488920944, 12859.742805144031, 13146.40841162169, 13147.671308217372, 13262.0, 12580.496780129059, 12687.936560317139, 13690.726185476435, 13705.588832335046, 14252.358643860844, 11585.768284634429, 11664.708382290512, 11817.940910295394, 11825.586104486301, 11906.702332441759, 11689.240199387013, 12015.339156346485, 12051.975582075622, 12127.514899403925, 12176.878231217928], "value": 7556.953545777102, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 109.0, 111.0, 111.0, 109.0, 109.0, 111.0, 114.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 156.0, 187.0, 128.0, 160.0, 154.0, 126.0, 189.0, 125.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 163.0, 168.0, 170.0, 167.0, 163.0, 162.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 160.0, 76.0, 75.0, 75.0, 76.0, 160.0, 75.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 149.0, 86.0, 85.0, 86.0, 140.0, 86.0, 85.0, 154.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 147.0, 149.0, 148.0, 148.0, 149.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 57.0, 57.0, 58.0, 57.0, 59.0, 59.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0, 81.0, 106.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 124.0, 141.0, 129.0, 132.0, 130.0, 133.0, 135.0, 138.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 159.0, 159.0, 158.0, 163.0, 163.0, 162.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 65.0, 64.0, 65.0, 63.0, 65.0, 70.0, 61.0], "value": 64.9, "unit": "score"}]}]} 07:24:03 INFO - Return code: 0 07:24:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:03 ERROR - # TBPL SUCCESS # 07:24:03 INFO - Running post-action listener: _resource_record_post_action 07:24:03 INFO - ##### 07:24:03 INFO - ##### Finished run-tests step (success) 07:24:03 INFO - ##### 07:24:03 INFO - Running post-run listener: _resource_record_post_run 07:24:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549453824; Read time: 4; Write time: 418264 07:24:03 INFO - TinderboxPrint: CPU usage
13.4% 07:24:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 07:24:03 INFO - TinderboxPrint: I/O write bytes / time
549,453,824 / 418,264 07:24:03 INFO - TinderboxPrint: CPU idle
8,216.1 (86.6%) 07:24:03 INFO - TinderboxPrint: CPU user
1,219.5 (12.8%) 07:24:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255492096; Read time: 0; Write time: 219236 07:24:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293961728; Read time: 4; Write time: 199028 07:24:03 INFO - Running post-run listener: _upload_blobber_files 07:24:03 INFO - Blob upload gear active. 07:24:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:24:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:04 INFO - (blobuploader) - INFO - Done attempting. 07:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:08 INFO - (blobuploader) - INFO - Done attempting. 07:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:09 INFO - (blobuploader) - INFO - Done attempting. 07:24:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:09 INFO - Return code: 0 07:24:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bf0972b501d3698244787329058d6536dbf75d6eb252cbb48c86066cdaa1d6e649123c43265682e2cd2dbb27eee33193860a4ff86e2e5f270e94bad7f104fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879516033dfdee57762eaf3ab96a12f96842a917e3852f57b1e72608f398f896564a2b27061a401c44d307a8ab93ea4a2212f7c56a3b38e159dc6d89c16101d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5837fea8df0fbd1a5c196225f6c166f343f638fc4cf742b9a21f39e2b2eb8887a23a6cf2ad86052648a308d4ef6d526d3e5894cad2fe2428e31230588c51f60e"} 07:24:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:09 INFO - Contents: 07:24:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bf0972b501d3698244787329058d6536dbf75d6eb252cbb48c86066cdaa1d6e649123c43265682e2cd2dbb27eee33193860a4ff86e2e5f270e94bad7f104fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879516033dfdee57762eaf3ab96a12f96842a917e3852f57b1e72608f398f896564a2b27061a401c44d307a8ab93ea4a2212f7c56a3b38e159dc6d89c16101d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5837fea8df0fbd1a5c196225f6c166f343f638fc4cf742b9a21f39e2b2eb8887a23a6cf2ad86052648a308d4ef6d526d3e5894cad2fe2428e31230588c51f60e"} 07:24:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:09 INFO - Copying logs to upload dir... 07:24:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.967969 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 07:24:09.416742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 07:24:09.420913) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 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/sha512/43bf0972b501d3698244787329058d6536dbf75d6eb252cbb48c86066cdaa1d6e649123c43265682e2cd2dbb27eee33193860a4ff86e2e5f270e94bad7f104fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879516033dfdee57762eaf3ab96a12f96842a917e3852f57b1e72608f398f896564a2b27061a401c44d307a8ab93ea4a2212f7c56a3b38e159dc6d89c16101d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5837fea8df0fbd1a5c196225f6c166f343f638fc4cf742b9a21f39e2b2eb8887a23a6cf2ad86052648a308d4ef6d526d3e5894cad2fe2428e31230588c51f60e"} build_url:https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/IAxeTISDTrGdkP0Ej8S32Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bf0972b501d3698244787329058d6536dbf75d6eb252cbb48c86066cdaa1d6e649123c43265682e2cd2dbb27eee33193860a4ff86e2e5f270e94bad7f104fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879516033dfdee57762eaf3ab96a12f96842a917e3852f57b1e72608f398f896564a2b27061a401c44d307a8ab93ea4a2212f7c56a3b38e159dc6d89c16101d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5837fea8df0fbd1a5c196225f6c166f343f638fc4cf742b9a21f39e2b2eb8887a23a6cf2ad86052648a308d4ef6d526d3e5894cad2fe2428e31230588c51f60e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 07:24:09.448535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:24:09.448878) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1466084825.263631-940216063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:24:09.531396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 07:24:09.534806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 07:24:09.535153) ========= ========= Total master_lag: 1.44 =========