builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1464442878.04 results: success (0) buildid: 20160528052044 builduid: 35ac5aea033444dd88a885886ac94675 revision: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.038554) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.039626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.040424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.057240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.057584) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 06:41:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2016-05-28 06:41:18 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.171205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.171590) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019236 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.226387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.227360) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 --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 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 06:41:18,360 truncating revision to first 12 chars 2016-05-28 06:41:18,360 Setting DEBUG logging. 2016-05-28 06:41:18,360 attempt 1/10 2016-05-28 06:41:18,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c7440e46d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 06:41:18,673 unpacking tar archive at: mozilla-central-2c7440e46d87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652508 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.898785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.899156) ========= script_repo_revision: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.899637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.900031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:41:18.911639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-28 06:41:18.912170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:19 INFO - MultiFileLogger online at 20160528 06:41:19 in /builds/slave/test 06:41:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:41:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:19 INFO - {'append_to_log': False, 06:41:19 INFO - 'base_work_dir': '/builds/slave/test', 06:41:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:41:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:19 INFO - 'branch': 'Firefox-Non-PGO', 06:41:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:19 INFO - 'config_files': ('talos/linux_config.py',), 06:41:19 INFO - 'default_actions': ('clobber', 06:41:19 INFO - 'read-buildbot-config', 06:41:19 INFO - 'download-and-extract', 06:41:19 INFO - 'populate-webroot', 06:41:19 INFO - 'create-virtualenv', 06:41:19 INFO - 'install', 06:41:19 INFO - 'run-tests'), 06:41:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:19 INFO - 'download_minidump_stackwalk': True, 06:41:19 INFO - 'download_symbols': 'ondemand', 06:41:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:19 INFO - 'installer_path': 'installer.exe', 06:41:19 INFO - 'log_level': 'info', 06:41:19 INFO - 'log_name': 'talos', 06:41:19 INFO - 'log_to_console': True, 06:41:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:19 INFO - 'opt_config_files': (), 06:41:19 INFO - 'pip_index': False, 06:41:19 INFO - 'sps_profile': False, 06:41:19 INFO - 'sps_profile_interval': 0, 06:41:19 INFO - 'suite': 'dromaeojs', 06:41:19 INFO - 'system_bits': '32', 06:41:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:19 INFO - 'title': 'talos-linux64-ix-025', 06:41:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:19 INFO - 'use_talos_json': True, 06:41:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:19 INFO - 'work_dir': 'build'} 06:41:19 INFO - ##### 06:41:19 INFO - ##### Running clobber step. 06:41:19 INFO - ##### 06:41:19 INFO - Running pre-action listener: _resource_record_pre_action 06:41:19 INFO - Running main action method: clobber 06:41:19 INFO - rmtree: /builds/slave/test/build 06:41:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:20 INFO - Running post-action listener: _resource_record_post_action 06:41:20 INFO - ##### 06:41:20 INFO - ##### Finished clobber step (success) 06:41:20 INFO - ##### 06:41:20 INFO - ##### 06:41:20 INFO - ##### Running read-buildbot-config step. 06:41:20 INFO - ##### 06:41:20 INFO - Running pre-action listener: _resource_record_pre_action 06:41:20 INFO - Running main action method: read_buildbot_config 06:41:20 INFO - Using buildbot properties: 06:41:20 INFO - { 06:41:20 INFO - "project": "", 06:41:20 INFO - "product": "firefox", 06:41:20 INFO - "script_repo_revision": "production", 06:41:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:41:20 INFO - "repository": "", 06:41:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:41:20 INFO - "buildid": "20160528052044", 06:41:20 INFO - "pgo_build": "False", 06:41:20 INFO - "basedir": "/builds/slave/test", 06:41:20 INFO - "buildnumber": 101, 06:41:20 INFO - "slavename": "talos-linux64-ix-025", 06:41:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:41:20 INFO - "platform": "ubuntu64_hw", 06:41:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:41:20 INFO - "branch": "mozilla-central", 06:41:20 INFO - "repo_path": "mozilla-central", 06:41:20 INFO - "revision": "2c7440e46d8786b2c82a1d2004e2b6d9d13f4046", 06:41:20 INFO - "stage_platform": "linux64", 06:41:20 INFO - "builduid": "35ac5aea033444dd88a885886ac94675", 06:41:20 INFO - "slavebuilddir": "test" 06:41:20 INFO - } 06:41:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:41:20 INFO - Running post-action listener: _resource_record_post_action 06:41:20 INFO - ##### 06:41:20 INFO - ##### Finished read-buildbot-config step (success) 06:41:20 INFO - ##### 06:41:20 INFO - ##### 06:41:20 INFO - ##### Running download-and-extract step. 06:41:20 INFO - ##### 06:41:20 INFO - Running pre-action listener: _resource_record_pre_action 06:41:20 INFO - Running main action method: download_and_extract 06:41:20 INFO - mkdir: /builds/slave/test/build/tests 06:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:20 INFO - https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:41:29 INFO - Downloaded 1361 bytes. 06:41:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:29 INFO - Using the following test package requirements: 06:41:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:41:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:41:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:41:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'jsshell-linux-x86_64.zip'], 06:41:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:41:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:41:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:41:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:41:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:41:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:41:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:41: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')]} 06:41:29 INFO - https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:41:35 INFO - Downloaded 22837929 bytes. 06:41:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:41:37 INFO - Return code: 0 06:41:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:37 INFO - https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:41:38 INFO - Downloaded 22837929 bytes. 06:41:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:41:40 INFO - Return code: 0 06:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:40 INFO - https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:41:41 INFO - Downloaded 10834034 bytes. 06:41:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:41:41 INFO - Return code: 0 06:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:41 INFO - https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:41:42 INFO - Downloaded 54832700 bytes. 06:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:42 INFO - mkdir: /builds/slave/test/properties 06:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:42 INFO - Contents: 06:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:43 INFO - Running post-action listener: _resource_record_post_action 06:41:43 INFO - Running post-action listener: set_extra_try_arguments 06:41:43 INFO - ##### 06:41:43 INFO - ##### Finished download-and-extract step (success) 06:41:43 INFO - ##### 06:41:43 INFO - ##### 06:41:43 INFO - ##### Running populate-webroot step. 06:41:43 INFO - ##### 06:41:43 INFO - Running pre-action listener: _resource_record_pre_action 06:41:43 INFO - Running main action method: populate_webroot 06:41:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:43 INFO - '--tppagecycles', 06:41:43 INFO - '7'], 06:41:43 INFO - 'tests': ['tsvgm']}}, 06:41:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:41:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['damp', 'tps']}, 06:41:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'tests': ['damp', 'tps']}, 06:41:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['dromaeo_dom']}, 06:41:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['a11yr', 06:41:43 INFO - 'ts_paint', 06:41:43 INFO - 'tpaint', 06:41:43 INFO - 'sessionrestore', 06:41:43 INFO - 'sessionrestore_no_auto_restore', 06:41:43 INFO - 'tabpaint']}, 06:41:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['tsvgx', 06:41:43 INFO - 'tsvgr_opacity', 06:41:43 INFO - 'tart', 06:41:43 INFO - 'tscrollx', 06:41:43 INFO - 'cart']}, 06:41:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:43 INFO - 'tsvgr_opacity', 06:41:43 INFO - 'tart', 06:41:43 INFO - 'tscrollx', 06:41:43 INFO - 'cart']}, 06:41:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'talos_options': ['--disable-e10s'], 06:41:43 INFO - 'tests': ['tp5o']}, 06:41:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'tests': ['tp5o']}, 06:41:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'talos_options': ['--disable-e10s', 06:41:43 INFO - '--xperf_path', 06:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:43 INFO - 'tests': ['tp5n']}, 06:41:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:43 INFO - 'talos_options': ['--xperf_path', 06:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:43 INFO - 'tests': ['tp5n']}}, 06:41:43 INFO - 'talos.zip': {'path': '', 06:41:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:43 INFO - Running post-action listener: _resource_record_post_action 06:41:43 INFO - ##### 06:41:43 INFO - ##### Finished populate-webroot step (success) 06:41:43 INFO - ##### 06:41:43 INFO - ##### 06:41:43 INFO - ##### Running create-virtualenv step. 06:41:43 INFO - ##### 06:41:43 INFO - Running pre-action listener: _resource_record_pre_action 06:41:43 INFO - Running main action method: create_virtualenv 06:41:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:41:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:43 INFO - Using real prefix '/usr' 06:41:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:46 INFO - Installing pip.................done. 06:41:46 INFO - Return code: 0 06:41:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:46 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:41:46 INFO - Using env: {'DISPLAY': ':0', 06:41:46 INFO - 'HOME': '/home/cltbld', 06:41:46 INFO - 'LANG': 'en_US.UTF-8', 06:41:46 INFO - 'LANGUAGE': 'en_US:en', 06:41:46 INFO - 'LOGNAME': 'cltbld', 06:41:46 INFO - 'MAIL': '/var/mail/cltbld', 06:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:46 INFO - 'MOZ_NO_REMOTE': '1', 06:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:46 INFO - 'NO_EM_RESTART': '1', 06:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:46 INFO - 'PWD': '/builds/slave/test', 06:41:46 INFO - 'SHELL': '/bin/bash', 06:41:46 INFO - 'SHLVL': '1', 06:41:46 INFO - 'TERM': 'linux', 06:41:46 INFO - 'TMOUT': '86400', 06:41:46 INFO - 'USER': 'cltbld', 06:41:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:46 INFO - '_': '/tools/buildbot/bin/python'} 06:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:41:46 INFO - Cleaning up... 06:41:46 INFO - Return code: 0 06:41:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:46 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:41:46 INFO - Using env: {'DISPLAY': ':0', 06:41:46 INFO - 'HOME': '/home/cltbld', 06:41:46 INFO - 'LANG': 'en_US.UTF-8', 06:41:46 INFO - 'LANGUAGE': 'en_US:en', 06:41:46 INFO - 'LOGNAME': 'cltbld', 06:41:46 INFO - 'MAIL': '/var/mail/cltbld', 06:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:46 INFO - 'MOZ_NO_REMOTE': '1', 06:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:46 INFO - 'NO_EM_RESTART': '1', 06:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:46 INFO - 'PWD': '/builds/slave/test', 06:41:46 INFO - 'SHELL': '/bin/bash', 06:41:46 INFO - 'SHLVL': '1', 06:41:46 INFO - 'TERM': 'linux', 06:41:46 INFO - 'TMOUT': '86400', 06:41:46 INFO - 'USER': 'cltbld', 06:41:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:46 INFO - '_': '/tools/buildbot/bin/python'} 06:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:46 INFO - Downloading/unpacking psutil>=3.1.1 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:48 INFO - Installing collected packages: psutil 06:41:48 INFO - Running setup.py install for psutil 06:41:48 INFO - building 'psutil._psutil_linux' extension 06:41:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:41:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:41:48 INFO - building 'psutil._psutil_posix' extension 06:41:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:41:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:41:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:48 INFO - Successfully installed psutil 06:41:48 INFO - Cleaning up... 06:41:49 INFO - Return code: 0 06:41:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:41: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 mozsystemmonitor==0.3 06:41:49 INFO - Using env: {'DISPLAY': ':0', 06:41:49 INFO - 'HOME': '/home/cltbld', 06:41:49 INFO - 'LANG': 'en_US.UTF-8', 06:41:49 INFO - 'LANGUAGE': 'en_US:en', 06:41:49 INFO - 'LOGNAME': 'cltbld', 06:41:49 INFO - 'MAIL': '/var/mail/cltbld', 06:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:49 INFO - 'MOZ_NO_REMOTE': '1', 06:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:49 INFO - 'NO_EM_RESTART': '1', 06:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:49 INFO - 'PWD': '/builds/slave/test', 06:41:49 INFO - 'SHELL': '/bin/bash', 06:41:49 INFO - 'SHLVL': '1', 06:41:49 INFO - 'TERM': 'linux', 06:41:49 INFO - 'TMOUT': '86400', 06:41:49 INFO - 'USER': 'cltbld', 06:41:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:49 INFO - '_': '/tools/buildbot/bin/python'} 06:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:41:51 INFO - Installing collected packages: mozsystemmonitor 06:41:51 INFO - Running setup.py install for mozsystemmonitor 06:41:51 INFO - Successfully installed mozsystemmonitor 06:41:51 INFO - Cleaning up... 06:41:51 INFO - Return code: 0 06:41:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:51 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:41:51 INFO - Using env: {'DISPLAY': ':0', 06:41:51 INFO - 'HOME': '/home/cltbld', 06:41:51 INFO - 'LANG': 'en_US.UTF-8', 06:41:51 INFO - 'LANGUAGE': 'en_US:en', 06:41:51 INFO - 'LOGNAME': 'cltbld', 06:41:51 INFO - 'MAIL': '/var/mail/cltbld', 06:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:51 INFO - 'MOZ_NO_REMOTE': '1', 06:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:51 INFO - 'NO_EM_RESTART': '1', 06:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:51 INFO - 'PWD': '/builds/slave/test', 06:41:51 INFO - 'SHELL': '/bin/bash', 06:41:51 INFO - 'SHLVL': '1', 06:41:51 INFO - 'TERM': 'linux', 06:41:51 INFO - 'TMOUT': '86400', 06:41:51 INFO - 'USER': 'cltbld', 06:41:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:51 INFO - '_': '/tools/buildbot/bin/python'} 06:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:53 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:54 INFO - Downloading docopt-0.6.1.tar.gz 06:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:54 INFO - Running setup.py install for blobuploader 06:41:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:54 INFO - Running setup.py install for requests 06:41:54 INFO - Running setup.py install for docopt 06:41:55 INFO - Successfully installed blobuploader requests docopt 06:41:55 INFO - Cleaning up... 06:41:55 INFO - Return code: 0 06:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:55 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:55 INFO - Using env: {'DISPLAY': ':0', 06:41:55 INFO - 'HOME': '/home/cltbld', 06:41:55 INFO - 'LANG': 'en_US.UTF-8', 06:41:55 INFO - 'LANGUAGE': 'en_US:en', 06:41:55 INFO - 'LOGNAME': 'cltbld', 06:41:55 INFO - 'MAIL': '/var/mail/cltbld', 06:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:55 INFO - 'MOZ_NO_REMOTE': '1', 06:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:55 INFO - 'NO_EM_RESTART': '1', 06:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:55 INFO - 'PWD': '/builds/slave/test', 06:41:55 INFO - 'SHELL': '/bin/bash', 06:41:55 INFO - 'SHLVL': '1', 06:41:55 INFO - 'TERM': 'linux', 06:41:55 INFO - 'TMOUT': '86400', 06:41:55 INFO - 'USER': 'cltbld', 06:41:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:55 INFO - '_': '/tools/buildbot/bin/python'} 06:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:55 INFO - Running setup.py (path:/tmp/pip-asg6en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:55 INFO - Running setup.py (path:/tmp/pip-4XLNDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:55 INFO - Running setup.py (path:/tmp/pip-EUcHr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:55 INFO - Running setup.py (path:/tmp/pip-99TtdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:55 INFO - Running setup.py (path:/tmp/pip-q4o1gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:55 INFO - Running setup.py (path:/tmp/pip-UMnlQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:55 INFO - Running setup.py (path:/tmp/pip-TXEBqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:55 INFO - Running setup.py (path:/tmp/pip-EiDwlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:56 INFO - Running setup.py (path:/tmp/pip-Vxng_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:56 INFO - Running setup.py (path:/tmp/pip-JYL7P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:56 INFO - Running setup.py (path:/tmp/pip-6PHGD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:56 INFO - Running setup.py (path:/tmp/pip-lqMQC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:56 INFO - Running setup.py (path:/tmp/pip-UyiBUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:56 INFO - Running setup.py (path:/tmp/pip-0kO6RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:56 INFO - Running setup.py (path:/tmp/pip-w4wq1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:56 INFO - Running setup.py (path:/tmp/pip-taf7uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:56 INFO - Running setup.py (path:/tmp/pip-eltByQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:56 INFO - Running setup.py install for manifestparser 06:41:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:56 INFO - Running setup.py install for mozcrash 06:41:56 INFO - Running setup.py install for mozdebug 06:41:56 INFO - Running setup.py install for mozdevice 06:41:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozfile 06:41:57 INFO - Running setup.py install for mozhttpd 06:41:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozinfo 06:41:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozInstall 06:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozleak 06:41:57 INFO - Running setup.py install for mozlog 06:41:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for moznetwork 06:41:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozprocess 06:41:57 INFO - Running setup.py install for mozprofile 06:41:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:57 INFO - Running setup.py install for mozrunner 06:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:58 INFO - Running setup.py install for mozscreenshot 06:41:58 INFO - Running setup.py install for moztest 06:41:58 INFO - Running setup.py install for mozversion 06:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:58 INFO - Cleaning up... 06:41:58 INFO - Return code: 0 06:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:58 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:58 INFO - Using env: {'DISPLAY': ':0', 06:41:58 INFO - 'HOME': '/home/cltbld', 06:41:58 INFO - 'LANG': 'en_US.UTF-8', 06:41:58 INFO - 'LANGUAGE': 'en_US:en', 06:41:58 INFO - 'LOGNAME': 'cltbld', 06:41:58 INFO - 'MAIL': '/var/mail/cltbld', 06:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:58 INFO - 'MOZ_NO_REMOTE': '1', 06:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:58 INFO - 'NO_EM_RESTART': '1', 06:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:58 INFO - 'PWD': '/builds/slave/test', 06:41:58 INFO - 'SHELL': '/bin/bash', 06:41:58 INFO - 'SHLVL': '1', 06:41:58 INFO - 'TERM': 'linux', 06:41:58 INFO - 'TMOUT': '86400', 06:41:58 INFO - 'USER': 'cltbld', 06:41:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:58 INFO - '_': '/tools/buildbot/bin/python'} 06:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:58 INFO - Running setup.py (path:/tmp/pip-EVO5cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:58 INFO - Running setup.py (path:/tmp/pip-EU4buM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:58 INFO - Running setup.py (path:/tmp/pip-OOhiAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:58 INFO - Running setup.py (path:/tmp/pip-GEhsVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:58 INFO - Running setup.py (path:/tmp/pip-x8HA3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:59 INFO - Running setup.py (path:/tmp/pip-qsjlKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:59 INFO - Running setup.py (path:/tmp/pip-RlqzDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:59 INFO - Running setup.py (path:/tmp/pip-KApkH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:59 INFO - Running setup.py (path:/tmp/pip-ioPYxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:59 INFO - Running setup.py (path:/tmp/pip-ju090w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:59 INFO - Running setup.py (path:/tmp/pip-Y9yZ4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:59 INFO - Running setup.py (path:/tmp/pip-7oHe72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:59 INFO - Running setup.py (path:/tmp/pip-vxZlt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:59 INFO - Running setup.py (path:/tmp/pip-F3maee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:59 INFO - Running setup.py (path:/tmp/pip-cLpDeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:59 INFO - Running setup.py (path:/tmp/pip-7_XMa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:59 INFO - Running setup.py (path:/tmp/pip-P6hw12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:01 INFO - Downloading blessings-1.6.tar.gz 06:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:01 INFO - Installing collected packages: blessings 06:42:01 INFO - Running setup.py install for blessings 06:42:01 INFO - Successfully installed blessings 06:42:01 INFO - Cleaning up... 06:42:02 INFO - Return code: 0 06:42:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:02 INFO - Reading from file tmpfile_stdout 06:42:02 INFO - Current package versions: 06:42:02 INFO - argparse == 1.2.1 06:42:02 INFO - blessings == 1.6 06:42:02 INFO - blobuploader == 1.2.4 06:42:02 INFO - docopt == 0.6.1 06:42:02 INFO - manifestparser == 1.1 06:42:02 INFO - mozInstall == 1.12 06:42:02 INFO - mozcrash == 0.17 06:42:02 INFO - mozdebug == 0.1 06:42:02 INFO - mozdevice == 0.48 06:42:02 INFO - mozfile == 1.2 06:42:02 INFO - mozhttpd == 0.7 06:42:02 INFO - mozinfo == 0.9 06:42:02 INFO - mozleak == 0.1 06:42:02 INFO - mozlog == 3.2 06:42:02 INFO - moznetwork == 0.27 06:42:02 INFO - mozprocess == 0.22 06:42:02 INFO - mozprofile == 0.28 06:42:02 INFO - mozrunner == 6.11 06:42:02 INFO - mozscreenshot == 0.1 06:42:02 INFO - mozsystemmonitor == 0.3 06:42:02 INFO - moztest == 0.7 06:42:02 INFO - mozversion == 1.4 06:42:02 INFO - psutil == 3.1.1 06:42:02 INFO - requests == 1.2.3 06:42:02 INFO - wsgiref == 0.1.2 06:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 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 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:42:02 INFO - Using env: {'DISPLAY': ':0', 06:42:02 INFO - 'HOME': '/home/cltbld', 06:42:02 INFO - 'LANG': 'en_US.UTF-8', 06:42:02 INFO - 'LANGUAGE': 'en_US:en', 06:42:02 INFO - 'LOGNAME': 'cltbld', 06:42:02 INFO - 'MAIL': '/var/mail/cltbld', 06:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:02 INFO - 'MOZ_NO_REMOTE': '1', 06:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:02 INFO - 'NO_EM_RESTART': '1', 06:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:02 INFO - 'PWD': '/builds/slave/test', 06:42:02 INFO - 'SHELL': '/bin/bash', 06:42:02 INFO - 'SHLVL': '1', 06:42:02 INFO - 'TERM': 'linux', 06:42:02 INFO - 'TMOUT': '86400', 06:42:02 INFO - 'USER': 'cltbld', 06:42:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:02 INFO - '_': '/tools/buildbot/bin/python'} 06:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:42:02 INFO - Cleaning up... 06:42:02 INFO - Return code: 0 06:42:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:42:02 INFO - Using env: {'DISPLAY': ':0', 06:42:02 INFO - 'HOME': '/home/cltbld', 06:42:02 INFO - 'LANG': 'en_US.UTF-8', 06:42:02 INFO - 'LANGUAGE': 'en_US:en', 06:42:02 INFO - 'LOGNAME': 'cltbld', 06:42:02 INFO - 'MAIL': '/var/mail/cltbld', 06:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:02 INFO - 'MOZ_NO_REMOTE': '1', 06:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:02 INFO - 'NO_EM_RESTART': '1', 06:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:02 INFO - 'PWD': '/builds/slave/test', 06:42:02 INFO - 'SHELL': '/bin/bash', 06:42:02 INFO - 'SHLVL': '1', 06:42:02 INFO - 'TERM': 'linux', 06:42:02 INFO - 'TMOUT': '86400', 06:42:02 INFO - 'USER': 'cltbld', 06:42:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:02 INFO - '_': '/tools/buildbot/bin/python'} 06:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:02 INFO - Downloading/unpacking jsonschema 06:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:04 INFO - Downloading/unpacking functools32 (from jsonschema) 06:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:04 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:04 INFO - warning: no files found matching '*.txt' 06:42:04 INFO - no previously-included directories found matching 'build' 06:42:04 INFO - no previously-included directories found matching 'dist' 06:42:04 INFO - no previously-included directories found matching '.git*' 06:42:04 INFO - Installing collected packages: jsonschema, functools32 06:42:04 INFO - Running setup.py install for functools32 06:42:04 INFO - warning: no files found matching '*.txt' 06:42:04 INFO - no previously-included directories found matching 'build' 06:42:04 INFO - no previously-included directories found matching 'dist' 06:42:04 INFO - no previously-included directories found matching '.git*' 06:42:04 INFO - Successfully installed jsonschema functools32 06:42:04 INFO - Cleaning up... 06:42:05 INFO - Return code: 0 06:42:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42: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')]} 06:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f80a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15778e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:42:05 INFO - Using env: {'DISPLAY': ':0', 06:42:05 INFO - 'HOME': '/home/cltbld', 06:42:05 INFO - 'LANG': 'en_US.UTF-8', 06:42:05 INFO - 'LANGUAGE': 'en_US:en', 06:42:05 INFO - 'LOGNAME': 'cltbld', 06:42:05 INFO - 'MAIL': '/var/mail/cltbld', 06:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:05 INFO - 'MOZ_NO_REMOTE': '1', 06:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:05 INFO - 'NO_EM_RESTART': '1', 06:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:05 INFO - 'PWD': '/builds/slave/test', 06:42:05 INFO - 'SHELL': '/bin/bash', 06:42:05 INFO - 'SHLVL': '1', 06:42:05 INFO - 'TERM': 'linux', 06:42:05 INFO - 'TMOUT': '86400', 06:42:05 INFO - 'USER': 'cltbld', 06:42:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:05 INFO - '_': '/tools/buildbot/bin/python'} 06:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:05 INFO - Downloading/unpacking flake8 06:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:42:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:42:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:42:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:42:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:42:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:42:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:42:07 INFO - no previously-included directories found matching 'docs/_build' 06:42:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:42:07 INFO - Running setup.py install for pep8 06:42:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:42:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:42:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:42:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:42:07 INFO - no previously-included directories found matching 'docs/_build' 06:42:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:42:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:42:08 INFO - Cleaning up... 06:42:08 INFO - Return code: 0 06:42:08 INFO - Running post-action listener: _resource_record_post_action 06:42:08 INFO - Running post-action listener: _start_resource_monitoring 06:42:08 INFO - Starting resource monitoring. 06:42:08 INFO - ##### 06:42:08 INFO - ##### Finished create-virtualenv step (success) 06:42:08 INFO - ##### 06:42:08 INFO - ##### 06:42:08 INFO - ##### Running install step. 06:42:08 INFO - ##### 06:42:08 INFO - Running pre-action listener: _resource_record_pre_action 06:42:08 INFO - Running main action method: install 06:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:08 INFO - Reading from file tmpfile_stdout 06:42:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:08 INFO - Reading from file tmpfile_stdout 06:42:08 INFO - Output received: 06:42:08 INFO - Usage: mozinstall [options] installer 06:42:08 INFO - Options: 06:42:08 INFO - -h, --help show this help message and exit 06:42:08 INFO - -d DEST, --destination=DEST 06:42:08 INFO - Directory to install application into. [default: 06:42:08 INFO - "/builds/slave/test"] 06:42:08 INFO - --app=APP Application being installed. [default: firefox] 06:42:08 INFO - mkdir: /builds/slave/test/build/application 06:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:42:24 INFO - Reading from file tmpfile_stdout 06:42:24 INFO - Output received: 06:42:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:42:24 INFO - Running post-action listener: _resource_record_post_action 06:42:24 INFO - ##### 06:42:24 INFO - ##### Finished install step (success) 06:42:24 INFO - ##### 06:42:24 INFO - ##### 06:42:24 INFO - ##### Running run-tests step. 06:42:24 INFO - ##### 06:42:24 INFO - Running pre-action listener: _resource_record_pre_action 06:42:24 INFO - Running main action method: run_tests 06:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:24 INFO - Python 2.7.3 06:42:24 INFO - Return code: 0 06:42:24 INFO - grabbing minidump binary from tooltool 06:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1606b20>, '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 0x1607a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1607eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:42:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:42:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:42:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:24 INFO - Return code: 0 06:42:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:42:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:42:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:42:25 INFO - Return code: 0 06:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:42:25 INFO - Using env: {'DISPLAY': ':0', 06:42:25 INFO - 'HOME': '/home/cltbld', 06:42:25 INFO - 'LANG': 'en_US.UTF-8', 06:42:25 INFO - 'LANGUAGE': 'en_US:en', 06:42:25 INFO - 'LOGNAME': 'cltbld', 06:42:25 INFO - 'MAIL': '/var/mail/cltbld', 06:42:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:25 INFO - 'MOZ_NO_REMOTE': '1', 06:42:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:25 INFO - 'NO_EM_RESTART': '1', 06:42:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:25 INFO - 'PWD': '/builds/slave/test', 06:42:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:25 INFO - 'SHELL': '/bin/bash', 06:42:25 INFO - 'SHLVL': '1', 06:42:25 INFO - 'TERM': 'linux', 06:42:25 INFO - 'TMOUT': '86400', 06:42:25 INFO - 'USER': 'cltbld', 06:42:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464442622.404030-82612683', 06:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:25 INFO - '_': '/tools/buildbot/bin/python'} 06:42:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:42:25 INFO - mozversion application_buildid: 20160528052044 06:42:25 INFO - mozversion application_changeset: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 06:42:25 INFO - mozversion application_display_name: Nightly 06:42:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:25 INFO - mozversion application_name: Firefox 06:42:25 INFO - mozversion application_remotingname: firefox 06:42:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:42:25 INFO - mozversion application_vendor: Mozilla 06:42:25 INFO - mozversion application_version: 49.0a1 06:42:25 INFO - mozversion platform_buildid: 20160528052044 06:42:25 INFO - mozversion platform_changeset: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 06:42:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:42:25 INFO - mozversion platform_version: 49.0a1 06:42:25 INFO - using testdate: 1464442945 06:42:25 INFO - actual date: 1464442945 06:42:25 INFO - starting webserver on 'localhost:38194' 06:42:25 INFO - SUITE-START | Running 2 tests 06:42:25 INFO - TEST-START | dromaeo_css 06:42:25 INFO - operating with platform_type : linux_ 06:42:25 INFO - Initialising browser for dromaeo_css test... 06:42:25 INFO - TEST-INFO | started process 27142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCBsKdd/profile http://localhost:38194/getInfo.html) 06:42:29 INFO - PROCESS | 27142 | __metrics Screen width/height:1600/1200 06:42:29 INFO - PROCESS | 27142 | colorDepth:24 06:42:29 INFO - PROCESS | 27142 | Browser inner width/height: 1024/697 06:42:29 INFO - PROCESS | 27142 | __metrics 06:42:31 ERROR - PROCESS | 27142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:42:32 INFO - TEST-INFO | 27142: exit 0 06:42:32 INFO - Browser initialized. 06:42:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:32 INFO - TEST-INFO | started process 27222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCBsKdd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:44 INFO - PROCESS | 27222 | RSS: Main: 157081600 06:42:44 INFO - PROCESS | 27222 | 06:43:35 INFO - PROCESS | 27222 | 1464443015714 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:45:47 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38194/tests/dromaeo/cssquery-ext.html) 06:45:48 INFO - PROCESS | 27222 | RSS: Main: 239976448 06:45:48 INFO - PROCESS | 27222 | 06:48:51 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-ext.html (next: http://localhost:38194/tests/dromaeo/cssquery-jquery.html) 06:48:51 INFO - PROCESS | 27222 | RSS: Main: 243253248 06:48:51 INFO - PROCESS | 27222 | 06:51:53 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38194/tests/dromaeo/cssquery-mootools.html) 06:51:54 INFO - PROCESS | 27222 | RSS: Main: 244862976 06:51:54 INFO - PROCESS | 27222 | 06:54:56 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38194/tests/dromaeo/cssquery-prototype.html) 06:54:57 INFO - PROCESS | 27222 | RSS: Main: 243421184 06:54:57 INFO - PROCESS | 27222 | 06:58:00 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38194/tests/dromaeo/cssquery-yui.html) 06:58:00 INFO - PROCESS | 27222 | RSS: Main: 232230912 06:58:00 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-yui.html (next: http://localhost:38194/tests/dromaeo/cssquery-dojo.html) 07:01:03 INFO - PROCESS | 27222 | RSS: Main: 291954688 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | __start_tp_report 07:01:03 INFO - PROCESS | 27222 | _x_x_mozilla_page_load 07:01:03 INFO - PROCESS | 27222 | _x_x_mozilla_page_load_details 07:01:03 INFO - PROCESS | 27222 | |i|pagename|runs| 07:01:03 INFO - PROCESS | 27222 | |0;dojo.html;2652.535806233911;2674.010616072053;2710.2004908551967;2720.238333266686;2732.030129304097;4603.7237765734;4656.534346565346;4715.669903106779;4737.313089602006;4739.573438390544;4728.9763551182195;4744.69159504632;4762.833300834472;4825.2279635258365;4829.9275510867365;4302.913941721164;4353.477582690066;4382.824687012531;4421.425214722081;4503.909921801562;4409.184300904327;4459.777011149446;4476.350929115276;4483.484399294074;4502.347159661847;4297.484301883778;4337.869863904088;4357.760323182224;4364.541723119059;4381.9342709859375;4383.145286669101;4383.75889326087;4393.099414620027;4418.182636212311;4434.866953991385;4399.274119770266;4416.40378548895;4424.070945101533;4473.127740090684;4474.127545128701;4619.630429565626;4693.413323334583;4711.670183087185;4752.263399173134;4762.452317983441;5156.381234251914;5232.790688372461;5243.4232234454175;5256.290400795881;5258.605604579634;5217.217417387385;5246.317978662788;5259.053370393328;5261.921071183935;5265.842024739264;4700.03649251906;4732.645051621143;4788.281757736368;4789.473157952622;4852.8544143675745;5257.132573125468;5295.814646487354;5295.947040529545;5298.655587386807;5299.046171689056;4902.926456103161;5040.092783299041;5087.847364579068;5088.516590923857;5093.057784309841;5076;5136.178211486144;5138.768755406016;5143.7685304161405;5167.638265321391;5083.415407228142;5094.439611642716;5100.846974590768;5103.336566246364;5149.7940082397035;4906.656534042654;5016.573591244785;5046.621503387188;5065.696058236517;5071.771770270347;4299.269124248885;4311.07311927937;4331.068820203672;4373.343998400202;4378.255696531533;3765.9246815063543;3780.8865734028022;3799.7910114943393;3824.9617503824607;3849.191669749328;4338.457692788402;4401.889952751207;4415.757133357632;4417.050334178167;4424.269995450714;5115.462876397999;5116.155834287301;5167.431582525919;5173.094708426011;5193.818216362409;4415.580519850673;4424.424824772759;4425.911481770347;4473.060657262012;4475.26158183896;4461.196984542748;4554.977225113853;4587.77061146948;4606.838760643362;4633.930491042637;4849.466558678472;4862.927056094232;4872.9269060964825;4919.975400123048;4922.65541412112;5174.767135478988;5188.143956247328;5188.351456067991;5188.481151884932;5194.97402512985;4737;4793;4831.806727730851;4831.9275210872565;4859.805607775649;5067.315912351785;5090.261912022662;5091.745412729423;5097.949020509747;5113.233015047773;5172.793088276427;5174.7930082796265;5184.844454666366;5185.144451165515;5186.196139598368;4872.6832755870755;4915.090708218991;4957.454679985127;4965.677230979974;4983.202687569971;4954.900901981868;4983.700977941335;4988.401391833003;4991.450940396626;5035.370578677665;4846.95153048465;4928.778204980857;4933.457319694902;4940.752962351796;4980.900381992412;4959.900801984012;4993.375828021497;5005.399352077774;5008.6243531734535;5018.272350509083;4901.803927842846;4902.3872015998;4906.55840974314;4906.8773280668265;4959.181735013826 07:01:03 INFO - PROCESS | 27222 | |1;ext.html;585.4613755345082;585.5227989188811;592.3010847200304;617.5337620096827;621.0280910375266;39504;40981.180376392454;41006.38490422646;44272.77863610678;44403;41366;41545.16909661813;41834;41867.16265674685;41983.58016419835;7728.07263128424;7909.564973926432;7911.367090632735;7924.603769811515;7943.086545047307;7768.922310776877;7858.214178582153;7860.410469214832;7861.449698521106;7863.370930325589;7831.647575859071;7883.724069657563;7888.842223155533;7891.921080789176;7897.052353717533;7845.293923546879;7893.486923349992;7897.8025549361155;7902.446828721992;7907.367410607195;7626.2755038271835;7689.9615501922135;7696.576688282143;7709.653065612061;7712.884306735404;38559.228815423536;38883;38983.41524877101;39007.41488877641;39022;2942.955855662167;2969.584258203853;3337.566116404876;3834.3673293906472;3866;27567.172984810488;28442.573361399594;29597.852010740025;30078.24804379886;30138.69861301381;3344.715699165574;3347.933041339184;3348.430766769655;3358.412277851366;3364.8990530283886;257022;263157;263315;263819.6809015962;263991;49240;50794.74602626963;56165.71917140388;57676.71161644249;58405.41594584085;55544.72227638917;55728;56118.43881561132;56152.15771763427;56231.15653265204;14161.85838141626;14262.85737142636;14361.281935903164;14373.425062997572;14386.35261413239;9679.70960871175;9987.550560224807;10762.869898660685;10858.511366988505;10858.837117443245;16703.749443758352;18644.551929009427;20185.394438166877;20316.28892988738;20419.08114134838;7513.962430187814;7535.886961695579;7564.583947882809;7648.847023059508;7739.1873853245725;814.3281792521075;847.3306088190384;929.0570071377557;984.8227319082633;1017.1049476460815;27508.724912751015;27894;28389.57415638767;28538.571921421197;28680;956.880509671068;993.339429279521;994.2791476179711;1058.8094143054325;1068.8663917010374;14819.40722371093;15093.39626414931;15296.182186194335;15456.304466299043;15498;373809;374443;378173;378605;379344;50269.74865125651;50831;50917.74541127345;50953.23570146451;51134.48865511372;1072.9570817167382;1212.7453234820787;1234.9135560510858;1245.5204746172608;1258.2450529682117;27768.722312776612;29164.854175729834;29285.7071429283;29390.559141612466;29681;41134.17731645291;41676.37485437781;41676.58323416727;41697.58302416937;41712.3743143847;276526;279371;280451;282234;284332;32296.19259518437;36635;37776.62223377841;39024.80487597544;41119;41740;42307.576924231595;42770;42797.786011069744;43157.56842431661;36448.901843343614;36572.26855462929;36807.81596092002;36881;37099.25801483901;35862.64137358697;35949.460758089175;36168.457473137394;36201.45697814588;36224.63775362318;35412.822935886186;35512.822435887654;36100.8194959034;36359.81820090883;36432.27135457223;31625.8418707905;32028;32110.839445803555;33220.833895830365;33809;25758;25815.225543233733;25974.48051038931;26065.73934260633;26383.208503744918 07:01:03 INFO - PROCESS | 27222 | |2;jquery.html;370.5016752467931;381.7766606535177;387.703133020048;396.24910794045303;397.60438363827996;15498.302576384061;16696.081715505643;17347.566310842234;17496.650066998653;17507.124643767824;15508.14705191214;16128.677426451464;16985.91507042466;17011.744823827652;17078.743818842697;4554.476235232949;4745.477997420281;4759.333693282943;4763.690360126598;4775.331453596482;3395.2021275000357;3559.4660800879947;5128.5897128229835;5395;5416.783328666848;5449.01917654822;5465.808696695616;5474.863128421782;5489.58828087893;5491.752871120789;5498.752556134984;5899.705014749288;5910.172575839364;5916.1421593868645;5917.792877249297;4630.236011058171;5195.974020129913;5242.580593552545;5248.160294352885;5252.474752524717;11982.340971246578;12081.15431919766;12198.39008049594;12209.694757631041;12211.206271592318;1832.0748022248679;1848.3530764232546;1852.1850385830326;1933.2846846666682;2050.064311863071;8840.911590884074;8939.463632182089;9034;9127.17855393011;9150.908490915139;1653.7023335799552;1657.892237004591;1662.2187571841216;1675.748637704342;1705.505403433003;65419.3458065418;66098;66748.66625666841;66900.6654966722;67687.66156169237;9978.401295922267;10088.243381746399;10343.94828025855;10474.947625261824;11030.50362733679;14000.689886168668;14094.295285235698;14114.717705646035;14189.645258868612;14189.929050354682;6973.4072603829245;7183;7222.602756848424;7292.489525733148;7319.377852882564;6493.902591461132;6525.184351956005;6607.471402287805;6642.6014439133805;6719.932800671931;4357.2592659248;4419.359192917009;4420.270655341833;4458.308962110878;4526.275795872711;1659.7593348964574;1739.7734597109009;1745.7992330882112;1818.3181307009872;1823.972640410395;708.348319546019;819.6885183630183;829.8423299573062;841.2050612171562;849.2865992566274;15822.129782862054;16331.346746130259;16674.83325166757;16815;17215.22531486061;834.3450391442689;837.4054421360902;851.6678495386805;866.1987661413168;875.3391189651772;9374.109459601326;9389.62441502346;9541;9561.091696288842;9671.323007389556;371935;373275;374252;375928;375996;67431.66284168646;69310.30689693039;69695;70322;71561;866.445474896067;925.7269105613725;957.9329446938648;990.2968892086699;1002.1231422505308;15180.848191517944;15431.768523471932;15621.062736235863;15695.351988041548;15987.680246395239;25773.484530309663;27329.043483477984;28753.856230718713;30061;32956.83521582377;44124.33813492736;44970.77514612406;45553.54446455493;53209.20186197288;53405.4659453416;7312.890306645511;7490.101187857492;7602.315791578784;7632.160462349026;7738.574378409242;10713.946430267799;10793.136549075898;10831.783364332512;11150.888491114985;11444.607003580171;6090.604110732788;8429.114942930904;8961.059088795582;9195.862062069207;9351.39215950961;9388.906110939077;9574.425534467955;9697.127258546765;9697.369670971364;9799.412035277906;8957.193852553302;9621.663241786504;9642.373245739005;9772.12050915421;9953.303268771117;7622.390208783395;7632.236776322324;7678.61606919663;7729;7812.062552493509;8367.372447066617;9506.524673766422;9628.614855405986;9764.804703906024;9770.31607787448 07:01:03 INFO - PROCESS | 27222 | |3;mootools.html;1164.243241892769;1399.5381524097045;1452.7312447197269;1539.899906506077;1742.6688929103477;6754.257031726506;7660.195679453661;7855;7860.489068210577;8071.556064416454;7807.141214466418;7977.282044615983;7993.480423772466;7993.600319983992;7994.04071511418;1915.6839121544929;2198.6152423325934;2212.8493183544547;2247.910083596654;2263.7962583367494;2216.745074316458;2236.183792915582;2237.798598126168;2238.6418173092306;2239.1826983151113;2210.3368989303144;2222.866628002325;2225.6772767948637;2243.383069655841;2247.9438014049697;1859.655963646723;1924.5477312831474;1925.9037048147536;2093.6440805063025;2157.838162137838;2127.7659457459667;2158.946026349338;2163;2163.729533808274;2169.2190811307914;7862.488938218998;7884.881726774103;7895.921040789576;7904.486208396436;7904.486208396436;4418.072204836988;4503.977480112611;4505.166544189336;4505.684602077856;4506.977465112686;2884.927876803076;2909.0836386538385;2975.4941659917868;3062.4793785056595;3084.4447999360104;912.5619702542816;947.9810403791886;948.9572969216401;952.1335584618033;961.9470929098896;10190.439525826077;10208.642697505551;10218.591256349737;10221.540030698636;10223.897761022368;4262.616364527207;4272.829086836492;4380.452443444569;4399.6040356368085;4402.0095478517715;8749.47503149813;8779.253763430052;8783.297336213087;8784;8786.560671966376;4789.377380940456;4797.4482934462985;4800.255960326155;4802.183628783116;4803.255495398219;3838.4626152338697;4277.101808620225;4424.601785839225;4428.2914733642465;4451.243288640939;3704.3517384457614;3720.2001569662652;3765.9435108473394;3812.370958791824;3853.7302388833073;1207.1549915059493;1227.6623928419756;1234.6234398508361;1247.1394737631188;1250.1623911978995;796.4942261663886;810.7243537197381;871.7428358634218;873.057098333798;916.2852974679761;5243.711595862264;5365.141577347606;5402.8109016185035;5466.098093814476;5495.945040549544;408.2610475040187;417.5135966598939;418.26594326955995;419.83626385709596;421.9472565929259;3677.42999835026;3744.681702055356;3758.9436158457647;3768.5289338832645;3796.563395209531;9553.665621703347;9737.172340351008;9933.602655893828;9950.35322704022;9960.153386962045;9668.419894806193;9750.366226195274;9760.219182465527;9769;9769.16962058233;7319.890201646979;7417.740379086706;7484.363829074481;7485.962570187115;7547.0943486781935;5288.894222115613;5337.359516858002;5346.786128554814;5363.088274993339;5374.328208973879;8589.8711519326;8842.248408885316;8845.778855528662;9002.459852408876;9102.726918192464;9024.774380640536;9135.177833994972;9139.543022848698;9211.677591284273;9391.342606017513;6104.511639068953;6165.229346331708;6628.403443690091;6932.44540436774;7094.716211351488;7489.400847932044;7694.692212311445;7773.650185741542;7778;7778.88331675014;6841.863162736817;6949.166100068024;6969.477289203229;7003.859922801414;7169.247229040876;6907.205671347659;6936.34104760047;6957.930420695729;6994.300569942965;7056.7530136444975;6194.845128871814;6378;6399.200099987502;6412.134361861089;6481.384268494486;4704.435467743892;4721.929171062368;4739.857804265877;4758.1911075118005;4791.257355109963;4726.527347265246;4758.547937945889;4799.328094066764;4818.156822556109;4871.80512779499 07:01:03 INFO - PROCESS | 27222 | |4;prototype.html;291.0685805422647;298.82070757545466;301.32352867811767;307.6923076923077;311.4409634705703;4695.6478264130155;4704.4589872164715;4756.357891684622;4760.90478190436;4779.90440191196;4653.255479123341;4664.790084446199;4684.672072954894;4714.127886341029;4723.7165770053825;3769.9623003769952;3772.3964165733487;3780.754250973692;3796.3735983562815;3797.1076796952693;3554.822258887058;3564.625714299987;3809.733318667694;3823.3882578787398;3828.8085595720104;3250.2361944943036;3597.478365636981;3603.981980090096;3613.674769270778;3698.223373091654;3584.8386822592915;3703.5370578677666;3705.4256590228556;3721.6650501454865;3736.831842567091;3240.8703651854134;3242.6919442653148;3250.431174544445;3252.2032102135126;3285.474324108155;4366.170427618774;4413.426254586883;4565.817367305303;4592.645169674954;4603.503861245109;4210.789460526961;4211.7262377945335;4214.452121224252;4222.007828160411;4224.070704445017;5009.173486374744;5024.572911302544;5027.296178535008;5029;5046.495350464961;3469.2367679110557;3529.523514325559;3555.6444355564236;3559.394902866519;3564.4475106358555;5181.885894532656;5197.948020519784;5198.194279886624;5208.687478751287;5209.739513024334;3600.2259514204047;3604.6575575320303;3606.711463082947;3613.2412193439673;3617.366960781853;3593.9820300898327;3646.2342907989087;3653.8721144759807;3669.229461813049;3688.3176612326806;4072.429859819628;4141.006158521933;4144.834206631761;4157.667386609064;4173.895652608649;4847.466778654345;4900.730459824744;4905.9264111038365;4913.746994516376;4918.286848407032;1249.6001279590444;1269.1623528471164;1276.889106477352;1284.3514025417105;1287.1247551664958;796.5857753967904;814.2956342763467;828.1635548096345;833.9207775261341;836.4354061008795;3949.4865667463046;3976.681865450757;4042.3224361890075;4046.6964977626794;4052.675785937118;4570.291604801261;4579.656525760582;4598.701084429501;4628.305754136839;4642;3946.2044769630324;4014.892181604681;4039.6768258539246;4056.249593825152;4067.2068946555137;2323.744388117306;2476.8885400157037;2478.4175718706088;2478.467129567152;2485.3538080099306;4309.664004158721;4337.8264869404875;4369.60673539383;4389.3415987601475;4429.453064487932;5053.216751403538;5074.949250507448;5211.159917844784;5234.92147617786;5251.477071649256;4872.537108974641;4873.31773551703;4885.193942999436;4886.828960986349;4896.755162241873;4889.926651100165;5152.536271735562;5176.197689358156;5176.456472070529;5177.948220517897;5037.0681423936685;5047.041062198171;5068.417132029716;5080.898382032265;5095.847124586268;4854.73298968546;4879.219324908139;4890.926636100533;4895.559399654048;4903.534164254533;3578.2306804036216;3623.9818800905828;3624.075860655516;3628.346897558359;3630.9455358170176;4943.182386040066;5098.796048158032;5162.199859021857;5169.276301317894;5170.586353091669;4966.528179822911;4977.153883839828;4988.700677959334;5000.774965126505;5038.319826823332;5011.7494125294315;5012.8496145115705;5015.1975683890405;5020.824271150492;5028.572571331478;4696.7886445110735;4969.577585905238;4984.975075124601;5015.924761128659;5034.647574669884;4998.175301075282;5065.544101030925;5070.5943524517215;5074.213496907985;5102.2346648003095;4719.921631489821;4941.925871111865;4970.776315065903;4993.101241776515;5009.323741294878 07:01:03 INFO - PROCESS | 27222 | |5;yui.html;724.4023680463617;726.9164046134689;727.6325455644899;734.4088009152633;753.1790348520112;10928.289661172019;11266;11266.098712103032;11296.717582060453;11307.208495405315;11659.825102623467;11695.064394848412;11712.472938717758;11726.179167458282;11727.17909746318;623.6445226221056;779.9142094369615;793.4247670438914;801.8556659801234;802.7912742686885;784.4940013691166;788.727888878339;791.8060075281535;792.2315354106507;792.4848848248656;655.4788942790493;852.4160949749441;852.8635418333068;854.2439940652537;854.3080105114846;822.3667775812621;841.9326453883705;842.8651415773509;844.4173520270994;844.5566077809137;619.8915189841805;620.2309136670541;620.2464006232449;620.4756980351596;620.6307247187916;11805.704857378549;11836.526538938431;11836.940815295955;11861.347625880573;11875.228110172811;11765.823512647317;11778.705532361759;12154.817677734753;12213.267203967791;12321.815172772416;9915.702528924145;10142.239332050125;10271.34004995089;10484.032135577016;10587.417692026935;3922.2155568886337;3946.881593552198;3973.046468847485;4020.618041286102;4068.410080538335;44675;44755.328670069975;44761;44924.101517969786;46641.766791166505;9364.953175234217;9525.857112143323;9540.379875308083;9548;9573.808523829484;16662.50012499627;16704.582385440463;16705.331786728395;16713.665726685642;16729.414470493473;6675.0988616537115;6716.597004179765;6787.790914191784;6872.347127022925;6937.861242775116;3550.786952782841;3587.4260118380935;3609.097725568608;3634;3653.287608916289;2750.2574304937557;2811.9859400702867;2829.0946896992764;2830.080223927232;2833.0226072005125;471.067286772193;504.60388594952786;515.8375111839758;524.8976449592369;549.409384911222;529.8887233680894;533.3067012883237;537.2532180269428;567.2427309541808;577.6938222741869;7849.411294152961;8006.279434850891;8042.557659328676;8121.675132994732;8350.498970061815;574.1359254322218;594.0435898203888;596.931352894414;598.4225222660153;603.6257520337331;3772.7170462215445;3793.487879136281;3894.7468414552964;3895.25990061893;3916.4908561886773;58395;59454;60090.09864852031;60186.097208541905;60255.397446025854;52204;52388.47611523912;53122.73438632859;53415.73292133515;54149;48264;48949.51050489521;49228.50771492311;49789.25316120189;49819.25271120936;7512.13610434807;7530.774076777706;7555.886661700189;7580.241975802596;7630.389568834591;31885;32027.83986080055;32495.512567311984;33053.84311549181;33254.66745332516;39825.80087099546;43016.139677206906;43060.35409468798;43386.78306608447;43633.127337453705;9606.903930960601;9639;9687.70936871895;9795.657151999645;9806;8622.913770862211;9494.335396522178;9640.71077867665;10337.74155646115;10502.842457362993;8073.313768329523;9769.31614786958;10103.494825258855;10188.490575471345;10815.891841081488;10885.619003334845;11064.28082174656;11324.716882078013;11783.293002419883;11821;11103.611373601885;11106.389148596905;11625.360605166798;11723.765524689628;11750.58872939443;8953.149450802164;9082.228010619172;9276;9304.615017451704;9706.320557560903;9749.610015599581;9888.909396559115;9913.206943444651;10075.546600403146;10089.24330675217 07:01:03 INFO - PROCESS | 27222 | __end_tp_report 07:01:03 INFO - PROCESS | 27222 | __start_cc_report 07:01:03 INFO - PROCESS | 27222 | _x_x_mozilla_cycle_collect,890 07:01:03 INFO - PROCESS | 27222 | __end_cc_report 07:01:03 INFO - PROCESS | 27222 | __startTimestamp1464444063983__endTimestamp 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | ------- Summary: start ------- 07:01:03 INFO - PROCESS | 27222 | Number of tests: 6 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#0] dojo.html Cycles:165 Average:4739.32 Median:4862.93 stddev:501.77 (10.3%) stddev-sans-first:475.85 07:01:03 INFO - PROCESS | 27222 | Values: 2652.5 2674.0 2710.2 2720.2 2732.0 4603.7 4656.5 4715.7 4737.3 4739.6 4729.0 4744.7 4762.8 4825.2 4829.9 4302.9 4353.5 4382.8 4421.4 4503.9 4409.2 4459.8 4476.4 4483.5 4502.3 4297.5 4337.9 4357.8 4364.5 4381.9 4383.1 4383.8 4393.1 4418.2 4434.9 4399.3 4416.4 4424.1 4473.1 4474.1 4619.6 4693.4 4711.7 4752.3 4762.5 5156.4 5232.8 5243.4 5256.3 5258.6 5217.2 5246.3 5259.1 5261.9 5265.8 4700.0 4732.6 4788.3 4789.5 4852.9 5257.1 5295.8 5295.9 5298.7 5299.0 4902.9 5040.1 5087.8 5088.5 5093.1 5076.0 5136.2 5138.8 5143.8 5167.6 5083.4 5094.4 5100.8 5103.3 5149.8 4906.7 5016.6 5046.6 5065.7 5071.8 4299.3 4311.1 4331.1 4373.3 4378.3 3765.9 3780.9 3799.8 3825.0 3849.2 4338.5 4401.9 4415.8 4417.1 4424.3 5115.5 5116.2 5167.4 5173.1 5193.8 4415.6 4424.4 4425.9 4473.1 4475.3 4461.2 4555.0 4587.8 4606.8 4633.9 4849.5 4862.9 4872.9 4920.0 4922.7 5174.8 5188.1 5188.4 5188.5 5195.0 4737.0 4793.0 4831.8 4831.9 4859.8 5067.3 5090.3 5091.7 5097.9 5113.2 5172.8 5174.8 5184.8 5185.1 5186.2 4872.7 4915.1 4957.5 4965.7 4983.2 4954.9 4983.7 4988.4 4991.5 5035.4 4847.0 4928.8 4933.5 4940.8 4980.9 4959.9 4993.4 5005.4 5008.6 5018.3 4901.8 4902.4 4906.6 4906.9 4959.2 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#1] ext.html Cycles:180 Average:47093.81 Median:378974.50 stddev:81512.84 (21.5%) stddev-sans-first:81666.71 07:01:03 INFO - PROCESS | 27222 | Values: 585.5 585.5 592.3 617.5 621.0 39504.0 40981.2 41006.4 44272.8 44403.0 41366.0 41545.2 41834.0 41867.2 41983.6 7728.1 7909.6 7911.4 7924.6 7943.1 7768.9 7858.2 7860.4 7861.4 7863.4 7831.6 7883.7 7888.8 7891.9 7897.1 7845.3 7893.5 7897.8 7902.4 7907.4 7626.3 7690.0 7696.6 7709.7 7712.9 38559.2 38883.0 38983.4 39007.4 39022.0 2943.0 2969.6 3337.6 3834.4 3866.0 27567.2 28442.6 29597.9 30078.2 30138.7 3344.7 3347.9 3348.4 3358.4 3364.9 257022.0 263157.0 263315.0 263819.7 263991.0 49240.0 50794.7 56165.7 57676.7 58405.4 55544.7 55728.0 56118.4 56152.2 56231.2 14161.9 14262.9 14361.3 14373.4 14386.4 9679.7 9987.6 10762.9 10858.5 10858.8 16703.7 18644.6 20185.4 20316.3 20419.1 7514.0 7535.9 7564.6 7648.8 7739.2 814.3 847.3 929.1 984.8 1017.1 27508.7 27894.0 28389.6 28538.6 28680.0 956.9 993.3 994.3 1058.8 1068.9 14819.4 15093.4 15296.2 15456.3 15498.0 373809.0 374443.0 378173.0 378605.0 379344.0 50269.7 50831.0 50917.7 50953.2 51134.5 1073.0 1212.7 1234.9 1245.5 1258.2 27768.7 29164.9 29285.7 29390.6 29681.0 41134.2 41676.4 41676.6 41697.6 41712.4 276526.0 279371.0 280451.0 282234.0 284332.0 32296.2 36635.0 37776.6 39024.8 41119.0 41740.0 42307.6 42770.0 42797.8 43157.6 36448.9 36572.3 36807.8 36881.0 37099.3 35862.6 35949.5 36168.5 36201.5 36224.6 35412.8 35512.8 36100.8 36359.8 36432.3 31625.8 32028.0 32110.8 33220.8 33809.0 25758.0 25815.2 25974.5 26065.7 26383.2 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#2] jquery.html Cycles:180 Average:22890.50 Median:29230.84 stddev:61691.64 (211.0%) stddev-sans-first:61841.53 07:01:03 INFO - PROCESS | 27222 | Values: 370.5 381.8 387.7 396.2 397.6 15498.3 16696.1 17347.6 17496.7 17507.1 15508.1 16128.7 16985.9 17011.7 17078.7 4554.5 4745.5 4759.3 4763.7 4775.3 3395.2 3559.5 5128.6 5395.0 5416.8 5449.0 5465.8 5474.9 5489.6 5491.8 5498.8 5899.7 5910.2 5916.1 5917.8 4630.2 5196.0 5242.6 5248.2 5252.5 11982.3 12081.2 12198.4 12209.7 12211.2 1832.1 1848.4 1852.2 1933.3 2050.1 8840.9 8939.5 9034.0 9127.2 9150.9 1653.7 1657.9 1662.2 1675.7 1705.5 65419.3 66098.0 66748.7 66900.7 67687.7 9978.4 10088.2 10343.9 10474.9 11030.5 14000.7 14094.3 14114.7 14189.6 14189.9 6973.4 7183.0 7222.6 7292.5 7319.4 6493.9 6525.2 6607.5 6642.6 6719.9 4357.3 4419.4 4420.3 4458.3 4526.3 1659.8 1739.8 1745.8 1818.3 1824.0 708.3 819.7 829.8 841.2 849.3 15822.1 16331.3 16674.8 16815.0 17215.2 834.3 837.4 851.7 866.2 875.3 9374.1 9389.6 9541.0 9561.1 9671.3 371935.0 373275.0 374252.0 375928.0 375996.0 67431.7 69310.3 69695.0 70322.0 71561.0 866.4 925.7 957.9 990.3 1002.1 15180.8 15431.8 15621.1 15695.4 15987.7 25773.5 27329.0 28753.9 30061.0 32956.8 44124.3 44970.8 45553.5 53209.2 53405.5 7312.9 7490.1 7602.3 7632.2 7738.6 10713.9 10793.1 10831.8 11150.9 11444.6 6090.6 8429.1 8961.1 9195.9 9351.4 9388.9 9574.4 9697.1 9697.4 9799.4 8957.2 9621.7 9642.4 9772.1 9953.3 7622.4 7632.2 7678.6 7729.0 7812.1 8367.4 9506.5 9628.6 9764.8 9770.3 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#3] mootools.html Cycles:180 Average:5181.99 Median:5266.30 stddev:2891.81 (54.9%) stddev-sans-first:2884.16 07:01:03 INFO - PROCESS | 27222 | Values: 1164.2 1399.5 1452.7 1539.9 1742.7 6754.3 7660.2 7855.0 7860.5 8071.6 7807.1 7977.3 7993.5 7993.6 7994.0 1915.7 2198.6 2212.8 2247.9 2263.8 2216.7 2236.2 2237.8 2238.6 2239.2 2210.3 2222.9 2225.7 2243.4 2247.9 1859.7 1924.5 1925.9 2093.6 2157.8 2127.8 2158.9 2163.0 2163.7 2169.2 7862.5 7884.9 7895.9 7904.5 7904.5 4418.1 4504.0 4505.2 4505.7 4507.0 2884.9 2909.1 2975.5 3062.5 3084.4 912.6 948.0 949.0 952.1 961.9 10190.4 10208.6 10218.6 10221.5 10223.9 4262.6 4272.8 4380.5 4399.6 4402.0 8749.5 8779.3 8783.3 8784.0 8786.6 4789.4 4797.4 4800.3 4802.2 4803.3 3838.5 4277.1 4424.6 4428.3 4451.2 3704.4 3720.2 3765.9 3812.4 3853.7 1207.2 1227.7 1234.6 1247.1 1250.2 796.5 810.7 871.7 873.1 916.3 5243.7 5365.1 5402.8 5466.1 5495.9 408.3 417.5 418.3 419.8 421.9 3677.4 3744.7 3758.9 3768.5 3796.6 9553.7 9737.2 9933.6 9950.4 9960.2 9668.4 9750.4 9760.2 9769.0 9769.2 7319.9 7417.7 7484.4 7486.0 7547.1 5288.9 5337.4 5346.8 5363.1 5374.3 8589.9 8842.2 8845.8 9002.5 9102.7 9024.8 9135.2 9139.5 9211.7 9391.3 6104.5 6165.2 6628.4 6932.4 7094.7 7489.4 7694.7 7773.7 7778.0 7778.9 6841.9 6949.2 6969.5 7003.9 7169.2 6907.2 6936.3 6957.9 6994.3 7056.8 6194.8 6378.0 6399.2 6412.1 6481.4 4704.4 4721.9 4739.9 4758.2 4791.3 4726.5 4758.5 4799.3 4818.2 4871.8 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#4] prototype.html Cycles:180 Average:4078.95 Median:4595.67 stddev:1201.77 (26.2%) stddev-sans-first:1171.03 07:01:03 INFO - PROCESS | 27222 | Values: 291.1 298.8 301.3 307.7 311.4 4695.6 4704.5 4756.4 4760.9 4779.9 4653.3 4664.8 4684.7 4714.1 4723.7 3770.0 3772.4 3780.8 3796.4 3797.1 3554.8 3564.6 3809.7 3823.4 3828.8 3250.2 3597.5 3604.0 3613.7 3698.2 3584.8 3703.5 3705.4 3721.7 3736.8 3240.9 3242.7 3250.4 3252.2 3285.5 4366.2 4413.4 4565.8 4592.6 4603.5 4210.8 4211.7 4214.5 4222.0 4224.1 5009.2 5024.6 5027.3 5029.0 5046.5 3469.2 3529.5 3555.6 3559.4 3564.4 5181.9 5197.9 5198.2 5208.7 5209.7 3600.2 3604.7 3606.7 3613.2 3617.4 3594.0 3646.2 3653.9 3669.2 3688.3 4072.4 4141.0 4144.8 4157.7 4173.9 4847.5 4900.7 4905.9 4913.7 4918.3 1249.6 1269.2 1276.9 1284.4 1287.1 796.6 814.3 828.2 833.9 836.4 3949.5 3976.7 4042.3 4046.7 4052.7 4570.3 4579.7 4598.7 4628.3 4642.0 3946.2 4014.9 4039.7 4056.2 4067.2 2323.7 2476.9 2478.4 2478.5 2485.4 4309.7 4337.8 4369.6 4389.3 4429.5 5053.2 5074.9 5211.2 5234.9 5251.5 4872.5 4873.3 4885.2 4886.8 4896.8 4889.9 5152.5 5176.2 5176.5 5177.9 5037.1 5047.0 5068.4 5080.9 5095.8 4854.7 4879.2 4890.9 4895.6 4903.5 3578.2 3624.0 3624.1 3628.3 3630.9 4943.2 5098.8 5162.2 5169.3 5170.6 4966.5 4977.2 4988.7 5000.8 5038.3 5011.7 5012.8 5015.2 5020.8 5028.6 4696.8 4969.6 4985.0 5015.9 5034.6 4998.2 5065.5 5070.6 5074.2 5102.2 4719.9 4941.9 4970.8 4993.1 5009.3 07:01:03 INFO - PROCESS | 27222 | 07:01:03 INFO - PROCESS | 27222 | [#5] yui.html Cycles:180 Average:13324.72 Median:26456.69 stddev:16118.54 (60.9%) stddev-sans-first:16135.98 07:01:03 INFO - PROCESS | 27222 | Values: 724.4 726.9 727.6 734.4 753.2 10928.3 11266.0 11266.1 11296.7 11307.2 11659.8 11695.1 11712.5 11726.2 11727.2 623.6 779.9 793.4 801.9 802.8 784.5 788.7 791.8 792.2 792.5 655.5 852.4 852.9 854.2 854.3 822.4 841.9 842.9 844.4 844.6 619.9 620.2 620.2 620.5 620.6 11805.7 11836.5 11836.9 11861.3 11875.2 11765.8 11778.7 12154.8 12213.3 12321.8 9915.7 10142.2 10271.3 10484.0 10587.4 3922.2 3946.9 3973.0 4020.6 4068.4 44675.0 44755.3 44761.0 44924.1 46641.8 9365.0 9525.9 9540.4 9548.0 9573.8 16662.5 16704.6 16705.3 16713.7 16729.4 6675.1 6716.6 6787.8 6872.3 6937.9 3550.8 3587.4 3609.1 3634.0 3653.3 2750.3 2812.0 2829.1 2830.1 2833.0 471.1 504.6 515.8 524.9 549.4 529.9 533.3 537.3 567.2 577.7 7849.4 8006.3 8042.6 8121.7 8350.5 574.1 594.0 596.9 598.4 603.6 3772.7 3793.5 3894.7 3895.3 3916.5 58395.0 59454.0 60090.1 60186.1 60255.4 52204.0 52388.5 53122.7 53415.7 54149.0 48264.0 48949.5 49228.5 49789.3 49819.3 7512.1 7530.8 7555.9 7580.2 7630.4 31885.0 32027.8 32495.5 33053.8 33254.7 39825.8 43016.1 43060.4 43386.8 43633.1 9606.9 9639.0 9687.7 9795.7 9806.0 8622.9 9494.3 9640.7 10337.7 10502.8 8073.3 9769.3 10103.5 10188.5 10815.9 10885.6 11064.3 11324.7 11783.3 11821.0 11103.6 11106.4 11625.4 11723.8 11750.6 8953.1 9082.2 9276.0 9304.6 9706.3 9749.6 9888.9 9913.2 10075.5 10089.2 07:01:03 INFO - PROCESS | 27222 | -------- Summary: end -------- 07:01:03 INFO - PROCESS | 27222 | 07:01:04 INFO - TEST-INFO | 27222: exit 0 07:01:04 INFO - TEST-OK | dromaeo_css | took 1119373ms 07:01:04 INFO - TEST-START | kraken 07:01:04 INFO - operating with platform_type : linux_ 07:01:04 INFO - Initialising browser for kraken test... 07:01:04 INFO - TEST-INFO | started process 27402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vwS83/profile http://localhost:38194/getInfo.html) 07:01:08 INFO - PROCESS | 27402 | __metrics Screen width/height:1600/1200 07:01:08 INFO - PROCESS | 27402 | colorDepth:24 07:01:08 INFO - PROCESS | 27402 | Browser inner width/height: 1024/697 07:01:08 INFO - PROCESS | 27402 | __metrics 07:01:10 ERROR - PROCESS | 27402 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:01:10 INFO - TEST-INFO | 27402: exit 0 07:01:10 INFO - Browser initialized. 07:01:10 INFO - Running cycle 1/1 for kraken test... 07:01:10 INFO - TEST-INFO | started process 27482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vwS83/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:22 INFO - PROCESS | 27482 | RSS: Main: 157134848 07:01:22 INFO - PROCESS | 27482 | 07:01:25 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:26 INFO - PROCESS | 27482 | RSS: Main: 214892544 07:01:26 INFO - PROCESS | 27482 | 07:01:29 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-dft) 07:01:29 INFO - PROCESS | 27482 | RSS: Main: 203243520 07:01:29 INFO - PROCESS | 27482 | 07:01:33 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-fft) 07:01:33 INFO - PROCESS | 27482 | RSS: Main: 269713408 07:01:33 INFO - PROCESS | 27482 | 07:01:35 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-oscillator) 07:01:36 INFO - PROCESS | 27482 | RSS: Main: 180064256 07:01:36 INFO - PROCESS | 27482 | 07:01:38 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:39 INFO - PROCESS | 27482 | RSS: Main: 184152064 07:01:39 INFO - PROCESS | 27482 | 07:01:42 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:43 INFO - PROCESS | 27482 | RSS: Main: 220131328 07:01:43 INFO - PROCESS | 27482 | 07:01:46 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-desaturate) 07:01:47 INFO - PROCESS | 27482 | RSS: Main: 216088576 07:01:47 INFO - PROCESS | 27482 | 07:01:50 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38194/tests/kraken/driver.html?testName=json-parse-financial) 07:01:50 INFO - PROCESS | 27482 | RSS: Main: 218836992 07:01:50 INFO - PROCESS | 27482 | 07:01:52 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:53 INFO - PROCESS | 27482 | RSS: Main: 207790080 07:01:53 INFO - PROCESS | 27482 | 07:01:54 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:55 INFO - PROCESS | 27482 | RSS: Main: 211726336 07:01:55 INFO - PROCESS | 27482 | 07:01:57 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:58 INFO - PROCESS | 27482 | RSS: Main: 217260032 07:01:58 INFO - PROCESS | 27482 | 07:02:01 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:01 INFO - PROCESS | 27482 | RSS: Main: 221138944 07:02:01 INFO - PROCESS | 27482 | 07:02:04 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:05 INFO - PROCESS | 27482 | RSS: Main: 221777920 07:02:05 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38194/tests/kraken/driver.html?testName=ai-astar) 07:02:07 INFO - PROCESS | 27482 | RSS: Main: 264687616 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | __start_tp_report 07:02:07 INFO - PROCESS | 27482 | _x_x_mozilla_page_load 07:02:07 INFO - PROCESS | 27482 | _x_x_mozilla_page_load_details 07:02:07 INFO - PROCESS | 27482 | |i|pagename|runs| 07:02:07 INFO - PROCESS | 27482 | |0;ai-astar;114;110;114;115;113;114;113;113;114;113 07:02:07 INFO - PROCESS | 27482 | |1;audio-beat-detection;161;129;130;188;130;131;165;129;179;129 07:02:07 INFO - PROCESS | 27482 | |2;audio-dft;162;163;161;162;160;163;162;161;161;162 07:02:07 INFO - PROCESS | 27482 | |3;audio-fft;75;75;76;123;78;77;76;76;101;76 07:02:07 INFO - PROCESS | 27482 | |4;audio-oscillator;85;84;113;84;85;84;123;94;84;128 07:02:07 INFO - PROCESS | 27482 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;119;117 07:02:07 INFO - PROCESS | 27482 | |6;imaging-darkroom;147;148;147;146;147;146;146;146;147;149 07:02:07 INFO - PROCESS | 27482 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;95 07:02:07 INFO - PROCESS | 27482 | |8;json-parse-financial;63;62;68;63;63;63;65;63;62;64 07:02:07 INFO - PROCESS | 27482 | |9;json-stringify-tinderbox;64;65;65;66;66;64;65;66;65;65 07:02:07 INFO - PROCESS | 27482 | |10;stanford-crypto-aes;81;81;83;83;83;90;84;83;116;82 07:02:07 INFO - PROCESS | 27482 | |11;stanford-crypto-ccm;146;140;144;128;128;138;130;132;140;134 07:02:07 INFO - PROCESS | 27482 | |12;stanford-crypto-pbkdf2;173;171;171;171;168;170;170;170;170;169 07:02:07 INFO - PROCESS | 27482 | |13;stanford-crypto-sha256-iterative;69;67;66;66;65;65;67;65;66;65 07:02:07 INFO - PROCESS | 27482 | __end_tp_report 07:02:07 INFO - PROCESS | 27482 | __start_cc_report 07:02:07 INFO - PROCESS | 27482 | _x_x_mozilla_cycle_collect,1921 07:02:07 INFO - PROCESS | 27482 | __end_cc_report 07:02:07 INFO - PROCESS | 27482 | __startTimestamp1464444127349__endTimestamp 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | ------- Summary: start ------- 07:02:07 INFO - PROCESS | 27482 | Number of tests: 14 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 07:02:07 INFO - PROCESS | 27482 | Values: 114.0 110.0 114.0 115.0 113.0 114.0 113.0 113.0 114.0 113.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:146.00 stddev:23.64 (16.2%) stddev-sans-first:24.54 07:02:07 INFO - PROCESS | 27482 | Values: 161.0 129.0 130.0 188.0 130.0 131.0 165.0 129.0 179.0 129.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:02:07 INFO - PROCESS | 27482 | Values: 162.0 163.0 161.0 162.0 160.0 163.0 162.0 161.0 161.0 162.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.01 (21.1%) stddev-sans-first:16.70 07:02:07 INFO - PROCESS | 27482 | Values: 75.0 75.0 76.0 123.0 78.0 77.0 76.0 76.0 101.0 76.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:17.83 (21.2%) stddev-sans-first:18.43 07:02:07 INFO - PROCESS | 27482 | Values: 85.0 84.0 113.0 84.0 85.0 84.0 123.0 94.0 84.0 128.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:02:07 INFO - PROCESS | 27482 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 119.0 117.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 07:02:07 INFO - PROCESS | 27482 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 149.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:02:07 INFO - PROCESS | 27482 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 07:02:07 INFO - PROCESS | 27482 | Values: 63.0 62.0 68.0 63.0 63.0 63.0 65.0 63.0 62.0 64.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 07:02:07 INFO - PROCESS | 27482 | Values: 64.0 65.0 65.0 66.0 66.0 64.0 65.0 66.0 65.0 65.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:83.00 stddev:10.64 (12.8%) stddev-sans-first:11.09 07:02:07 INFO - PROCESS | 27482 | Values: 81.0 81.0 83.0 83.0 83.0 90.0 84.0 83.0 116.0 82.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:139.00 stddev:6.53 (4.7%) stddev-sans-first:5.84 07:02:07 INFO - PROCESS | 27482 | Values: 146.0 140.0 144.0 128.0 128.0 138.0 130.0 132.0 140.0 134.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:1.34 (0.8%) stddev-sans-first:1.00 07:02:07 INFO - PROCESS | 27482 | Values: 173.0 171.0 171.0 171.0 168.0 170.0 170.0 170.0 170.0 169.0 07:02:07 INFO - PROCESS | 27482 | 07:02:07 INFO - PROCESS | 27482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:0.83 07:02:07 INFO - PROCESS | 27482 | Values: 69.0 67.0 66.0 66.0 65.0 65.0 67.0 65.0 66.0 65.0 07:02:07 INFO - PROCESS | 27482 | -------- Summary: end -------- 07:02:07 INFO - PROCESS | 27482 | 07:02:08 INFO - TEST-INFO | 27482: exit 0 07:02:08 INFO - TEST-OK | kraken | took 63733ms 07:02:08 INFO - SUITE-END | took 1183s 07:02:08 INFO - Completed test suite (00:19:43) 07:02:08 INFO - javascript benchmark 07:02:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.535806233911, 2674.010616072053, 2710.2004908551967, 2720.238333266686, 2732.030129304097, 4603.7237765734, 4656.534346565346, 4715.669903106779, 4737.313089602006, 4739.573438390544, 4728.9763551182195, 4744.69159504632, 4762.833300834472, 4825.2279635258365, 4829.9275510867365, 4302.913941721164, 4353.477582690066, 4382.824687012531, 4421.425214722081, 4503.909921801562, 4409.184300904327, 4459.777011149446, 4476.350929115276, 4483.484399294074, 4502.347159661847, 4297.484301883778, 4337.869863904088, 4357.760323182224, 4364.541723119059, 4381.9342709859375, 4383.145286669101, 4383.75889326087, 4393.099414620027, 4418.182636212311, 4434.866953991385, 4399.274119770266, 4416.40378548895, 4424.070945101533, 4473.127740090684, 4474.127545128701, 4619.630429565626, 4693.413323334583, 4711.670183087185, 4752.263399173134, 4762.452317983441, 5156.381234251914, 5232.790688372461, 5243.4232234454175, 5256.290400795881, 5258.605604579634, 5217.217417387385, 5246.317978662788, 5259.053370393328, 5261.921071183935, 5265.842024739264, 4700.03649251906, 4732.645051621143, 4788.281757736368, 4789.473157952622, 4852.8544143675745, 5257.132573125468, 5295.814646487354, 5295.947040529545, 5298.655587386807, 5299.046171689056, 4902.926456103161, 5040.092783299041, 5087.847364579068, 5088.516590923857, 5093.057784309841, 5076.0, 5136.178211486144, 5138.768755406016, 5143.7685304161405, 5167.638265321391, 5083.415407228142, 5094.439611642716, 5100.846974590768, 5103.336566246364, 5149.7940082397035, 4906.656534042654, 5016.573591244785, 5046.621503387188, 5065.696058236517, 5071.771770270347, 4299.269124248885, 4311.07311927937, 4331.068820203672, 4373.343998400202, 4378.255696531533, 3765.9246815063543, 3780.8865734028022, 3799.7910114943393, 3824.9617503824607, 3849.191669749328, 4338.457692788402, 4401.889952751207, 4415.757133357632, 4417.050334178167, 4424.269995450714, 5115.462876397999, 5116.155834287301, 5167.431582525919, 5173.094708426011, 5193.818216362409, 4415.580519850673, 4424.424824772759, 4425.911481770347, 4473.060657262012, 4475.26158183896, 4461.196984542748, 4554.977225113853, 4587.77061146948, 4606.838760643362, 4633.930491042637, 4849.466558678472, 4862.927056094232, 4872.9269060964825, 4919.975400123048, 4922.65541412112, 5174.767135478988, 5188.143956247328, 5188.351456067991, 5188.481151884932, 5194.97402512985, 4737.0, 4793.0, 4831.806727730851, 4831.9275210872565, 4859.805607775649, 5067.315912351785, 5090.261912022662, 5091.745412729423, 5097.949020509747, 5113.233015047773, 5172.793088276427, 5174.7930082796265, 5184.844454666366, 5185.144451165515, 5186.196139598368, 4872.6832755870755, 4915.090708218991, 4957.454679985127, 4965.677230979974, 4983.202687569971, 4954.900901981868, 4983.700977941335, 4988.401391833003, 4991.450940396626, 5035.370578677665, 4846.95153048465, 4928.778204980857, 4933.457319694902, 4940.752962351796, 4980.900381992412, 4959.900801984012, 4993.375828021497, 5005.399352077774, 5008.6243531734535, 5018.272350509083, 4901.803927842846, 4902.3872015998, 4906.55840974314, 4906.8773280668265, 4959.181735013826], "value": 4707.257044397424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4613755345082, 585.5227989188811, 592.3010847200304, 617.5337620096827, 621.0280910375266, 39504.0, 40981.180376392454, 41006.38490422646, 44272.77863610678, 44403.0, 41366.0, 41545.16909661813, 41834.0, 41867.16265674685, 41983.58016419835, 7728.07263128424, 7909.564973926432, 7911.367090632735, 7924.603769811515, 7943.086545047307, 7768.922310776877, 7858.214178582153, 7860.410469214832, 7861.449698521106, 7863.370930325589, 7831.647575859071, 7883.724069657563, 7888.842223155533, 7891.921080789176, 7897.052353717533, 7845.293923546879, 7893.486923349992, 7897.8025549361155, 7902.446828721992, 7907.367410607195, 7626.2755038271835, 7689.9615501922135, 7696.576688282143, 7709.653065612061, 7712.884306735404, 38559.228815423536, 38883.0, 38983.41524877101, 39007.41488877641, 39022.0, 2942.955855662167, 2969.584258203853, 3337.566116404876, 3834.3673293906472, 3866.0, 27567.172984810488, 28442.573361399594, 29597.852010740025, 30078.24804379886, 30138.69861301381, 3344.715699165574, 3347.933041339184, 3348.430766769655, 3358.412277851366, 3364.8990530283886, 257022.0, 263157.0, 263315.0, 263819.6809015962, 263991.0, 49240.0, 50794.74602626963, 56165.71917140388, 57676.71161644249, 58405.41594584085, 55544.72227638917, 55728.0, 56118.43881561132, 56152.15771763427, 56231.15653265204, 14161.85838141626, 14262.85737142636, 14361.281935903164, 14373.425062997572, 14386.35261413239, 9679.70960871175, 9987.550560224807, 10762.869898660685, 10858.511366988505, 10858.837117443245, 16703.749443758352, 18644.551929009427, 20185.394438166877, 20316.28892988738, 20419.08114134838, 7513.962430187814, 7535.886961695579, 7564.583947882809, 7648.847023059508, 7739.1873853245725, 814.3281792521075, 847.3306088190384, 929.0570071377557, 984.8227319082633, 1017.1049476460815, 27508.724912751015, 27894.0, 28389.57415638767, 28538.571921421197, 28680.0, 956.880509671068, 993.339429279521, 994.2791476179711, 1058.8094143054325, 1068.8663917010374, 14819.40722371093, 15093.39626414931, 15296.182186194335, 15456.304466299043, 15498.0, 373809.0, 374443.0, 378173.0, 378605.0, 379344.0, 50269.74865125651, 50831.0, 50917.74541127345, 50953.23570146451, 51134.48865511372, 1072.9570817167382, 1212.7453234820787, 1234.9135560510858, 1245.5204746172608, 1258.2450529682117, 27768.722312776612, 29164.854175729834, 29285.7071429283, 29390.559141612466, 29681.0, 41134.17731645291, 41676.37485437781, 41676.58323416727, 41697.58302416937, 41712.3743143847, 276526.0, 279371.0, 280451.0, 282234.0, 284332.0, 32296.19259518437, 36635.0, 37776.62223377841, 39024.80487597544, 41119.0, 41740.0, 42307.576924231595, 42770.0, 42797.786011069744, 43157.56842431661, 36448.901843343614, 36572.26855462929, 36807.81596092002, 36881.0, 37099.25801483901, 35862.64137358697, 35949.460758089175, 36168.457473137394, 36201.45697814588, 36224.63775362318, 35412.822935886186, 35512.822435887654, 36100.8194959034, 36359.81820090883, 36432.27135457223, 31625.8418707905, 32028.0, 32110.839445803555, 33220.833895830365, 33809.0, 25758.0, 25815.225543233733, 25974.48051038931, 26065.73934260633, 26383.208503744918], "value": 17954.693769502905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5016752467931, 381.7766606535177, 387.703133020048, 396.24910794045303, 397.60438363827996, 15498.302576384061, 16696.081715505643, 17347.566310842234, 17496.650066998653, 17507.124643767824, 15508.14705191214, 16128.677426451464, 16985.91507042466, 17011.744823827652, 17078.743818842697, 4554.476235232949, 4745.477997420281, 4759.333693282943, 4763.690360126598, 4775.331453596482, 3395.2021275000357, 3559.4660800879947, 5128.5897128229835, 5395.0, 5416.783328666848, 5449.01917654822, 5465.808696695616, 5474.863128421782, 5489.58828087893, 5491.752871120789, 5498.752556134984, 5899.705014749288, 5910.172575839364, 5916.1421593868645, 5917.792877249297, 4630.236011058171, 5195.974020129913, 5242.580593552545, 5248.160294352885, 5252.474752524717, 11982.340971246578, 12081.15431919766, 12198.39008049594, 12209.694757631041, 12211.206271592318, 1832.0748022248679, 1848.3530764232546, 1852.1850385830326, 1933.2846846666682, 2050.064311863071, 8840.911590884074, 8939.463632182089, 9034.0, 9127.17855393011, 9150.908490915139, 1653.7023335799552, 1657.892237004591, 1662.2187571841216, 1675.748637704342, 1705.505403433003, 65419.3458065418, 66098.0, 66748.66625666841, 66900.6654966722, 67687.66156169237, 9978.401295922267, 10088.243381746399, 10343.94828025855, 10474.947625261824, 11030.50362733679, 14000.689886168668, 14094.295285235698, 14114.717705646035, 14189.645258868612, 14189.929050354682, 6973.4072603829245, 7183.0, 7222.602756848424, 7292.489525733148, 7319.377852882564, 6493.902591461132, 6525.184351956005, 6607.471402287805, 6642.6014439133805, 6719.932800671931, 4357.2592659248, 4419.359192917009, 4420.270655341833, 4458.308962110878, 4526.275795872711, 1659.7593348964574, 1739.7734597109009, 1745.7992330882112, 1818.3181307009872, 1823.972640410395, 708.348319546019, 819.6885183630183, 829.8423299573062, 841.2050612171562, 849.2865992566274, 15822.129782862054, 16331.346746130259, 16674.83325166757, 16815.0, 17215.22531486061, 834.3450391442689, 837.4054421360902, 851.6678495386805, 866.1987661413168, 875.3391189651772, 9374.109459601326, 9389.62441502346, 9541.0, 9561.091696288842, 9671.323007389556, 371935.0, 373275.0, 374252.0, 375928.0, 375996.0, 67431.66284168646, 69310.30689693039, 69695.0, 70322.0, 71561.0, 866.445474896067, 925.7269105613725, 957.9329446938648, 990.2968892086699, 1002.1231422505308, 15180.848191517944, 15431.768523471932, 15621.062736235863, 15695.351988041548, 15987.680246395239, 25773.484530309663, 27329.043483477984, 28753.856230718713, 30061.0, 32956.83521582377, 44124.33813492736, 44970.77514612406, 45553.54446455493, 53209.20186197288, 53405.4659453416, 7312.890306645511, 7490.101187857492, 7602.315791578784, 7632.160462349026, 7738.574378409242, 10713.946430267799, 10793.136549075898, 10831.783364332512, 11150.888491114985, 11444.607003580171, 6090.604110732788, 8429.114942930904, 8961.059088795582, 9195.862062069207, 9351.39215950961, 9388.906110939077, 9574.425534467955, 9697.127258546765, 9697.369670971364, 9799.412035277906, 8957.193852553302, 9621.663241786504, 9642.373245739005, 9772.12050915421, 9953.303268771117, 7622.390208783395, 7632.236776322324, 7678.61606919663, 7729.0, 7812.062552493509, 8367.372447066617, 9506.524673766422, 9628.614855405986, 9764.804703906024, 9770.31607787448], "value": 7802.680445935273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1164.243241892769, 1399.5381524097045, 1452.7312447197269, 1539.899906506077, 1742.6688929103477, 6754.257031726506, 7660.195679453661, 7855.0, 7860.489068210577, 8071.556064416454, 7807.141214466418, 7977.282044615983, 7993.480423772466, 7993.600319983992, 7994.04071511418, 1915.6839121544929, 2198.6152423325934, 2212.8493183544547, 2247.910083596654, 2263.7962583367494, 2216.745074316458, 2236.183792915582, 2237.798598126168, 2238.6418173092306, 2239.1826983151113, 2210.3368989303144, 2222.866628002325, 2225.6772767948637, 2243.383069655841, 2247.9438014049697, 1859.655963646723, 1924.5477312831474, 1925.9037048147536, 2093.6440805063025, 2157.838162137838, 2127.7659457459667, 2158.946026349338, 2163.0, 2163.729533808274, 2169.2190811307914, 7862.488938218998, 7884.881726774103, 7895.921040789576, 7904.486208396436, 7904.486208396436, 4418.072204836988, 4503.977480112611, 4505.166544189336, 4505.684602077856, 4506.977465112686, 2884.927876803076, 2909.0836386538385, 2975.4941659917868, 3062.4793785056595, 3084.4447999360104, 912.5619702542816, 947.9810403791886, 948.9572969216401, 952.1335584618033, 961.9470929098896, 10190.439525826077, 10208.642697505551, 10218.591256349737, 10221.540030698636, 10223.897761022368, 4262.616364527207, 4272.829086836492, 4380.452443444569, 4399.6040356368085, 4402.0095478517715, 8749.47503149813, 8779.253763430052, 8783.297336213087, 8784.0, 8786.560671966376, 4789.377380940456, 4797.4482934462985, 4800.255960326155, 4802.183628783116, 4803.255495398219, 3838.4626152338697, 4277.101808620225, 4424.601785839225, 4428.2914733642465, 4451.243288640939, 3704.3517384457614, 3720.2001569662652, 3765.9435108473394, 3812.370958791824, 3853.7302388833073, 1207.1549915059493, 1227.6623928419756, 1234.6234398508361, 1247.1394737631188, 1250.1623911978995, 796.4942261663886, 810.7243537197381, 871.7428358634218, 873.057098333798, 916.2852974679761, 5243.711595862264, 5365.141577347606, 5402.8109016185035, 5466.098093814476, 5495.945040549544, 408.2610475040187, 417.5135966598939, 418.26594326955995, 419.83626385709596, 421.9472565929259, 3677.42999835026, 3744.681702055356, 3758.9436158457647, 3768.5289338832645, 3796.563395209531, 9553.665621703347, 9737.172340351008, 9933.602655893828, 9950.35322704022, 9960.153386962045, 9668.419894806193, 9750.366226195274, 9760.219182465527, 9769.0, 9769.16962058233, 7319.890201646979, 7417.740379086706, 7484.363829074481, 7485.962570187115, 7547.0943486781935, 5288.894222115613, 5337.359516858002, 5346.786128554814, 5363.088274993339, 5374.328208973879, 8589.8711519326, 8842.248408885316, 8845.778855528662, 9002.459852408876, 9102.726918192464, 9024.774380640536, 9135.177833994972, 9139.543022848698, 9211.677591284273, 9391.342606017513, 6104.511639068953, 6165.229346331708, 6628.403443690091, 6932.44540436774, 7094.716211351488, 7489.400847932044, 7694.692212311445, 7773.650185741542, 7778.0, 7778.88331675014, 6841.863162736817, 6949.166100068024, 6969.477289203229, 7003.859922801414, 7169.247229040876, 6907.205671347659, 6936.34104760047, 6957.930420695729, 6994.300569942965, 7056.7530136444975, 6194.845128871814, 6378.0, 6399.200099987502, 6412.134361861089, 6481.384268494486, 4704.435467743892, 4721.929171062368, 4739.857804265877, 4758.1911075118005, 4791.257355109963, 4726.527347265246, 4758.547937945889, 4799.328094066764, 4818.156822556109, 4871.80512779499], "value": 4107.76515791701, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.0685805422647, 298.82070757545466, 301.32352867811767, 307.6923076923077, 311.4409634705703, 4695.6478264130155, 4704.4589872164715, 4756.357891684622, 4760.90478190436, 4779.90440191196, 4653.255479123341, 4664.790084446199, 4684.672072954894, 4714.127886341029, 4723.7165770053825, 3769.9623003769952, 3772.3964165733487, 3780.754250973692, 3796.3735983562815, 3797.1076796952693, 3554.822258887058, 3564.625714299987, 3809.733318667694, 3823.3882578787398, 3828.8085595720104, 3250.2361944943036, 3597.478365636981, 3603.981980090096, 3613.674769270778, 3698.223373091654, 3584.8386822592915, 3703.5370578677666, 3705.4256590228556, 3721.6650501454865, 3736.831842567091, 3240.8703651854134, 3242.6919442653148, 3250.431174544445, 3252.2032102135126, 3285.474324108155, 4366.170427618774, 4413.426254586883, 4565.817367305303, 4592.645169674954, 4603.503861245109, 4210.789460526961, 4211.7262377945335, 4214.452121224252, 4222.007828160411, 4224.070704445017, 5009.173486374744, 5024.572911302544, 5027.296178535008, 5029.0, 5046.495350464961, 3469.2367679110557, 3529.523514325559, 3555.6444355564236, 3559.394902866519, 3564.4475106358555, 5181.885894532656, 5197.948020519784, 5198.194279886624, 5208.687478751287, 5209.739513024334, 3600.2259514204047, 3604.6575575320303, 3606.711463082947, 3613.2412193439673, 3617.366960781853, 3593.9820300898327, 3646.2342907989087, 3653.8721144759807, 3669.229461813049, 3688.3176612326806, 4072.429859819628, 4141.006158521933, 4144.834206631761, 4157.667386609064, 4173.895652608649, 4847.466778654345, 4900.730459824744, 4905.9264111038365, 4913.746994516376, 4918.286848407032, 1249.6001279590444, 1269.1623528471164, 1276.889106477352, 1284.3514025417105, 1287.1247551664958, 796.5857753967904, 814.2956342763467, 828.1635548096345, 833.9207775261341, 836.4354061008795, 3949.4865667463046, 3976.681865450757, 4042.3224361890075, 4046.6964977626794, 4052.675785937118, 4570.291604801261, 4579.656525760582, 4598.701084429501, 4628.305754136839, 4642.0, 3946.2044769630324, 4014.892181604681, 4039.6768258539246, 4056.249593825152, 4067.2068946555137, 2323.744388117306, 2476.8885400157037, 2478.4175718706088, 2478.467129567152, 2485.3538080099306, 4309.664004158721, 4337.8264869404875, 4369.60673539383, 4389.3415987601475, 4429.453064487932, 5053.216751403538, 5074.949250507448, 5211.159917844784, 5234.92147617786, 5251.477071649256, 4872.537108974641, 4873.31773551703, 4885.193942999436, 4886.828960986349, 4896.755162241873, 4889.926651100165, 5152.536271735562, 5176.197689358156, 5176.456472070529, 5177.948220517897, 5037.0681423936685, 5047.041062198171, 5068.417132029716, 5080.898382032265, 5095.847124586268, 4854.73298968546, 4879.219324908139, 4890.926636100533, 4895.559399654048, 4903.534164254533, 3578.2306804036216, 3623.9818800905828, 3624.075860655516, 3628.346897558359, 3630.9455358170176, 4943.182386040066, 5098.796048158032, 5162.199859021857, 5169.276301317894, 5170.586353091669, 4966.528179822911, 4977.153883839828, 4988.700677959334, 5000.774965126505, 5038.319826823332, 5011.7494125294315, 5012.8496145115705, 5015.1975683890405, 5020.824271150492, 5028.572571331478, 4696.7886445110735, 4969.577585905238, 4984.975075124601, 5015.924761128659, 5034.647574669884, 4998.175301075282, 5065.544101030925, 5070.5943524517215, 5074.213496907985, 5102.2346648003095, 4719.921631489821, 4941.925871111865, 4970.776315065903, 4993.101241776515, 5009.323741294878], "value": 3700.6966856798063, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.4023680463617, 726.9164046134689, 727.6325455644899, 734.4088009152633, 753.1790348520112, 10928.289661172019, 11266.0, 11266.098712103032, 11296.717582060453, 11307.208495405315, 11659.825102623467, 11695.064394848412, 11712.472938717758, 11726.179167458282, 11727.17909746318, 623.6445226221056, 779.9142094369615, 793.4247670438914, 801.8556659801234, 802.7912742686885, 784.4940013691166, 788.727888878339, 791.8060075281535, 792.2315354106507, 792.4848848248656, 655.4788942790493, 852.4160949749441, 852.8635418333068, 854.2439940652537, 854.3080105114846, 822.3667775812621, 841.9326453883705, 842.8651415773509, 844.4173520270994, 844.5566077809137, 619.8915189841805, 620.2309136670541, 620.2464006232449, 620.4756980351596, 620.6307247187916, 11805.704857378549, 11836.526538938431, 11836.940815295955, 11861.347625880573, 11875.228110172811, 11765.823512647317, 11778.705532361759, 12154.817677734753, 12213.267203967791, 12321.815172772416, 9915.702528924145, 10142.239332050125, 10271.34004995089, 10484.032135577016, 10587.417692026935, 3922.2155568886337, 3946.881593552198, 3973.046468847485, 4020.618041286102, 4068.410080538335, 44675.0, 44755.328670069975, 44761.0, 44924.101517969786, 46641.766791166505, 9364.953175234217, 9525.857112143323, 9540.379875308083, 9548.0, 9573.808523829484, 16662.50012499627, 16704.582385440463, 16705.331786728395, 16713.665726685642, 16729.414470493473, 6675.0988616537115, 6716.597004179765, 6787.790914191784, 6872.347127022925, 6937.861242775116, 3550.786952782841, 3587.4260118380935, 3609.097725568608, 3634.0, 3653.287608916289, 2750.2574304937557, 2811.9859400702867, 2829.0946896992764, 2830.080223927232, 2833.0226072005125, 471.067286772193, 504.60388594952786, 515.8375111839758, 524.8976449592369, 549.409384911222, 529.8887233680894, 533.3067012883237, 537.2532180269428, 567.2427309541808, 577.6938222741869, 7849.411294152961, 8006.279434850891, 8042.557659328676, 8121.675132994732, 8350.498970061815, 574.1359254322218, 594.0435898203888, 596.931352894414, 598.4225222660153, 603.6257520337331, 3772.7170462215445, 3793.487879136281, 3894.7468414552964, 3895.25990061893, 3916.4908561886773, 58395.0, 59454.0, 60090.09864852031, 60186.097208541905, 60255.397446025854, 52204.0, 52388.47611523912, 53122.73438632859, 53415.73292133515, 54149.0, 48264.0, 48949.51050489521, 49228.50771492311, 49789.25316120189, 49819.25271120936, 7512.13610434807, 7530.774076777706, 7555.886661700189, 7580.241975802596, 7630.389568834591, 31885.0, 32027.83986080055, 32495.512567311984, 33053.84311549181, 33254.66745332516, 39825.80087099546, 43016.139677206906, 43060.35409468798, 43386.78306608447, 43633.127337453705, 9606.903930960601, 9639.0, 9687.70936871895, 9795.657151999645, 9806.0, 8622.913770862211, 9494.335396522178, 9640.71077867665, 10337.74155646115, 10502.842457362993, 8073.313768329523, 9769.31614786958, 10103.494825258855, 10188.490575471345, 10815.891841081488, 10885.619003334845, 11064.28082174656, 11324.716882078013, 11783.293002419883, 11821.0, 11103.611373601885, 11106.389148596905, 11625.360605166798, 11723.765524689628, 11750.58872939443, 8953.149450802164, 9082.228010619172, 9276.0, 9304.615017451704, 9706.320557560903, 9749.610015599581, 9888.909396559115, 9913.206943444651, 10075.546600403146, 10089.24330675217], "value": 5929.545049401447, "unit": "score"}], "name": "dromaeo_css", "value": 6247.29364922802, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 115.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 130.0, 188.0, 130.0, 131.0, 165.0, 129.0, 179.0, 129.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 160.0, 163.0, 162.0, 161.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 123.0, 78.0, 77.0, 76.0, 76.0, 101.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 84.0, 85.0, 84.0, 123.0, 94.0, 84.0, 128.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 149.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 68.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 83.0, 83.0, 90.0, 84.0, 83.0, 116.0, 82.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 140.0, 144.0, 128.0, 128.0, 138.0, 130.0, 132.0, 140.0, 134.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 171.0, 171.0, 168.0, 170.0, 170.0, 170.0, 170.0, 169.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1548.1999999999996, "alertThreshold": 2.0}]} 07:02:08 INFO - Return code: 0 07:02:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:02:08 ERROR - # TBPL SUCCESS # 07:02:08 INFO - Running post-action listener: _resource_record_post_action 07:02:08 INFO - ##### 07:02:08 INFO - ##### Finished run-tests step (success) 07:02:08 INFO - ##### 07:02:08 INFO - Running post-run listener: _resource_record_post_run 07:02:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 135168; Write bytes: 283123712; Read time: 20; Write time: 215728 07:02:08 INFO - TinderboxPrint: CPU usage
13.1% 07:02:08 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 20 07:02:08 INFO - TinderboxPrint: I/O write bytes / time
283,123,712 / 215,728 07:02:08 INFO - TinderboxPrint: CPU idle
8,320.8 (86.9%) 07:02:08 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 07:02:08 INFO - TinderboxPrint: Swap in / out
0 / 0 07:02:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1159168; Read time: 0; Write time: 48 07:02:08 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 135168; Write bytes: 279719936; Read time: 20; Write time: 215576 07:02:09 INFO - Running post-run listener: _upload_blobber_files 07:02:09 INFO - Blob upload gear active. 07:02:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:02:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:02:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:10 INFO - (blobuploader) - INFO - Done attempting. 07:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:15 INFO - (blobuploader) - INFO - Done attempting. 07:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:15 INFO - (blobuploader) - INFO - Done attempting. 07:02:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:15 INFO - Return code: 0 07:02:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbab0693e8c8c320df39d5942fd307f74660764b3b94f381039445da14ae47657b98122badfba2f5ffbe7b54b65205b68c618fe4546b32589860f198ad16cbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb596c7b7034b7e430c2bd6e48237787ce4c5ce9fe3d7d14d2a52fa22fd4038a31996815a5f5958bd71a1466e55be12dbd3b5e26f5071e455501613c6e0e9604", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15c70ccb46917e2c7e180850f305631e40fab30849eb80f20adf6e2d2feee98d210b4a185672bdc07da0fdc64370e642d37731571cbd9f3c259bb7b271284c32"} 07:02:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:15 INFO - Contents: 07:02:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbab0693e8c8c320df39d5942fd307f74660764b3b94f381039445da14ae47657b98122badfba2f5ffbe7b54b65205b68c618fe4546b32589860f198ad16cbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb596c7b7034b7e430c2bd6e48237787ce4c5ce9fe3d7d14d2a52fa22fd4038a31996815a5f5958bd71a1466e55be12dbd3b5e26f5071e455501613c6e0e9604", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15c70ccb46917e2c7e180850f305631e40fab30849eb80f20adf6e2d2feee98d210b4a185672bdc07da0fdc64370e642d37731571cbd9f3c259bb7b271284c32"} 07:02:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:15 INFO - Copying logs to upload dir... 07:02:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.853434 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-28 07:02:15.774123) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 07:02:15.778047) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbab0693e8c8c320df39d5942fd307f74660764b3b94f381039445da14ae47657b98122badfba2f5ffbe7b54b65205b68c618fe4546b32589860f198ad16cbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb596c7b7034b7e430c2bd6e48237787ce4c5ce9fe3d7d14d2a52fa22fd4038a31996815a5f5958bd71a1466e55be12dbd3b5e26f5071e455501613c6e0e9604", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15c70ccb46917e2c7e180850f305631e40fab30849eb80f20adf6e2d2feee98d210b4a185672bdc07da0fdc64370e642d37731571cbd9f3c259bb7b271284c32"} build_url:https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/fHcPXQ98RiSzSnL4lAvVHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbab0693e8c8c320df39d5942fd307f74660764b3b94f381039445da14ae47657b98122badfba2f5ffbe7b54b65205b68c618fe4546b32589860f198ad16cbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb596c7b7034b7e430c2bd6e48237787ce4c5ce9fe3d7d14d2a52fa22fd4038a31996815a5f5958bd71a1466e55be12dbd3b5e26f5071e455501613c6e0e9604", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15c70ccb46917e2c7e180850f305631e40fab30849eb80f20adf6e2d2feee98d210b4a185672bdc07da0fdc64370e642d37731571cbd9f3c259bb7b271284c32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 07:02:15.806282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:02:15.806964) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464442622.404030-82612683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:02:15.886787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 07:02:15.887155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 07:02:15.887523) ========= ========= Total master_lag: 0.17 =========