builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1464175375.9 results: success (0) buildid: 20160525013026 builduid: 1e8a787cba1c42eb818eb9caeedd5444 revision: 51b1f2343ad9544921e68859dfbe9d3c79b00951 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:55.898652) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:55.899065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:55.899340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:55.922594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:55.922865) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 04:22:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-05-25 04:22:56 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146565 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:56.185293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:56.188743) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:56.232503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 04:22:56.232858) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 51b1f2343ad9544921e68859dfbe9d3c79b00951 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 51b1f2343ad9544921e68859dfbe9d3c79b00951 --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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 04:22:56,743 truncating revision to first 12 chars 2016-05-25 04:22:56,743 Setting DEBUG logging. 2016-05-25 04:22:56,743 attempt 1/10 2016-05-25 04:22:56,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/51b1f2343ad9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 04:22:57,722 unpacking tar archive at: mozilla-inbound-51b1f2343ad9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249609 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 04:22:57.498170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:57.498714) ========= script_repo_revision: 51b1f2343ad9544921e68859dfbe9d3c79b00951 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:57.499344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:57.499811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:22:57.511140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-25 04:22:57.511768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:58 INFO - MultiFileLogger online at 20160525 04:22:58 in /builds/slave/test 04:22:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:22:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:58 INFO - {'append_to_log': False, 04:22:58 INFO - 'base_work_dir': '/builds/slave/test', 04:22:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:22:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:58 INFO - 'branch': 'Mozilla-Inbound', 04:22:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:58 INFO - 'config_files': ('talos/linux_config.py',), 04:22:58 INFO - 'default_actions': ('clobber', 04:22:58 INFO - 'read-buildbot-config', 04:22:58 INFO - 'download-and-extract', 04:22:58 INFO - 'populate-webroot', 04:22:58 INFO - 'create-virtualenv', 04:22:58 INFO - 'install', 04:22:58 INFO - 'run-tests'), 04:22:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:58 INFO - 'download_minidump_stackwalk': True, 04:22:58 INFO - 'download_symbols': 'ondemand', 04:22:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:58 INFO - 'installer_path': 'installer.exe', 04:22:58 INFO - 'log_level': 'info', 04:22:58 INFO - 'log_name': 'talos', 04:22:58 INFO - 'log_to_console': True, 04:22:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:58 INFO - 'opt_config_files': (), 04:22:58 INFO - 'pip_index': False, 04:22:58 INFO - 'sps_profile': False, 04:22:58 INFO - 'sps_profile_interval': 0, 04:22:58 INFO - 'suite': 'dromaeojs', 04:22:58 INFO - 'system_bits': '32', 04:22:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:58 INFO - 'title': 'talos-linux64-ix-034', 04:22:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:58 INFO - 'use_talos_json': True, 04:22:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:58 INFO - 'work_dir': 'build'} 04:22:58 INFO - ##### 04:22:58 INFO - ##### Running clobber step. 04:22:58 INFO - ##### 04:22:58 INFO - Running pre-action listener: _resource_record_pre_action 04:22:58 INFO - Running main action method: clobber 04:22:58 INFO - rmtree: /builds/slave/test/build 04:22:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:58 INFO - Running post-action listener: _resource_record_post_action 04:22:58 INFO - ##### 04:22:58 INFO - ##### Finished clobber step (success) 04:22:58 INFO - ##### 04:22:58 INFO - ##### 04:22:58 INFO - ##### Running read-buildbot-config step. 04:22:58 INFO - ##### 04:22:58 INFO - Running pre-action listener: _resource_record_pre_action 04:22:58 INFO - Running main action method: read_buildbot_config 04:22:58 INFO - Using buildbot properties: 04:22:58 INFO - { 04:22:58 INFO - "project": "", 04:22:58 INFO - "product": "firefox", 04:22:58 INFO - "script_repo_revision": "production", 04:22:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:22:58 INFO - "repository": "", 04:22:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:22:58 INFO - "buildid": "20160525013026", 04:22:58 INFO - "pgo_build": "True", 04:22:58 INFO - "basedir": "/builds/slave/test", 04:22:58 INFO - "buildnumber": 1064, 04:22:58 INFO - "slavename": "talos-linux64-ix-034", 04:22:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:22:58 INFO - "platform": "ubuntu64_hw", 04:22:58 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:22:58 INFO - "branch": "mozilla-inbound", 04:22:58 INFO - "repo_path": "integration/mozilla-inbound", 04:22:58 INFO - "revision": "51b1f2343ad9544921e68859dfbe9d3c79b00951", 04:22:58 INFO - "stage_platform": "linux64-pgo", 04:22:58 INFO - "builduid": "1e8a787cba1c42eb818eb9caeedd5444", 04:22:58 INFO - "slavebuilddir": "test" 04:22:58 INFO - } 04:22:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:22:58 INFO - Running post-action listener: _resource_record_post_action 04:22:58 INFO - ##### 04:22:58 INFO - ##### Finished read-buildbot-config step (success) 04:22:58 INFO - ##### 04:22:58 INFO - ##### 04:22:58 INFO - ##### Running download-and-extract step. 04:22:58 INFO - ##### 04:22:58 INFO - Running pre-action listener: _resource_record_pre_action 04:22:58 INFO - Running main action method: download_and_extract 04:22:58 INFO - mkdir: /builds/slave/test/build/tests 04:22: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')]} 04:22:58 INFO - https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:22:59 INFO - Downloaded 1361 bytes. 04:22:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:22:59 INFO - Using the following test package requirements: 04:22:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'jsshell-linux-x86_64.zip'], 04:22:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:59 INFO - https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:00 INFO - Downloaded 24421443 bytes. 04:23:00 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'] 04:23:00 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 04:23:01 INFO - Return code: 0 04:23:01 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 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:01 INFO - https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:06 INFO - Downloaded 24421443 bytes. 04:23:06 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'] 04:23:06 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 04:23:08 INFO - Return code: 0 04:23:08 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')]} 04:23:08 INFO - https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:08 INFO - Downloaded 10834034 bytes. 04:23:08 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'] 04:23:08 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 04:23:09 INFO - Return code: 0 04:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:09 INFO - https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b3dIIW62TkCFCmNLSEV_pg/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 04:23:12 INFO - Downloaded 58666690 bytes. 04:23:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:12 INFO - mkdir: /builds/slave/test/properties 04:23:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:12 INFO - Contents: 04:23:12 INFO - build_url:https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:14 INFO - Running post-action listener: _resource_record_post_action 04:23:14 INFO - Running post-action listener: set_extra_try_arguments 04:23:14 INFO - ##### 04:23:14 INFO - ##### Finished download-and-extract step (success) 04:23:14 INFO - ##### 04:23:14 INFO - ##### 04:23:14 INFO - ##### Running populate-webroot step. 04:23:14 INFO - ##### 04:23:14 INFO - Running pre-action listener: _resource_record_pre_action 04:23:14 INFO - Running main action method: populate_webroot 04:23:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:14 INFO - '--tppagecycles', 04:23:14 INFO - '7'], 04:23:14 INFO - 'tests': ['tsvgm']}}, 04:23:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['damp', 'tps']}, 04:23:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'tests': ['damp', 'tps']}, 04:23:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['dromaeo_dom']}, 04:23:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['a11yr', 04:23:14 INFO - 'ts_paint', 04:23:14 INFO - 'tpaint', 04:23:14 INFO - 'sessionrestore', 04:23:14 INFO - 'sessionrestore_no_auto_restore', 04:23:14 INFO - 'tabpaint']}, 04:23:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['tsvgx', 04:23:14 INFO - 'tsvgr_opacity', 04:23:14 INFO - 'tart', 04:23:14 INFO - 'tscrollx', 04:23:14 INFO - 'cart']}, 04:23:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:14 INFO - 'tsvgr_opacity', 04:23:14 INFO - 'tart', 04:23:14 INFO - 'tscrollx', 04:23:14 INFO - 'cart']}, 04:23:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'talos_options': ['--disable-e10s'], 04:23:14 INFO - 'tests': ['tp5o']}, 04:23:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'tests': ['tp5o']}, 04:23:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'talos_options': ['--disable-e10s', 04:23:14 INFO - '--xperf_path', 04:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:14 INFO - 'tests': ['tp5n']}, 04:23:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:14 INFO - 'talos_options': ['--xperf_path', 04:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:14 INFO - 'tests': ['tp5n']}}, 04:23:14 INFO - 'talos.zip': {'path': '', 04:23:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:14 INFO - Running post-action listener: _resource_record_post_action 04:23:14 INFO - ##### 04:23:14 INFO - ##### Finished populate-webroot step (success) 04:23:14 INFO - ##### 04:23:14 INFO - ##### 04:23:14 INFO - ##### Running create-virtualenv step. 04:23:14 INFO - ##### 04:23:14 INFO - Running pre-action listener: _resource_record_pre_action 04:23:14 INFO - Running main action method: create_virtualenv 04:23:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:14 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 04:23:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:14 INFO - Using real prefix '/usr' 04:23:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:16 INFO - Installing pip.................done. 04:23:16 INFO - Return code: 0 04:23:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:16 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:16 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 04:23:16 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 04:23:16 INFO - Using env: {'DISPLAY': ':0', 04:23:16 INFO - 'HOME': '/home/cltbld', 04:23:16 INFO - 'LANG': 'en_US.UTF-8', 04:23:16 INFO - 'LANGUAGE': 'en_US:en', 04:23:16 INFO - 'LOGNAME': 'cltbld', 04:23:16 INFO - 'MAIL': '/var/mail/cltbld', 04:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:16 INFO - 'MOZ_NO_REMOTE': '1', 04:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:16 INFO - 'NO_EM_RESTART': '1', 04:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:16 INFO - 'PWD': '/builds/slave/test', 04:23:16 INFO - 'SHELL': '/bin/bash', 04:23:16 INFO - 'SHLVL': '1', 04:23:16 INFO - 'TERM': 'linux', 04:23:16 INFO - 'TMOUT': '86400', 04:23:16 INFO - 'USER': 'cltbld', 04:23:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:16 INFO - '_': '/tools/buildbot/bin/python'} 04:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:16 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 04:23:16 INFO - Cleaning up... 04:23:16 INFO - Return code: 0 04:23:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:16 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:16 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 04:23:16 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 04:23:16 INFO - Using env: {'DISPLAY': ':0', 04:23:16 INFO - 'HOME': '/home/cltbld', 04:23:16 INFO - 'LANG': 'en_US.UTF-8', 04:23:16 INFO - 'LANGUAGE': 'en_US:en', 04:23:16 INFO - 'LOGNAME': 'cltbld', 04:23:16 INFO - 'MAIL': '/var/mail/cltbld', 04:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:16 INFO - 'MOZ_NO_REMOTE': '1', 04:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:16 INFO - 'NO_EM_RESTART': '1', 04:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:16 INFO - 'PWD': '/builds/slave/test', 04:23:16 INFO - 'SHELL': '/bin/bash', 04:23:16 INFO - 'SHLVL': '1', 04:23:16 INFO - 'TERM': 'linux', 04:23:16 INFO - 'TMOUT': '86400', 04:23:16 INFO - 'USER': 'cltbld', 04:23:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:16 INFO - '_': '/tools/buildbot/bin/python'} 04:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:17 INFO - Downloading/unpacking psutil>=3.1.1 04:23:17 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 04:23:17 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 04:23:17 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 04:23:17 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 04:23:17 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 04:23:17 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 04:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:19 INFO - Installing collected packages: psutil 04:23:19 INFO - Running setup.py install for psutil 04:23:19 INFO - building 'psutil._psutil_linux' extension 04:23:19 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 04:23:19 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 04:23:19 INFO - building 'psutil._psutil_posix' extension 04:23:19 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 04:23:19 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 04:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:19 INFO - Successfully installed psutil 04:23:19 INFO - Cleaning up... 04:23:19 INFO - Return code: 0 04:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:19 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')]} 04:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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')]} 04:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:19 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 04:23:19 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 04:23:19 INFO - Using env: {'DISPLAY': ':0', 04:23:19 INFO - 'HOME': '/home/cltbld', 04:23:19 INFO - 'LANG': 'en_US.UTF-8', 04:23:19 INFO - 'LANGUAGE': 'en_US:en', 04:23:19 INFO - 'LOGNAME': 'cltbld', 04:23:19 INFO - 'MAIL': '/var/mail/cltbld', 04:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:19 INFO - 'MOZ_NO_REMOTE': '1', 04:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:19 INFO - 'NO_EM_RESTART': '1', 04:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:19 INFO - 'PWD': '/builds/slave/test', 04:23:19 INFO - 'SHELL': '/bin/bash', 04:23:19 INFO - 'SHLVL': '1', 04:23:19 INFO - 'TERM': 'linux', 04:23:19 INFO - 'TMOUT': '86400', 04:23:19 INFO - 'USER': 'cltbld', 04:23:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:19 INFO - '_': '/tools/buildbot/bin/python'} 04:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:19 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 04:23:19 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 04:23:19 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 04:23:19 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 04:23:19 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 04:23:19 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 04:23:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:21 INFO - Installing collected packages: mozsystemmonitor 04:23:21 INFO - Running setup.py install for mozsystemmonitor 04:23:21 INFO - Successfully installed mozsystemmonitor 04:23:21 INFO - Cleaning up... 04:23:21 INFO - Return code: 0 04:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:21 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:21 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 04:23:21 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 04:23:21 INFO - Using env: {'DISPLAY': ':0', 04:23:21 INFO - 'HOME': '/home/cltbld', 04:23:21 INFO - 'LANG': 'en_US.UTF-8', 04:23:21 INFO - 'LANGUAGE': 'en_US:en', 04:23:21 INFO - 'LOGNAME': 'cltbld', 04:23:21 INFO - 'MAIL': '/var/mail/cltbld', 04:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:21 INFO - 'MOZ_NO_REMOTE': '1', 04:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:21 INFO - 'NO_EM_RESTART': '1', 04:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:21 INFO - 'PWD': '/builds/slave/test', 04:23:21 INFO - 'SHELL': '/bin/bash', 04:23:21 INFO - 'SHLVL': '1', 04:23:21 INFO - 'TERM': 'linux', 04:23:21 INFO - 'TMOUT': '86400', 04:23:21 INFO - 'USER': 'cltbld', 04:23:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:21 INFO - '_': '/tools/buildbot/bin/python'} 04:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 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 04:23:24 INFO - Downloading docopt-0.6.1.tar.gz 04:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:24 INFO - Running setup.py install for blobuploader 04:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:24 INFO - Running setup.py install for requests 04:23:25 INFO - Running setup.py install for docopt 04:23:25 INFO - Successfully installed blobuploader requests docopt 04:23:25 INFO - Cleaning up... 04:23:25 INFO - Return code: 0 04:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:25 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 04:23:25 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 04:23:25 INFO - Using env: {'DISPLAY': ':0', 04:23:25 INFO - 'HOME': '/home/cltbld', 04:23:25 INFO - 'LANG': 'en_US.UTF-8', 04:23:25 INFO - 'LANGUAGE': 'en_US:en', 04:23:25 INFO - 'LOGNAME': 'cltbld', 04:23:25 INFO - 'MAIL': '/var/mail/cltbld', 04:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:25 INFO - 'MOZ_NO_REMOTE': '1', 04:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:25 INFO - 'NO_EM_RESTART': '1', 04:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:25 INFO - 'PWD': '/builds/slave/test', 04:23:25 INFO - 'SHELL': '/bin/bash', 04:23:25 INFO - 'SHLVL': '1', 04:23:25 INFO - 'TERM': 'linux', 04:23:25 INFO - 'TMOUT': '86400', 04:23:25 INFO - 'USER': 'cltbld', 04:23:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:25 INFO - '_': '/tools/buildbot/bin/python'} 04:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:25 INFO - Running setup.py (path:/tmp/pip-wPSL0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:25 INFO - Running setup.py (path:/tmp/pip-hA594u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:25 INFO - Running setup.py (path:/tmp/pip-AXf9yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:25 INFO - Running setup.py (path:/tmp/pip-LZxJ6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:25 INFO - Running setup.py (path:/tmp/pip-mi_R42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:26 INFO - Running setup.py (path:/tmp/pip-ZYW8CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:26 INFO - Running setup.py (path:/tmp/pip-WzQp25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:26 INFO - Running setup.py (path:/tmp/pip-4PDdlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:26 INFO - Running setup.py (path:/tmp/pip-m1QRC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:26 INFO - Running setup.py (path:/tmp/pip-3UCw3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:26 INFO - Running setup.py (path:/tmp/pip-sZtrpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:26 INFO - Running setup.py (path:/tmp/pip-zFkfDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:26 INFO - Running setup.py (path:/tmp/pip-c2zpAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:26 INFO - Running setup.py (path:/tmp/pip-2d_Rry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:26 INFO - Running setup.py (path:/tmp/pip-Cl889v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:26 INFO - Running setup.py (path:/tmp/pip-591r_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:26 INFO - Running setup.py (path:/tmp/pip-LOEuLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:26 INFO - Running setup.py install for manifestparser 04:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for mozcrash 04:23:27 INFO - Running setup.py install for mozdebug 04:23:27 INFO - Running setup.py install for mozdevice 04:23:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for mozfile 04:23:27 INFO - Running setup.py install for mozhttpd 04:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for mozinfo 04:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for mozInstall 04:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for mozleak 04:23:27 INFO - Running setup.py install for mozlog 04:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:27 INFO - Running setup.py install for moznetwork 04:23:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Running setup.py install for mozprocess 04:23:28 INFO - Running setup.py install for mozprofile 04:23:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Running setup.py install for mozrunner 04:23:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Running setup.py install for mozscreenshot 04:23:28 INFO - Running setup.py install for moztest 04:23:28 INFO - Running setup.py install for mozversion 04:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:28 INFO - Cleaning up... 04:23:28 INFO - Return code: 0 04:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:28 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:28 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 04:23:28 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 04:23:28 INFO - Using env: {'DISPLAY': ':0', 04:23:28 INFO - 'HOME': '/home/cltbld', 04:23:28 INFO - 'LANG': 'en_US.UTF-8', 04:23:28 INFO - 'LANGUAGE': 'en_US:en', 04:23:28 INFO - 'LOGNAME': 'cltbld', 04:23:28 INFO - 'MAIL': '/var/mail/cltbld', 04:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:28 INFO - 'MOZ_NO_REMOTE': '1', 04:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:28 INFO - 'NO_EM_RESTART': '1', 04:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:28 INFO - 'PWD': '/builds/slave/test', 04:23:28 INFO - 'SHELL': '/bin/bash', 04:23:28 INFO - 'SHLVL': '1', 04:23:28 INFO - 'TERM': 'linux', 04:23:28 INFO - 'TMOUT': '86400', 04:23:28 INFO - 'USER': 'cltbld', 04:23:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:28 INFO - '_': '/tools/buildbot/bin/python'} 04:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:28 INFO - Running setup.py (path:/tmp/pip-pF0DDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:28 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)) 04:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:28 INFO - Running setup.py (path:/tmp/pip-SP23cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:29 INFO - Running setup.py (path:/tmp/pip-KxuM8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:29 INFO - Running setup.py (path:/tmp/pip-R9BdvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:29 INFO - Running setup.py (path:/tmp/pip-2kMmNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:29 INFO - Running setup.py (path:/tmp/pip-Ayq5LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:29 INFO - Running setup.py (path:/tmp/pip-VWRpfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:29 INFO - Running setup.py (path:/tmp/pip-EznDnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:29 INFO - Running setup.py (path:/tmp/pip-WdI6LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:29 INFO - Running setup.py (path:/tmp/pip-JNWGSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:29 INFO - Running setup.py (path:/tmp/pip-8YIFKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:29 INFO - Running setup.py (path:/tmp/pip-nLax8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:29 INFO - Running setup.py (path:/tmp/pip-DIgqKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:29 INFO - Running setup.py (path:/tmp/pip-DIkp3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:29 INFO - Running setup.py (path:/tmp/pip-FNUFcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:29 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)) 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:29 INFO - Running setup.py (path:/tmp/pip-x5e1Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:30 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)) 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:30 INFO - Running setup.py (path:/tmp/pip-6ClnyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:30 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)) 04:23:30 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)) 04:23:30 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)) 04:23:30 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)) 04:23:30 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)) 04:23:30 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)) 04:23:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:30 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 04:23:30 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 04:23:30 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 04:23:30 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 04:23:30 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 04:23:30 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 04:23:32 INFO - Downloading blessings-1.6.tar.gz 04:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:32 INFO - Installing collected packages: blessings 04:23:32 INFO - Running setup.py install for blessings 04:23:32 INFO - Successfully installed blessings 04:23:32 INFO - Cleaning up... 04:23:32 INFO - Return code: 0 04:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:32 INFO - Reading from file tmpfile_stdout 04:23:32 INFO - Current package versions: 04:23:32 INFO - argparse == 1.2.1 04:23:32 INFO - blessings == 1.6 04:23:32 INFO - blobuploader == 1.2.4 04:23:32 INFO - docopt == 0.6.1 04:23:32 INFO - manifestparser == 1.1 04:23:32 INFO - mozInstall == 1.12 04:23:32 INFO - mozcrash == 0.17 04:23:32 INFO - mozdebug == 0.1 04:23:32 INFO - mozdevice == 0.48 04:23:32 INFO - mozfile == 1.2 04:23:32 INFO - mozhttpd == 0.7 04:23:32 INFO - mozinfo == 0.9 04:23:32 INFO - mozleak == 0.1 04:23:32 INFO - mozlog == 3.2 04:23:32 INFO - moznetwork == 0.27 04:23:32 INFO - mozprocess == 0.22 04:23:32 INFO - mozprofile == 0.28 04:23:32 INFO - mozrunner == 6.11 04:23:32 INFO - mozscreenshot == 0.1 04:23:32 INFO - mozsystemmonitor == 0.3 04:23:32 INFO - moztest == 0.7 04:23:32 INFO - mozversion == 1.4 04:23:32 INFO - psutil == 3.1.1 04:23:32 INFO - requests == 1.2.3 04:23:32 INFO - wsgiref == 0.1.2 04:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:32 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 04:23:32 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 04:23:32 INFO - Using env: {'DISPLAY': ':0', 04:23:32 INFO - 'HOME': '/home/cltbld', 04:23:32 INFO - 'LANG': 'en_US.UTF-8', 04:23:32 INFO - 'LANGUAGE': 'en_US:en', 04:23:32 INFO - 'LOGNAME': 'cltbld', 04:23:32 INFO - 'MAIL': '/var/mail/cltbld', 04:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:32 INFO - 'MOZ_NO_REMOTE': '1', 04:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:32 INFO - 'NO_EM_RESTART': '1', 04:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:32 INFO - 'PWD': '/builds/slave/test', 04:23:32 INFO - 'SHELL': '/bin/bash', 04:23:32 INFO - 'SHLVL': '1', 04:23:32 INFO - 'TERM': 'linux', 04:23:32 INFO - 'TMOUT': '86400', 04:23:32 INFO - 'USER': 'cltbld', 04:23:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:32 INFO - '_': '/tools/buildbot/bin/python'} 04:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 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)) 04:23:32 INFO - Cleaning up... 04:23:32 INFO - Return code: 0 04:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:32 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 04:23:32 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 04:23:32 INFO - Using env: {'DISPLAY': ':0', 04:23:32 INFO - 'HOME': '/home/cltbld', 04:23:32 INFO - 'LANG': 'en_US.UTF-8', 04:23:32 INFO - 'LANGUAGE': 'en_US:en', 04:23:32 INFO - 'LOGNAME': 'cltbld', 04:23:32 INFO - 'MAIL': '/var/mail/cltbld', 04:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:32 INFO - 'MOZ_NO_REMOTE': '1', 04:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:32 INFO - 'NO_EM_RESTART': '1', 04:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:32 INFO - 'PWD': '/builds/slave/test', 04:23:32 INFO - 'SHELL': '/bin/bash', 04:23:32 INFO - 'SHLVL': '1', 04:23:32 INFO - 'TERM': 'linux', 04:23:32 INFO - 'TMOUT': '86400', 04:23:32 INFO - 'USER': 'cltbld', 04:23:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:32 INFO - '_': '/tools/buildbot/bin/python'} 04:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:32 INFO - Downloading/unpacking jsonschema 04:23:32 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 04:23:32 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 04:23:32 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 04:23:32 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 04:23:32 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 04:23:32 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 04:23:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:34 INFO - Downloading/unpacking functools32 (from jsonschema) 04:23:34 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 04:23:34 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 04:23:34 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 04:23:34 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 04:23:34 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 04:23:34 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 04:23:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:35 INFO - warning: no files found matching '*.txt' 04:23:35 INFO - no previously-included directories found matching 'build' 04:23:35 INFO - no previously-included directories found matching 'dist' 04:23:35 INFO - no previously-included directories found matching '.git*' 04:23:35 INFO - Installing collected packages: jsonschema, functools32 04:23:35 INFO - Running setup.py install for functools32 04:23:35 INFO - warning: no files found matching '*.txt' 04:23:35 INFO - no previously-included directories found matching 'build' 04:23:35 INFO - no previously-included directories found matching 'dist' 04:23:35 INFO - no previously-included directories found matching '.git*' 04:23:35 INFO - Successfully installed jsonschema functools32 04:23:35 INFO - Cleaning up... 04:23:35 INFO - Return code: 0 04:23:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:35 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')]} 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 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')]} 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 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 0x7fcfb4c6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', '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 04:23:35 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 04:23:35 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 04:23:35 INFO - Using env: {'DISPLAY': ':0', 04:23:35 INFO - 'HOME': '/home/cltbld', 04:23:35 INFO - 'LANG': 'en_US.UTF-8', 04:23:35 INFO - 'LANGUAGE': 'en_US:en', 04:23:35 INFO - 'LOGNAME': 'cltbld', 04:23:35 INFO - 'MAIL': '/var/mail/cltbld', 04:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:35 INFO - 'MOZ_NO_REMOTE': '1', 04:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:35 INFO - 'NO_EM_RESTART': '1', 04:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:35 INFO - 'PWD': '/builds/slave/test', 04:23:35 INFO - 'SHELL': '/bin/bash', 04:23:35 INFO - 'SHLVL': '1', 04:23:35 INFO - 'TERM': 'linux', 04:23:35 INFO - 'TMOUT': '86400', 04:23:35 INFO - 'USER': 'cltbld', 04:23:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:35 INFO - '_': '/tools/buildbot/bin/python'} 04:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:35 INFO - Downloading/unpacking flake8 04:23:35 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 04:23:35 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 04:23:35 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 04:23:35 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 04:23:35 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 04:23:35 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 04:23:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:37 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 04:23:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:38 INFO - no previously-included directories found matching 'docs/_build' 04:23:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:38 INFO - Running setup.py install for pep8 04:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:38 INFO - no previously-included directories found matching 'docs/_build' 04:23:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:38 INFO - Cleaning up... 04:23:38 INFO - Return code: 0 04:23:38 INFO - Running post-action listener: _resource_record_post_action 04:23:38 INFO - Running post-action listener: _start_resource_monitoring 04:23:38 INFO - Starting resource monitoring. 04:23:38 INFO - ##### 04:23:38 INFO - ##### Finished create-virtualenv step (success) 04:23:38 INFO - ##### 04:23:38 INFO - ##### 04:23:38 INFO - ##### Running install step. 04:23:38 INFO - ##### 04:23:38 INFO - Running pre-action listener: _resource_record_pre_action 04:23:38 INFO - Running main action method: install 04:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:38 INFO - Reading from file tmpfile_stdout 04:23:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:38 INFO - Reading from file tmpfile_stdout 04:23:38 INFO - Output received: 04:23:38 INFO - Usage: mozinstall [options] installer 04:23:38 INFO - Options: 04:23:38 INFO - -h, --help show this help message and exit 04:23:38 INFO - -d DEST, --destination=DEST 04:23:38 INFO - Directory to install application into. [default: 04:23:38 INFO - "/builds/slave/test"] 04:23:38 INFO - --app=APP Application being installed. [default: firefox] 04:23:38 INFO - mkdir: /builds/slave/test/build/application 04:23:38 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'] 04:23:38 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 04:23:55 INFO - Reading from file tmpfile_stdout 04:23:55 INFO - Output received: 04:23:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:55 INFO - Running post-action listener: _resource_record_post_action 04:23:55 INFO - ##### 04:23:55 INFO - ##### Finished install step (success) 04:23:55 INFO - ##### 04:23:55 INFO - ##### 04:23:55 INFO - ##### Running run-tests step. 04:23:55 INFO - ##### 04:23:55 INFO - Running pre-action listener: _resource_record_pre_action 04:23:55 INFO - Running main action method: run_tests 04:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:55 INFO - Python 2.7.3 04:23:55 INFO - Return code: 0 04:23:55 INFO - grabbing minidump binary from tooltool 04:23: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')]} 04:23:55 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 0x26579c0>, '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 0x26588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2658d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:55 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 04:23:55 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 04:23:55 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 04:23:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:55 INFO - Return code: 0 04:23:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:56 INFO - Return code: 0 04:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 04:23:56 INFO - Using env: {'DISPLAY': ':0', 04:23:56 INFO - 'HOME': '/home/cltbld', 04:23:56 INFO - 'LANG': 'en_US.UTF-8', 04:23:56 INFO - 'LANGUAGE': 'en_US:en', 04:23:56 INFO - 'LOGNAME': 'cltbld', 04:23:56 INFO - 'MAIL': '/var/mail/cltbld', 04:23:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:56 INFO - 'MOZ_NO_REMOTE': '1', 04:23:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:56 INFO - 'NO_EM_RESTART': '1', 04:23:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:56 INFO - 'PWD': '/builds/slave/test', 04:23:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:56 INFO - 'SHELL': '/bin/bash', 04:23:56 INFO - 'SHLVL': '1', 04:23:56 INFO - 'TERM': 'linux', 04:23:56 INFO - 'TMOUT': '86400', 04:23:56 INFO - 'USER': 'cltbld', 04:23:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812', 04:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:56 INFO - '_': '/tools/buildbot/bin/python'} 04:23:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:23:56 INFO - mozversion application_buildid: 20160525013026 04:23:56 INFO - mozversion application_changeset: 51b1f2343ad9544921e68859dfbe9d3c79b00951 04:23:56 INFO - mozversion application_display_name: Nightly 04:23:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:56 INFO - mozversion application_name: Firefox 04:23:56 INFO - mozversion application_remotingname: firefox 04:23:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:23:56 INFO - mozversion application_vendor: Mozilla 04:23:56 INFO - mozversion application_version: 49.0a1 04:23:56 INFO - mozversion platform_buildid: 20160525013026 04:23:56 INFO - mozversion platform_changeset: 51b1f2343ad9544921e68859dfbe9d3c79b00951 04:23:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:23:56 INFO - mozversion platform_version: 49.0a1 04:23:56 INFO - using testdate: 1464175436 04:23:56 INFO - actual date: 1464175436 04:23:56 INFO - starting webserver on 'localhost:52515' 04:23:56 INFO - SUITE-START | Running 2 tests 04:23:56 INFO - TEST-START | dromaeo_css 04:23:56 INFO - operating with platform_type : linux_ 04:23:56 INFO - Initialising browser for dromaeo_css test... 04:23:56 INFO - TEST-INFO | started process 14258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbLw6z/profile http://localhost:52515/getInfo.html) 04:24:00 INFO - PROCESS | 14258 | __metrics Screen width/height:1600/1200 04:24:00 INFO - PROCESS | 14258 | colorDepth:24 04:24:00 INFO - PROCESS | 14258 | Browser inner width/height: 1024/697 04:24:00 INFO - PROCESS | 14258 | __metrics 04:24:01 ERROR - PROCESS | 14258 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:24:02 INFO - TEST-INFO | 14258: exit 0 04:24:02 INFO - Browser initialized. 04:24:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:02 INFO - TEST-INFO | started process 14342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbLw6z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:14 INFO - PROCESS | 14342 | RSS: Main: 154857472 04:24:14 INFO - PROCESS | 14342 | 04:25:05 INFO - PROCESS | 14342 | 1464175505297 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] 04:27:13 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52515/tests/dromaeo/cssquery-ext.html) 04:27:13 INFO - PROCESS | 14342 | RSS: Main: 246616064 04:27:13 INFO - PROCESS | 14342 | 04:30:16 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-ext.html (next: http://localhost:52515/tests/dromaeo/cssquery-jquery.html) 04:30:16 INFO - PROCESS | 14342 | RSS: Main: 258080768 04:30:16 INFO - PROCESS | 14342 | 04:33:18 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52515/tests/dromaeo/cssquery-mootools.html) 04:33:19 INFO - PROCESS | 14342 | RSS: Main: 256241664 04:33:19 INFO - PROCESS | 14342 | 04:36:21 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52515/tests/dromaeo/cssquery-prototype.html) 04:36:22 INFO - PROCESS | 14342 | RSS: Main: 254406656 04:36:22 INFO - PROCESS | 14342 | 04:39:24 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52515/tests/dromaeo/cssquery-yui.html) 04:39:25 INFO - PROCESS | 14342 | RSS: Main: 225005568 04:39:25 INFO - PROCESS | 14342 | 04:42:27 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:52515/tests/dromaeo/cssquery-yui.html (next: http://localhost:52515/tests/dromaeo/cssquery-dojo.html) 04:42:28 INFO - PROCESS | 14342 | RSS: Main: 314753024 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | __start_tp_report 04:42:28 INFO - PROCESS | 14342 | _x_x_mozilla_page_load 04:42:28 INFO - PROCESS | 14342 | _x_x_mozilla_page_load_details 04:42:28 INFO - PROCESS | 14342 | |i|pagename|runs| 04:42:28 INFO - PROCESS | 14342 | |0;dojo.html;3111.6110486189227;3113.891013814516;3124.9531257031135;3174.5079512675543;3189.409959157556;5265.552428043621;5331.813386531472;5353.7590808413615;5438.8912221755545;5470.370907345651;5379.6503227290195;5382.703951282678;5388.946110538894;5444.3194600674815;5464.289642346489;4825.179719447694;4840.685355451885;4990.27640992056;5039.294498770175;5065.088284108859;4972.055309491203;5001.574866136383;5014.598832093424;5033.446320904697;5036.143855544567;4763.90472190556;4846.975765121169;4869.902601947977;4902.338184345103;4934.950650493485;4878.707277563358;4885.633577481668;4902.068606964665;4903.043906438246;4942.827001054981;4832.202686556714;4850.660453768238;4889.804407823718;4898.069366820293;4918.360613120271;5219.034478621467;5247.921281180786;5297.046531624306;5324.733763311819;5371.946280537184;5765.971170144165;5814.127880817869;5819.418058194189;5819.592628516006;5829.766809327622;5586.944130558683;5822;5867.8533036674;5876.676782776945;5876.676782776945;5366.490183432567;5429.484199001088;5435.972820135914;5458.099413596791;5501.724913754297;5912.674802885883;5945.643261404243;5954.672493012839;5964.7912323068485;5991.730372133265;5514.393416724157;5636.689982051026;5759.971200143972;5770;5778.624389414758;5751.424857514299;5817.040188368872;5817.272840894888;5872.207252021008;5877.853053673693;5779.104238842986;5779.566532510079;5785.103308987113;5788.334341550775;5790.420957904176;5536.861578460571;5593.272874526367;5700.714964251853;5804.854878628068;5814.738336774771;4408.360787685831;4411.426514553152;4413;4442.777861106932;4452.154090722753;3914.4715463412645;3915.3735402335487;3941.8620348288246;3965.325894597925;3976.443297938291;5363.249145119687;5386.542143917733;5416.83749487516;5500.889982200333;5544.69504177266;5830.766769329264;5854.121881717776;5858.681796595817;5884.382139875337;5904.675242861598;5506.889862202734;5516.834494965157;5517.834464966058;5519.227308176858;5521.889562208733;4875.68308059975;4970.577500912391;5027.698338099725;5042.974785126051;5051.015052064886;5922.822315330547;5935.643861368331;5946.375630558729;5950.851228719317;6005.069214271794;5802.303723553201;5808;5811.593188476935;5818.359980402237;5819.6508209507565;5809.796657116981;5900.232969714081;5939.049752039826;5964.463198311999;5980.192673988956;5677.233573467529;5715;5721;5724.856878578069;5726.885462290647;5760.366359700513;5800.100984347433;5815.447532484407;5818.359980402237;5825.70871456417;5502.972485137549;5626.24045753818;5637.830865074055;5685.687287199244;5720.427957204412;5693.686847223276;5694.629849059798;5702.800401985911;5704.9429505706075;5706.857328566819;5415.756290966837;5627.268455100974;5628.437156284339;5633.295838020247;5638.295213098363;5581.860453488695;5597.6641401516035;5630.85922851932;5709.65742055478;5721.942780572141;5558.555315574825;5564.610477266714;5566.582506311962;5578.553715702815;5614.69119198448 04:42:28 INFO - PROCESS | 14342 | |1;ext.html;604.7218279591387;622.4056026494698;623.2489849731074;637.5664548107285;639.7504973060508;38671.22657546847;42266.57733422665;42312.36531452023;42353.78823105884;42367;43717.562824371744;44399.3340099898;44424.77787611057;44471.77764111183;44497;8510.106438823927;8734.301255899512;8744.693935712252;8750.606222719993;8755.912440875605;8672.306215502776;8753.649854005864;8765.649374025032;8765.824683506326;8770.429922055078;8764.079771623983;8783.692570760024;8819.735407937773;8826.470411775283;8840.823183536326;8758.824823503526;8795.384323097385;8798.912010879905;8807.075257097977;8809.911900881038;8378.748637540884;8469.068402475723;8491.74524764258;8497.235248827574;8497.61760720769;40784;40997;41281.38077928834;41323.1735365291;41359.793201033805;2537.936551586225;3593.8921832345072;3609.2961872434885;3777.017975326435;3803.0682482791617;32477;32816;33033.6696633033;34483.13792155191;34501;4218.6835987300765;4238.7032907696475;4239.394030118864;4246.108317253381;4264.211120942605;366081;367387;369846;369864;370266.9999999973;50614.493855061715;54514.72742636262;55607;55700;58128.70935645295;54714.72642636761;54814;55020;55093;55125.44874551203;15888;16032.679346413006;16049.679006419807;16053;16075.356985720675;12316.507339706312;12399.442025108712;12408.56570020045;12485.50057997688;12537.24776513394;17854.642907141784;17942.102894855467;17992.91003544974;18067.819321806877;18130.184141713653;6584.440322572539;6767.526273160832;6976.127984002;7007.474439417064;7057.964710176417;1041.3491567770143;1129.3854726308568;1130.9434528273553;1140.9144314176303;1141.9143564232716;32552.674473255436;32650.673493264763;32691.673083268863;32888.177795555304;33484.3303133936;1076.1337123615565;1155.861296644408;1181.8818118188112;1202.3387137074749;1216.920900141488;16478.588035299214;16929.830701692827;16947.745783813254;16978;17241.482755517354;553893;558076;558608;563020;569065;57588.13617795736;57920;58079.41920580825;58095;58135.41864581384;1354.9757221053455;1362.9182249065088;1382.6819831438625;1383.1493631416606;1391.8190635217356;30257.848710756305;31489.685103148677;31608.209794754395;31857;32438.189045273113;50480.74759626325;50773;50865.237021443965;50878.74560627173;50900.745496272284;434863;438839;439229;441829;441969;35663.46504802482;38728.80635596804;39778.2044359117;40250.39624405577;40650.79674601608;47908;48407;48619;49542.75228623834;49708.502914970384;40241.79879100586;40276.79861600673;40876.59123408728;41310.79344603258;41329;38808.6119138805;39713.20573588454;39723.40414893721;40019.3997090038;40578.39132413075;40226.59773402228;40657.1868562633;41342.58657413508;41497.79251103725;41553.37669935014;35564.466533002545;36094.45858312075;36636;36800.63199367972;36828.44757328696;27913.860430697718;27971.58042629403;28040.71959280381;28211;28391.574126388536 04:42:28 INFO - PROCESS | 14342 | |2;jquery.html;388.3340071776902;388.97471664341833;396.13839898221363;401.8774273846477;410.9527404348499;13968.44126234952;15632.452864149756;18573.164207610673;19238.23047078117;19243.845369277835;14344.784828227585;17682.82317176828;17711.29154833805;17866.10669466528;18151.45545633633;5470.835874923749;5513.228148059255;5644.266245388094;5653.4911857932775;5667.149927510865;3454.809985450799;5462.371827239878;5560.471755183251;5613.578981576377;5999.910001349983;6254.312025677172;6351.555391122623;6360.586561873463;6373.426391624753;6373.776917807878;6086.878262434727;6268.937310626904;6329.303776584572;6360.109584658151;6374.553781235315;5453.3728621208675;5458.263134476834;5468.535174510172;5472.370677372073;5476.972615136939;20993.475163121046;21124.683129753066;21459.356219313446;22111.44721381962;22127.889360553094;2232.843700940935;2334.0780391745334;2363.0429675981254;2447.6940382452194;2531.4304281536506;13120.409581568852;13635.727285454235;13749.31253437324;14141.29293535319;14288.357023933948;1934.5840644261411;1981.8711783734154;1994.4914046918088;2024.3016159424974;2026.432598872318;73452;75834.24165758328;75837;76758.84861727079;76972.61513692452;10046.246531510165;10340.482975851177;10419.895801041892;10509.31689440184;10610.310329828537;14453.349599268058;14510.637234069232;14549.418023279162;14562.635934101732;14574.052686575338;7301.342879140902;7651.273129052731;7859.331956783737;7986.3610911128135;8135.3491720662205;7826.256505631955;7891.408144389079;7988.960055199803;7997.480163789335;8175.836483270301;6372.2671892732005;6473.741050357933;6497.870042599122;6510.218773747086;6557.737690492422;1888.3579582941866;1910.5987742574216;1916.626257879728;1931.430228082691;1965.5282732144183;980.9362391444533;1002.9498525073717;1057.2335057083706;1090.5528733219342;1121.3832392184265;18807;18882.24471021171;18996;19158.13788379526;19437.902810485855;1016.3749294184023;1019.1031891935049;1037.1288117980932;1057.841323801436;1103.758271944063;10517.368957862553;10975.451227438596;11008.504617292241;11050.226484146193;11094.833577496343;430001;437036;437841;438732;443576;78362.6081869587;82257.58871205605;82438.58780706058;83504;84028;1054.7732237568805;1077.186724023373;1093.5297821936645;1102.735343517566;1118.2060736876747;16457.835421645632;16868.53884419479;16896;17120.486385408458;17458.388956386465;37750.811245943594;37879.81060094682;37997.24005519819;38522;39689.80155099206;47763.522364775905;50328.24507632315;52098.21852672137;52173.7391313041;52505.7374713124;8450.957745211235;8483.44857584255;8564.143585641386;8593.8710919335;8747.781305467159;7790.182030886675;10818.945905270739;13257.07200495956;13363.1313964592;13527.526536571173;11255.943720281346;11269.323840569592;11481;11746.941265293619;11762.059035277329;11029.724256893642;11081.944590277319;11596.826047609462;11636;11661.76676466449;6027.095935609694;8135.064467586303;8871.955640221757;10279.280450368402;11901.226420282654;8304.916950830415;8343.66625335004;8538.10349913275;8636.481811091355;8750.562471876254;11067.944660276647;11606.187566870238;11669.12481563903;11686.474108664961;11727.179097463095 04:42:28 INFO - PROCESS | 14342 | |3;mootools.html;1328.0637150808682;1436.454147423979;1469.8015767871339;1599.2483532739616;1776.555861034742;7746.690132394704;8086.919130808697;8099.838003239939;8290.129536398666;8309.086000539952;8046.839063218732;8223.136570660085;8227.382946279038;8232.506049637026;8250.257476827084;1941.8737782044122;2205.790449907256;2232.8771917544527;2269;2274.317704688595;2245.5059886824874;2264.830137739668;2275.9089636414524;2276.146445083094;2276.3739971507885;2190.9671354929687;2240.5070884405486;2246.1352379333994;2246.359787460574;2246.528229071897;1904.7047707605343;2148.6132496150763;2216.966745498819;2222.7110475638065;2236.563870045342;2139.1336508713994;2159.6436587962967;2165.447810808234;2172.174573662014;2172.73927128744;8138.064122625915;8181.468204566743;8190.7133250335955;8203.507789532647;8235.21765432283;4842.370491836074;4983.775730092155;4984.850454486371;4985.750712464363;4988.102141614508;3372.224388390684;3390.5253264542985;3421.3157368526395;3510.7717998330027;3514.8242587870504;1092.2245205903819;1103.564092183591;1126.9436528173558;1147.0995268714018;1196.3719047500044;11135.721606959809;11154.888451115467;11172.162087843444;11179.60871369498;11181.273217240934;4307.504636966726;4392.604665580113;4448.621867141329;4485.215087359699;4490.2142125127975;9492.477913714674;9500.667476638284;9511.762205944768;9516.524173791422;9518.619255229853;4483.21543729846;4979.502049795064;4983.6760610560195;4985.252212168204;4989.077020751172;4546.113507866001;4699.060187962421;4700.412448443944;4714.5521175488275;4716.646251531149;3708.9072773180346;3756.2111956488898;3807.4859893913967;3849.4610754494392;3882.0683036071705;1232.2668012532529;1248.6066888929959;1250.5810553464692;1257.1200159887933;1272.853621833501;960.500539719342;960.8126415348939;963.4026903319987;973.6932866147282;999.4503023337136;5559;5600.019996500596;5664.603477756517;5765.88468230633;5895.263092113486;1003.117256813999;1053.2995557953875;1071.908887744535;1090.334895713614;1094.2777766674117;4073.816678249486;4150.605692459211;4151.190517848991;4156.854510092193;4189;10042.246831487668;10234.02776736209;10313.071823535918;10321.122704570045;10321.122704570045;10147.847782283272;10223.079922806834;10225.693229203136;10244.180465562737;10247.897521024843;7392.630368481555;7609.505382150142;7624;7642.5032372895585;7829.41279404047;5360.356757189163;5539.529140022982;5678.375378708256;5736;5845.970770146122;8731.25784308341;9091.818163636557;9222.123898229658;9229.815403692022;9271.165595096474;9332;9427.905720942977;9430;9455.432674039304;9479.526023698925;7110.893336599852;7551.131619863786;7806.648700808364;7828.334591559781;7962.960185199037;8003;8003.079645840803;8085.555294458862;8091.595420228848;8100.189981001853;7123.287671232835;7296.19741828409;7311.524750891175;7431.145418276751;7481.102267727908;7188.928110718826;7196.748113815991;7215.974661157992;7237.8914316284245;7337.376323012603;6402.295747467868;6486.383793539606;6488.091667166695;6488.967555162194;6490.415862572391;4685.742284174403;4731.905361892812;4795.808167673254;4816.181249187716;4915.3855768029;4672.392588963549;4711.8350857719815;4760.6429517787;4789.976050119727;4871.391076115486 04:42:28 INFO - PROCESS | 14342 | |4;prototype.html;317.2117288537983;317.65534395181226;324.9512573114034;325.4759836662973;325.59626063681014;5286.418493965665;5289.523942845143;5314.007247282269;5341.706206158659;5363.973180134104;5173.741312934348;5187.144121220003;5253.842384728455;5264.973675131629;5289.61967114798;3885.5531613864414;3982.3030969580354;4098.897527561805;4107.466029416171;4114;4063.2686116499017;4096.303628383167;4096.32410652242;4105.97947010266;4114.897127571805;3933.331333673282;4075.7976396962817;4078.3882417637296;4079.1433798902267;4083.917202226856;3999.840006399755;4092.6930480213955;4111.958880411187;4114.732542384735;4121.443605113332;3592.8742494012586;3606.6032736398975;3609.3864043112735;3631.801505503204;3634.3639863024127;5102.540771330561;5104.770285337132;5106.08090543702;5123.410807757118;5129.307543481619;4473;4699.389079419688;4700.5064468230685;4729.219678753002;4737.8104875805275;5424.430434804328;5444.373897001817;5448.45515448456;5468.070428027245;5538.6399884007415;3741.7193710471824;3906.824192911326;3961.6830653547936;3969.940450893239;3970.8808735737975;5644.8871022579315;5661.433856614347;5668.987509434174;5672.68800215988;5685.214245019952;3840.7887566183567;3857.07430216746;3857.1514266861245;3870.6903447724117;3876.770856757376;3862.633049860259;3924.136689928211;3936.2717897189114;3937.783421911822;3954.209158168378;4480.619147372445;4511.962248682821;4519.118771839526;4531.342955271467;4539.591436770706;5464.7814087436855;5474.91787623186;5486.1770734389365;5500.697461639568;5511.807086751945;1368.4936573467683;1393.3381643719151;1393.888488920884;1394.9886332408923;1395.9162450253018;890.3366991591176;894.7449976756593;901;908.7001289574424;909.5497728624373;5281.577473802086;5380.192971054373;5399.217113518518;5399.487048730443;5432.75552600134;5701.660109874177;5715.31416230055;5728.885422291531;5730.312362516524;5741.1388291756575;5181.689098654093;5370.382406023279;5396.354111995879;5419.512243898068;5431.266778984866;3010.1571559963245;3026.379592183597;3030.65147508035;3030.8029978051795;3045.4365942300747;5629.761452480448;5834.082958520739;5840.620359676693;5843.298804143445;5915.970420147958;5815.418458154235;5838.416158384128;5843.123531470228;5846.649201047866;5854.824355269348;5870.119482077637;5899.2007437731045;5907.202527658797;5909.172715819875;5937.287525496968;5527;5699.4300569944335;5711.914321285101;5712.285964254468;5773.278340207474;5635.351934527582;5650.915236271377;5653.689047102284;5664.631798933056;5668.744906479301;5613.522850557748;5849.766009359748;5898.9705051476185;5904.232449781673;5929.52563794904;3872.993021814292;3905;3907.843686252518;3920.176762879713;3938.369860822255;5683.460071293221;5709.7430615623225;5719.598698318939;5767.865889620867;5780.508656764222;5378.220158076979;5559.44405559457;5581.776728930798;5609.691466969356;5634.492895639412;5549.529374715623;5558.91661625084;5560.332760068818;5579.916301255404;5588.888222235451;5228.640553456053;5316;5463.617546771688;5494.945050549603;5507;5568.77724891016;5570.022641962045;5577.693226872561;5585.301837270341;5595.440455954372;5418.783248670009;5454.890902182014;5455.1544510600925;5459.39946605881;5462.508374246337 04:42:28 INFO - PROCESS | 14342 | |5;yui.html;773.7485317271888;815.4129027100488;825.9876101858476;842.7092653034705;856.8586183279757;15128.243587820607;15200.087994720325;15653.139077350741;15829.762553561706;16300;15319.846801531981;15468.767968480483;15497.07017578946;15521;15534.689306213897;682.3108660253155;779.0729032451364;804.5293503300576;807.3057170833064;814.8573999550084;807.5719868469721;809.0534075132109;810.0481933727875;813.2274339377615;813.2477458351002;834.2700137379793;839.5508403004363;840.7351684219451;841.7011960753936;841.7769291137853;707.762899428692;817.207308910356;836.3351135846985;837.1126605797813;837.4723923927886;615.6275453350748;616.1189499016405;616.1251023546574;616.414406313999;616.5375968023982;14898.627534311621;14930;14940;14949.103053816805;14955.177465239407;13202.273874936971;13375.26436046017;13377.464901403931;13645.931770341183;13947;12336.691582710415;12519.56181533651;12548.749025019448;12555.906895473374;12822.23066616006;4224.662027037861;4271.1671224111315;4289.528151903288;4443.089166720814;4448.510663826976;62544;62989.055164172576;63270.367296326905;63670.68164659193;63738.362616373706;10686.389645436208;10815.513301901434;11014.44927753609;11095.889041109647;11147.832782508269;19526.31657891967;19601.901990489958;19617.901910490356;19628.313009044614;19633;8108.75673729789;8114.107448180695;8178.3048440882;8235.629396677165;8395.748127556182;4807.61539076873;4817.181079216542;4862.489438608965;4895.069936712013;4959.876003099951;3437.793732376015;3441.7074548663645;3526.100844284691;3533.2756784859043;3535.3459609972238;654.3783405764448;657.4181849063613;659.7756762700704;672.3545396419395;680.7685386968355;761.6762875777772;773.8916551682769;779.123486078162;788.2078511096312;804.9678012879419;9928.305018648769;10642;10642.361458312525;10705.732356690989;10712.303700259614;627.5701144715885;720.3404525164781;724.0742299901426;733.5598640815575;747.2639450141606;4650.465196502378;4763.880902977453;4767.141914455362;4778.641601879804;4855.223164293767;75975;76056.61971690106;76249.23750762532;76598;78359.21640783519;66376;67006.32993670099;67940.6602966982;68200;69746;60025.699871500365;60723.69638151781;60733.69633151806;60995.39004609897;61554.38445615487;9368.81262374735;9386.15524602789;9461.526923653651;9491.762705932408;9502.85745713801;36378.27243455169;38805.80597096997;39382.60617393789;39888.2022359557;40317.39523907085;51138;52172.47827521676;52179;52467;53115.734421327645;12275.570355037531;12316.137870349348;12470.1270911039;12581.714733184965;12745.299008554619;13953.930230348784;14526.564203073925;14589.416423342947;14646.26768661584;14732.55802325932;8543;13073.869261307265;13258.53595124166;13497.122687025312;13816.861831381557;13131.803022954855;13388.129771564818;13657;13717.245551494763;13926.442942282196;13138.120229007422;13319.733605328032;13455.327233638083;13603.455861765418;13796.172229666252;11035.44822758875;11209.88790112121;11347;11372.601958931398;11395.145592499755;11018.50416731233;11416.600418985296;11613.777842016148;11837.526498939946;11931.880681193077 04:42:28 INFO - PROCESS | 14342 | __end_tp_report 04:42:28 INFO - PROCESS | 14342 | __start_cc_report 04:42:28 INFO - PROCESS | 14342 | _x_x_mozilla_cycle_collect,754 04:42:28 INFO - PROCESS | 14342 | __end_cc_report 04:42:28 INFO - PROCESS | 14342 | __startTimestamp1464176548188__endTimestamp 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | ------- Summary: start ------- 04:42:28 INFO - PROCESS | 14342 | Number of tests: 6 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#0] dojo.html Cycles:165 Average:5374.68 Median:5578.55 stddev:610.78 (10.9%) stddev-sans-first:586.28 04:42:28 INFO - PROCESS | 14342 | Values: 3111.6 3113.9 3125.0 3174.5 3189.4 5265.6 5331.8 5353.8 5438.9 5470.4 5379.7 5382.7 5388.9 5444.3 5464.3 4825.2 4840.7 4990.3 5039.3 5065.1 4972.1 5001.6 5014.6 5033.4 5036.1 4763.9 4847.0 4869.9 4902.3 4935.0 4878.7 4885.6 4902.1 4903.0 4942.8 4832.2 4850.7 4889.8 4898.1 4918.4 5219.0 5247.9 5297.0 5324.7 5371.9 5766.0 5814.1 5819.4 5819.6 5829.8 5586.9 5822.0 5867.9 5876.7 5876.7 5366.5 5429.5 5436.0 5458.1 5501.7 5912.7 5945.6 5954.7 5964.8 5991.7 5514.4 5636.7 5760.0 5770.0 5778.6 5751.4 5817.0 5817.3 5872.2 5877.9 5779.1 5779.6 5785.1 5788.3 5790.4 5536.9 5593.3 5700.7 5804.9 5814.7 4408.4 4411.4 4413.0 4442.8 4452.2 3914.5 3915.4 3941.9 3965.3 3976.4 5363.2 5386.5 5416.8 5500.9 5544.7 5830.8 5854.1 5858.7 5884.4 5904.7 5506.9 5516.8 5517.8 5519.2 5521.9 4875.7 4970.6 5027.7 5043.0 5051.0 5922.8 5935.6 5946.4 5950.9 6005.1 5802.3 5808.0 5811.6 5818.4 5819.7 5809.8 5900.2 5939.0 5964.5 5980.2 5677.2 5715.0 5721.0 5724.9 5726.9 5760.4 5800.1 5815.4 5818.4 5825.7 5503.0 5626.2 5637.8 5685.7 5720.4 5693.7 5694.6 5702.8 5704.9 5706.9 5415.8 5627.3 5628.4 5633.3 5638.3 5581.9 5597.7 5630.9 5709.7 5721.9 5558.6 5564.6 5566.6 5578.6 5614.7 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#1] ext.html Cycles:180 Average:61438.45 Median:41326.09 stddev:122850.62 (297.3%) stddev-sans-first:123110.34 04:42:28 INFO - PROCESS | 14342 | Values: 604.7 622.4 623.2 637.6 639.8 38671.2 42266.6 42312.4 42353.8 42367.0 43717.6 44399.3 44424.8 44471.8 44497.0 8510.1 8734.3 8744.7 8750.6 8755.9 8672.3 8753.6 8765.6 8765.8 8770.4 8764.1 8783.7 8819.7 8826.5 8840.8 8758.8 8795.4 8798.9 8807.1 8809.9 8378.7 8469.1 8491.7 8497.2 8497.6 40784.0 40997.0 41281.4 41323.2 41359.8 2537.9 3593.9 3609.3 3777.0 3803.1 32477.0 32816.0 33033.7 34483.1 34501.0 4218.7 4238.7 4239.4 4246.1 4264.2 366081.0 367387.0 369846.0 369864.0 370267.0 50614.5 54514.7 55607.0 55700.0 58128.7 54714.7 54814.0 55020.0 55093.0 55125.4 15888.0 16032.7 16049.7 16053.0 16075.4 12316.5 12399.4 12408.6 12485.5 12537.2 17854.6 17942.1 17992.9 18067.8 18130.2 6584.4 6767.5 6976.1 7007.5 7058.0 1041.3 1129.4 1130.9 1140.9 1141.9 32552.7 32650.7 32691.7 32888.2 33484.3 1076.1 1155.9 1181.9 1202.3 1216.9 16478.6 16929.8 16947.7 16978.0 17241.5 553893.0 558076.0 558608.0 563020.0 569065.0 57588.1 57920.0 58079.4 58095.0 58135.4 1355.0 1362.9 1382.7 1383.1 1391.8 30257.8 31489.7 31608.2 31857.0 32438.2 50480.7 50773.0 50865.2 50878.7 50900.7 434863.0 438839.0 439229.0 441829.0 441969.0 35663.5 38728.8 39778.2 40250.4 40650.8 47908.0 48407.0 48619.0 49542.8 49708.5 40241.8 40276.8 40876.6 41310.8 41329.0 38808.6 39713.2 39723.4 40019.4 40578.4 40226.6 40657.2 41342.6 41497.8 41553.4 35564.5 36094.5 36636.0 36800.6 36828.4 27913.9 27971.6 28040.7 28211.0 28391.6 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#2] jquery.html Cycles:180 Average:26658.92 Median:2283.46 stddev:72044.80 (3155.1%) stddev-sans-first:72219.90 04:42:28 INFO - PROCESS | 14342 | Values: 388.3 389.0 396.1 401.9 411.0 13968.4 15632.5 18573.2 19238.2 19243.8 14344.8 17682.8 17711.3 17866.1 18151.5 5470.8 5513.2 5644.3 5653.5 5667.1 3454.8 5462.4 5560.5 5613.6 5999.9 6254.3 6351.6 6360.6 6373.4 6373.8 6086.9 6268.9 6329.3 6360.1 6374.6 5453.4 5458.3 5468.5 5472.4 5477.0 20993.5 21124.7 21459.4 22111.4 22127.9 2232.8 2334.1 2363.0 2447.7 2531.4 13120.4 13635.7 13749.3 14141.3 14288.4 1934.6 1981.9 1994.5 2024.3 2026.4 73452.0 75834.2 75837.0 76758.8 76972.6 10046.2 10340.5 10419.9 10509.3 10610.3 14453.3 14510.6 14549.4 14562.6 14574.1 7301.3 7651.3 7859.3 7986.4 8135.3 7826.3 7891.4 7989.0 7997.5 8175.8 6372.3 6473.7 6497.9 6510.2 6557.7 1888.4 1910.6 1916.6 1931.4 1965.5 980.9 1002.9 1057.2 1090.6 1121.4 18807.0 18882.2 18996.0 19158.1 19437.9 1016.4 1019.1 1037.1 1057.8 1103.8 10517.4 10975.5 11008.5 11050.2 11094.8 430001.0 437036.0 437841.0 438732.0 443576.0 78362.6 82257.6 82438.6 83504.0 84028.0 1054.8 1077.2 1093.5 1102.7 1118.2 16457.8 16868.5 16896.0 17120.5 17458.4 37750.8 37879.8 37997.2 38522.0 39689.8 47763.5 50328.2 52098.2 52173.7 52505.7 8451.0 8483.4 8564.1 8593.9 8747.8 7790.2 10818.9 13257.1 13363.1 13527.5 11255.9 11269.3 11481.0 11746.9 11762.1 11029.7 11081.9 11596.8 11636.0 11661.8 6027.1 8135.1 8872.0 10279.3 11901.2 8304.9 8343.7 8538.1 8636.5 8750.6 11067.9 11606.2 11669.1 11686.5 11727.2 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#3] mootools.html Cycles:180 Average:5463.07 Median:4775.31 stddev:3018.54 (63.2%) stddev-sans-first:3011.01 04:42:28 INFO - PROCESS | 14342 | Values: 1328.1 1436.5 1469.8 1599.2 1776.6 7746.7 8086.9 8099.8 8290.1 8309.1 8046.8 8223.1 8227.4 8232.5 8250.3 1941.9 2205.8 2232.9 2269.0 2274.3 2245.5 2264.8 2275.9 2276.1 2276.4 2191.0 2240.5 2246.1 2246.4 2246.5 1904.7 2148.6 2217.0 2222.7 2236.6 2139.1 2159.6 2165.4 2172.2 2172.7 8138.1 8181.5 8190.7 8203.5 8235.2 4842.4 4983.8 4984.9 4985.8 4988.1 3372.2 3390.5 3421.3 3510.8 3514.8 1092.2 1103.6 1126.9 1147.1 1196.4 11135.7 11154.9 11172.2 11179.6 11181.3 4307.5 4392.6 4448.6 4485.2 4490.2 9492.5 9500.7 9511.8 9516.5 9518.6 4483.2 4979.5 4983.7 4985.3 4989.1 4546.1 4699.1 4700.4 4714.6 4716.6 3708.9 3756.2 3807.5 3849.5 3882.1 1232.3 1248.6 1250.6 1257.1 1272.9 960.5 960.8 963.4 973.7 999.5 5559.0 5600.0 5664.6 5765.9 5895.3 1003.1 1053.3 1071.9 1090.3 1094.3 4073.8 4150.6 4151.2 4156.9 4189.0 10042.2 10234.0 10313.1 10321.1 10321.1 10147.8 10223.1 10225.7 10244.2 10247.9 7392.6 7609.5 7624.0 7642.5 7829.4 5360.4 5539.5 5678.4 5736.0 5846.0 8731.3 9091.8 9222.1 9229.8 9271.2 9332.0 9427.9 9430.0 9455.4 9479.5 7110.9 7551.1 7806.6 7828.3 7963.0 8003.0 8003.1 8085.6 8091.6 8100.2 7123.3 7296.2 7311.5 7431.1 7481.1 7188.9 7196.7 7216.0 7237.9 7337.4 6402.3 6486.4 6488.1 6489.0 6490.4 4685.7 4731.9 4795.8 4816.2 4915.4 4672.4 4711.8 4760.6 4790.0 4871.4 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#4] prototype.html Cycles:180 Average:4641.15 Median:5379.21 stddev:1389.96 (25.8%) stddev-sans-first:1355.44 04:42:28 INFO - PROCESS | 14342 | Values: 317.2 317.7 325.0 325.5 325.6 5286.4 5289.5 5314.0 5341.7 5364.0 5173.7 5187.1 5253.8 5265.0 5289.6 3885.6 3982.3 4098.9 4107.5 4114.0 4063.3 4096.3 4096.3 4106.0 4114.9 3933.3 4075.8 4078.4 4079.1 4083.9 3999.8 4092.7 4112.0 4114.7 4121.4 3592.9 3606.6 3609.4 3631.8 3634.4 5102.5 5104.8 5106.1 5123.4 5129.3 4473.0 4699.4 4700.5 4729.2 4737.8 5424.4 5444.4 5448.5 5468.1 5538.6 3741.7 3906.8 3961.7 3969.9 3970.9 5644.9 5661.4 5669.0 5672.7 5685.2 3840.8 3857.1 3857.2 3870.7 3876.8 3862.6 3924.1 3936.3 3937.8 3954.2 4480.6 4512.0 4519.1 4531.3 4539.6 5464.8 5474.9 5486.2 5500.7 5511.8 1368.5 1393.3 1393.9 1395.0 1395.9 890.3 894.7 901.0 908.7 909.5 5281.6 5380.2 5399.2 5399.5 5432.8 5701.7 5715.3 5728.9 5730.3 5741.1 5181.7 5370.4 5396.4 5419.5 5431.3 3010.2 3026.4 3030.7 3030.8 3045.4 5629.8 5834.1 5840.6 5843.3 5916.0 5815.4 5838.4 5843.1 5846.6 5854.8 5870.1 5899.2 5907.2 5909.2 5937.3 5527.0 5699.4 5711.9 5712.3 5773.3 5635.4 5650.9 5653.7 5664.6 5668.7 5613.5 5849.8 5899.0 5904.2 5929.5 3873.0 3905.0 3907.8 3920.2 3938.4 5683.5 5709.7 5719.6 5767.9 5780.5 5378.2 5559.4 5581.8 5609.7 5634.5 5549.5 5558.9 5560.3 5579.9 5588.9 5228.6 5316.0 5463.6 5494.9 5507.0 5568.8 5570.0 5577.7 5585.3 5595.4 5418.8 5454.9 5455.2 5459.4 5462.5 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - PROCESS | 14342 | [#5] yui.html Cycles:180 Average:16780.55 Median:4772.89 stddev:20699.52 (433.7%) stddev-sans-first:20722.69 04:42:28 INFO - PROCESS | 14342 | Values: 773.7 815.4 826.0 842.7 856.9 15128.2 15200.1 15653.1 15829.8 16300.0 15319.8 15468.8 15497.1 15521.0 15534.7 682.3 779.1 804.5 807.3 814.9 807.6 809.1 810.0 813.2 813.2 834.3 839.6 840.7 841.7 841.8 707.8 817.2 836.3 837.1 837.5 615.6 616.1 616.1 616.4 616.5 14898.6 14930.0 14940.0 14949.1 14955.2 13202.3 13375.3 13377.5 13645.9 13947.0 12336.7 12519.6 12548.7 12555.9 12822.2 4224.7 4271.2 4289.5 4443.1 4448.5 62544.0 62989.1 63270.4 63670.7 63738.4 10686.4 10815.5 11014.4 11095.9 11147.8 19526.3 19601.9 19617.9 19628.3 19633.0 8108.8 8114.1 8178.3 8235.6 8395.7 4807.6 4817.2 4862.5 4895.1 4959.9 3437.8 3441.7 3526.1 3533.3 3535.3 654.4 657.4 659.8 672.4 680.8 761.7 773.9 779.1 788.2 805.0 9928.3 10642.0 10642.4 10705.7 10712.3 627.6 720.3 724.1 733.6 747.3 4650.5 4763.9 4767.1 4778.6 4855.2 75975.0 76056.6 76249.2 76598.0 78359.2 66376.0 67006.3 67940.7 68200.0 69746.0 60025.7 60723.7 60733.7 60995.4 61554.4 9368.8 9386.2 9461.5 9491.8 9502.9 36378.3 38805.8 39382.6 39888.2 40317.4 51138.0 52172.5 52179.0 52467.0 53115.7 12275.6 12316.1 12470.1 12581.7 12745.3 13953.9 14526.6 14589.4 14646.3 14732.6 8543.0 13073.9 13258.5 13497.1 13816.9 13131.8 13388.1 13657.0 13717.2 13926.4 13138.1 13319.7 13455.3 13603.5 13796.2 11035.4 11209.9 11347.0 11372.6 11395.1 11018.5 11416.6 11613.8 11837.5 11931.9 04:42:28 INFO - PROCESS | 14342 | -------- Summary: end -------- 04:42:28 INFO - PROCESS | 14342 | 04:42:28 INFO - TEST-INFO | 14342: exit 0 04:42:28 INFO - TEST-OK | dromaeo_css | took 1112202ms 04:42:28 INFO - TEST-START | kraken 04:42:28 INFO - operating with platform_type : linux_ 04:42:28 INFO - Initialising browser for kraken test... 04:42:28 INFO - TEST-INFO | started process 14524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5WQnTq/profile http://localhost:52515/getInfo.html) 04:42:32 INFO - PROCESS | 14524 | __metrics Screen width/height:1600/1200 04:42:32 INFO - PROCESS | 14524 | colorDepth:24 04:42:32 INFO - PROCESS | 14524 | Browser inner width/height: 1024/697 04:42:32 INFO - PROCESS | 14524 | __metrics 04:42:33 ERROR - PROCESS | 14524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:42:34 INFO - TEST-INFO | 14524: exit 0 04:42:34 INFO - Browser initialized. 04:42:34 INFO - Running cycle 1/1 for kraken test... 04:42:34 INFO - TEST-INFO | started process 14607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5WQnTq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:46 INFO - PROCESS | 14607 | RSS: Main: 155185152 04:42:46 INFO - PROCESS | 14607 | 04:42:48 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52515/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:49 INFO - PROCESS | 14607 | RSS: Main: 211173376 04:42:49 INFO - PROCESS | 14607 | 04:42:52 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52515/tests/kraken/driver.html?testName=audio-dft) 04:42:53 INFO - PROCESS | 14607 | RSS: Main: 199319552 04:42:53 INFO - PROCESS | 14607 | 04:42:56 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52515/tests/kraken/driver.html?testName=audio-fft) 04:42:56 INFO - PROCESS | 14607 | RSS: Main: 268091392 04:42:56 INFO - PROCESS | 14607 | 04:42:58 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52515/tests/kraken/driver.html?testName=audio-oscillator) 04:42:59 INFO - PROCESS | 14607 | RSS: Main: 176701440 04:42:59 INFO - PROCESS | 14607 | 04:43:01 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:02 INFO - PROCESS | 14607 | RSS: Main: 181825536 04:43:02 INFO - PROCESS | 14607 | 04:43:05 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52515/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:05 INFO - PROCESS | 14607 | RSS: Main: 217038848 04:43:05 INFO - PROCESS | 14607 | 04:43:09 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52515/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:09 INFO - PROCESS | 14607 | RSS: Main: 217300992 04:43:09 INFO - PROCESS | 14607 | 04:43:12 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52515/tests/kraken/driver.html?testName=json-parse-financial) 04:43:13 INFO - PROCESS | 14607 | RSS: Main: 218193920 04:43:13 INFO - PROCESS | 14607 | 04:43:14 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:15 INFO - PROCESS | 14607 | RSS: Main: 205422592 04:43:15 INFO - PROCESS | 14607 | 04:43:17 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:17 INFO - PROCESS | 14607 | RSS: Main: 207740928 04:43:17 INFO - PROCESS | 14607 | 04:43:19 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:20 INFO - PROCESS | 14607 | RSS: Main: 218431488 04:43:20 INFO - PROCESS | 14607 | 04:43:22 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:23 INFO - PROCESS | 14607 | RSS: Main: 226422784 04:43:23 INFO - PROCESS | 14607 | 04:43:26 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:26 INFO - PROCESS | 14607 | RSS: Main: 223821824 04:43:26 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | Cycle 1(1): loaded http://localhost:52515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52515/tests/kraken/driver.html?testName=ai-astar) 04:43:28 INFO - PROCESS | 14607 | RSS: Main: 270053376 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | __start_tp_report 04:43:28 INFO - PROCESS | 14607 | _x_x_mozilla_page_load 04:43:28 INFO - PROCESS | 14607 | _x_x_mozilla_page_load_details 04:43:28 INFO - PROCESS | 14607 | |i|pagename|runs| 04:43:28 INFO - PROCESS | 14607 | |0;ai-astar;110;107;111;109;111;111;111;109;110;110 04:43:28 INFO - PROCESS | 14607 | |1;audio-beat-detection;163;125;130;171;130;125;152;131;184;128 04:43:28 INFO - PROCESS | 14607 | |2;audio-dft;162;159;160;161;160;161;161;162;162;160 04:43:28 INFO - PROCESS | 14607 | |3;audio-fft;74;74;73;115;75;75;75;76;97;74 04:43:28 INFO - PROCESS | 14607 | |4;audio-oscillator;82;83;122;83;82;83;116;82;83;122 04:43:28 INFO - PROCESS | 14607 | |5;imaging-gaussian-blur;116;116;116;117;116;117;116;117;117;116 04:43:28 INFO - PROCESS | 14607 | |6;imaging-darkroom;145;146;145;146;146;148;145;145;145;145 04:43:28 INFO - PROCESS | 14607 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;94 04:43:28 INFO - PROCESS | 14607 | |8;json-parse-financial;53;53;54;54;52;54;53;67;51;53 04:43:28 INFO - PROCESS | 14607 | |9;json-stringify-tinderbox;60;61;61;60;62;61;61;62;63;62 04:43:28 INFO - PROCESS | 14607 | |10;stanford-crypto-aes;78;78;78;78;79;79;80;81;80;86 04:43:28 INFO - PROCESS | 14607 | |11;stanford-crypto-ccm;120;127;119;128;118;126;132;118;160;122 04:43:28 INFO - PROCESS | 14607 | |12;stanford-crypto-pbkdf2;168;162;164;163;165;162;164;167;161;163 04:43:28 INFO - PROCESS | 14607 | |13;stanford-crypto-sha256-iterative;71;63;63;63;64;67;62;61;62;62 04:43:28 INFO - PROCESS | 14607 | __end_tp_report 04:43:28 INFO - PROCESS | 14607 | __start_cc_report 04:43:28 INFO - PROCESS | 14607 | _x_x_mozilla_cycle_collect,1691 04:43:28 INFO - PROCESS | 14607 | __end_cc_report 04:43:28 INFO - PROCESS | 14607 | __startTimestamp1464176608792__endTimestamp 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | ------- Summary: start ------- 04:43:28 INFO - PROCESS | 14607 | Number of tests: 14 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.29 (1.2%) stddev-sans-first:1.36 04:43:28 INFO - PROCESS | 14607 | Values: 110.0 107.0 111.0 109.0 111.0 111.0 111.0 109.0 110.0 110.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:141.50 stddev:21.84 (15.4%) stddev-sans-first:22.04 04:43:28 INFO - PROCESS | 14607 | Values: 163.0 125.0 130.0 171.0 130.0 125.0 152.0 131.0 184.0 128.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 04:43:28 INFO - PROCESS | 14607 | Values: 162.0 159.0 160.0 161.0 160.0 161.0 161.0 162.0 162.0 160.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.97 (18.6%) stddev-sans-first:14.60 04:43:28 INFO - PROCESS | 14607 | Values: 74.0 74.0 73.0 115.0 75.0 75.0 75.0 76.0 97.0 74.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:82.50 stddev:18.16 (22.0%) stddev-sans-first:18.75 04:43:28 INFO - PROCESS | 14607 | Values: 82.0 83.0 122.0 83.0 82.0 83.0 116.0 82.0 83.0 122.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:43:28 INFO - PROCESS | 14607 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 04:43:28 INFO - PROCESS | 14607 | Values: 145.0 146.0 145.0 146.0 146.0 148.0 145.0 145.0 145.0 145.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:43:28 INFO - PROCESS | 14607 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:4.53 (8.5%) stddev-sans-first:4.77 04:43:28 INFO - PROCESS | 14607 | Values: 53.0 53.0 54.0 54.0 52.0 54.0 53.0 67.0 51.0 53.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 04:43:28 INFO - PROCESS | 14607 | Values: 60.0 61.0 61.0 60.0 62.0 61.0 61.0 62.0 63.0 62.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.45 (3.1%) stddev-sans-first:2.52 04:43:28 INFO - PROCESS | 14607 | Values: 78.0 78.0 78.0 78.0 79.0 79.0 80.0 81.0 80.0 86.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.50 stddev:12.54 (9.9%) stddev-sans-first:13.05 04:43:28 INFO - PROCESS | 14607 | Values: 120.0 127.0 119.0 128.0 118.0 126.0 132.0 118.0 160.0 122.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:2.23 (1.4%) stddev-sans-first:1.81 04:43:28 INFO - PROCESS | 14607 | Values: 168.0 162.0 164.0 163.0 165.0 162.0 164.0 167.0 161.0 163.0 04:43:28 INFO - PROCESS | 14607 | 04:43:28 INFO - PROCESS | 14607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.01 (4.8%) stddev-sans-first:1.73 04:43:28 INFO - PROCESS | 14607 | Values: 71.0 63.0 63.0 63.0 64.0 67.0 62.0 61.0 62.0 62.0 04:43:28 INFO - PROCESS | 14607 | -------- Summary: end -------- 04:43:28 INFO - PROCESS | 14607 | 04:43:29 INFO - TEST-INFO | 14607: exit 0 04:43:29 INFO - TEST-OK | kraken | took 60883ms 04:43:29 INFO - SUITE-END | took 1173s 04:43:29 INFO - Completed test suite (00:19:33) 04:43:29 INFO - javascript benchmark 04:43:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.6110486189227, 3113.891013814516, 3124.9531257031135, 3174.5079512675543, 3189.409959157556, 5265.552428043621, 5331.813386531472, 5353.7590808413615, 5438.8912221755545, 5470.370907345651, 5379.6503227290195, 5382.703951282678, 5388.946110538894, 5444.3194600674815, 5464.289642346489, 4825.179719447694, 4840.685355451885, 4990.27640992056, 5039.294498770175, 5065.088284108859, 4972.055309491203, 5001.574866136383, 5014.598832093424, 5033.446320904697, 5036.143855544567, 4763.90472190556, 4846.975765121169, 4869.902601947977, 4902.338184345103, 4934.950650493485, 4878.707277563358, 4885.633577481668, 4902.068606964665, 4903.043906438246, 4942.827001054981, 4832.202686556714, 4850.660453768238, 4889.804407823718, 4898.069366820293, 4918.360613120271, 5219.034478621467, 5247.921281180786, 5297.046531624306, 5324.733763311819, 5371.946280537184, 5765.971170144165, 5814.127880817869, 5819.418058194189, 5819.592628516006, 5829.766809327622, 5586.944130558683, 5822.0, 5867.8533036674, 5876.676782776945, 5876.676782776945, 5366.490183432567, 5429.484199001088, 5435.972820135914, 5458.099413596791, 5501.724913754297, 5912.674802885883, 5945.643261404243, 5954.672493012839, 5964.7912323068485, 5991.730372133265, 5514.393416724157, 5636.689982051026, 5759.971200143972, 5770.0, 5778.624389414758, 5751.424857514299, 5817.040188368872, 5817.272840894888, 5872.207252021008, 5877.853053673693, 5779.104238842986, 5779.566532510079, 5785.103308987113, 5788.334341550775, 5790.420957904176, 5536.861578460571, 5593.272874526367, 5700.714964251853, 5804.854878628068, 5814.738336774771, 4408.360787685831, 4411.426514553152, 4413.0, 4442.777861106932, 4452.154090722753, 3914.4715463412645, 3915.3735402335487, 3941.8620348288246, 3965.325894597925, 3976.443297938291, 5363.249145119687, 5386.542143917733, 5416.83749487516, 5500.889982200333, 5544.69504177266, 5830.766769329264, 5854.121881717776, 5858.681796595817, 5884.382139875337, 5904.675242861598, 5506.889862202734, 5516.834494965157, 5517.834464966058, 5519.227308176858, 5521.889562208733, 4875.68308059975, 4970.577500912391, 5027.698338099725, 5042.974785126051, 5051.015052064886, 5922.822315330547, 5935.643861368331, 5946.375630558729, 5950.851228719317, 6005.069214271794, 5802.303723553201, 5808.0, 5811.593188476935, 5818.359980402237, 5819.6508209507565, 5809.796657116981, 5900.232969714081, 5939.049752039826, 5964.463198311999, 5980.192673988956, 5677.233573467529, 5715.0, 5721.0, 5724.856878578069, 5726.885462290647, 5760.366359700513, 5800.100984347433, 5815.447532484407, 5818.359980402237, 5825.70871456417, 5502.972485137549, 5626.24045753818, 5637.830865074055, 5685.687287199244, 5720.427957204412, 5693.686847223276, 5694.629849059798, 5702.800401985911, 5704.9429505706075, 5706.857328566819, 5415.756290966837, 5627.268455100974, 5628.437156284339, 5633.295838020247, 5638.295213098363, 5581.860453488695, 5597.6641401516035, 5630.85922851932, 5709.65742055478, 5721.942780572141, 5558.555315574825, 5564.610477266714, 5566.582506311962, 5578.553715702815, 5614.69119198448], "value": 5333.523950717206, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.7218279591387, 622.4056026494698, 623.2489849731074, 637.5664548107285, 639.7504973060508, 38671.22657546847, 42266.57733422665, 42312.36531452023, 42353.78823105884, 42367.0, 43717.562824371744, 44399.3340099898, 44424.77787611057, 44471.77764111183, 44497.0, 8510.106438823927, 8734.301255899512, 8744.693935712252, 8750.606222719993, 8755.912440875605, 8672.306215502776, 8753.649854005864, 8765.649374025032, 8765.824683506326, 8770.429922055078, 8764.079771623983, 8783.692570760024, 8819.735407937773, 8826.470411775283, 8840.823183536326, 8758.824823503526, 8795.384323097385, 8798.912010879905, 8807.075257097977, 8809.911900881038, 8378.748637540884, 8469.068402475723, 8491.74524764258, 8497.235248827574, 8497.61760720769, 40784.0, 40997.0, 41281.38077928834, 41323.1735365291, 41359.793201033805, 2537.936551586225, 3593.8921832345072, 3609.2961872434885, 3777.017975326435, 3803.0682482791617, 32477.0, 32816.0, 33033.6696633033, 34483.13792155191, 34501.0, 4218.6835987300765, 4238.7032907696475, 4239.394030118864, 4246.108317253381, 4264.211120942605, 366081.0, 367387.0, 369846.0, 369864.0, 370266.9999999973, 50614.493855061715, 54514.72742636262, 55607.0, 55700.0, 58128.70935645295, 54714.72642636761, 54814.0, 55020.0, 55093.0, 55125.44874551203, 15888.0, 16032.679346413006, 16049.679006419807, 16053.0, 16075.356985720675, 12316.507339706312, 12399.442025108712, 12408.56570020045, 12485.50057997688, 12537.24776513394, 17854.642907141784, 17942.102894855467, 17992.91003544974, 18067.819321806877, 18130.184141713653, 6584.440322572539, 6767.526273160832, 6976.127984002, 7007.474439417064, 7057.964710176417, 1041.3491567770143, 1129.3854726308568, 1130.9434528273553, 1140.9144314176303, 1141.9143564232716, 32552.674473255436, 32650.673493264763, 32691.673083268863, 32888.177795555304, 33484.3303133936, 1076.1337123615565, 1155.861296644408, 1181.8818118188112, 1202.3387137074749, 1216.920900141488, 16478.588035299214, 16929.830701692827, 16947.745783813254, 16978.0, 17241.482755517354, 553893.0, 558076.0, 558608.0, 563020.0, 569065.0, 57588.13617795736, 57920.0, 58079.41920580825, 58095.0, 58135.41864581384, 1354.9757221053455, 1362.9182249065088, 1382.6819831438625, 1383.1493631416606, 1391.8190635217356, 30257.848710756305, 31489.685103148677, 31608.209794754395, 31857.0, 32438.189045273113, 50480.74759626325, 50773.0, 50865.237021443965, 50878.74560627173, 50900.745496272284, 434863.0, 438839.0, 439229.0, 441829.0, 441969.0, 35663.46504802482, 38728.80635596804, 39778.2044359117, 40250.39624405577, 40650.79674601608, 47908.0, 48407.0, 48619.0, 49542.75228623834, 49708.502914970384, 40241.79879100586, 40276.79861600673, 40876.59123408728, 41310.79344603258, 41329.0, 38808.6119138805, 39713.20573588454, 39723.40414893721, 40019.3997090038, 40578.39132413075, 40226.59773402228, 40657.1868562633, 41342.58657413508, 41497.79251103725, 41553.37669935014, 35564.466533002545, 36094.45858312075, 36636.0, 36800.63199367972, 36828.44757328696, 27913.860430697718, 27971.58042629403, 28040.71959280381, 28211.0, 28391.574126388536], "value": 20178.74704351109, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.3340071776902, 388.97471664341833, 396.13839898221363, 401.8774273846477, 410.9527404348499, 13968.44126234952, 15632.452864149756, 18573.164207610673, 19238.23047078117, 19243.845369277835, 14344.784828227585, 17682.82317176828, 17711.29154833805, 17866.10669466528, 18151.45545633633, 5470.835874923749, 5513.228148059255, 5644.266245388094, 5653.4911857932775, 5667.149927510865, 3454.809985450799, 5462.371827239878, 5560.471755183251, 5613.578981576377, 5999.910001349983, 6254.312025677172, 6351.555391122623, 6360.586561873463, 6373.426391624753, 6373.776917807878, 6086.878262434727, 6268.937310626904, 6329.303776584572, 6360.109584658151, 6374.553781235315, 5453.3728621208675, 5458.263134476834, 5468.535174510172, 5472.370677372073, 5476.972615136939, 20993.475163121046, 21124.683129753066, 21459.356219313446, 22111.44721381962, 22127.889360553094, 2232.843700940935, 2334.0780391745334, 2363.0429675981254, 2447.6940382452194, 2531.4304281536506, 13120.409581568852, 13635.727285454235, 13749.31253437324, 14141.29293535319, 14288.357023933948, 1934.5840644261411, 1981.8711783734154, 1994.4914046918088, 2024.3016159424974, 2026.432598872318, 73452.0, 75834.24165758328, 75837.0, 76758.84861727079, 76972.61513692452, 10046.246531510165, 10340.482975851177, 10419.895801041892, 10509.31689440184, 10610.310329828537, 14453.349599268058, 14510.637234069232, 14549.418023279162, 14562.635934101732, 14574.052686575338, 7301.342879140902, 7651.273129052731, 7859.331956783737, 7986.3610911128135, 8135.3491720662205, 7826.256505631955, 7891.408144389079, 7988.960055199803, 7997.480163789335, 8175.836483270301, 6372.2671892732005, 6473.741050357933, 6497.870042599122, 6510.218773747086, 6557.737690492422, 1888.3579582941866, 1910.5987742574216, 1916.626257879728, 1931.430228082691, 1965.5282732144183, 980.9362391444533, 1002.9498525073717, 1057.2335057083706, 1090.5528733219342, 1121.3832392184265, 18807.0, 18882.24471021171, 18996.0, 19158.13788379526, 19437.902810485855, 1016.3749294184023, 1019.1031891935049, 1037.1288117980932, 1057.841323801436, 1103.758271944063, 10517.368957862553, 10975.451227438596, 11008.504617292241, 11050.226484146193, 11094.833577496343, 430001.0, 437036.0, 437841.0, 438732.0, 443576.0, 78362.6081869587, 82257.58871205605, 82438.58780706058, 83504.0, 84028.0, 1054.7732237568805, 1077.186724023373, 1093.5297821936645, 1102.735343517566, 1118.2060736876747, 16457.835421645632, 16868.53884419479, 16896.0, 17120.486385408458, 17458.388956386465, 37750.811245943594, 37879.81060094682, 37997.24005519819, 38522.0, 39689.80155099206, 47763.522364775905, 50328.24507632315, 52098.21852672137, 52173.7391313041, 52505.7374713124, 8450.957745211235, 8483.44857584255, 8564.143585641386, 8593.8710919335, 8747.781305467159, 7790.182030886675, 10818.945905270739, 13257.07200495956, 13363.1313964592, 13527.526536571173, 11255.943720281346, 11269.323840569592, 11481.0, 11746.941265293619, 11762.059035277329, 11029.724256893642, 11081.944590277319, 11596.826047609462, 11636.0, 11661.76676466449, 6027.095935609694, 8135.064467586303, 8871.955640221757, 10279.280450368402, 11901.226420282654, 8304.916950830415, 8343.66625335004, 8538.10349913275, 8636.481811091355, 8750.562471876254, 11067.944660276647, 11606.187566870238, 11669.12481563903, 11686.474108664961, 11727.179097463095], "value": 9095.114317172309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.0637150808682, 1436.454147423979, 1469.8015767871339, 1599.2483532739616, 1776.555861034742, 7746.690132394704, 8086.919130808697, 8099.838003239939, 8290.129536398666, 8309.086000539952, 8046.839063218732, 8223.136570660085, 8227.382946279038, 8232.506049637026, 8250.257476827084, 1941.8737782044122, 2205.790449907256, 2232.8771917544527, 2269.0, 2274.317704688595, 2245.5059886824874, 2264.830137739668, 2275.9089636414524, 2276.146445083094, 2276.3739971507885, 2190.9671354929687, 2240.5070884405486, 2246.1352379333994, 2246.359787460574, 2246.528229071897, 1904.7047707605343, 2148.6132496150763, 2216.966745498819, 2222.7110475638065, 2236.563870045342, 2139.1336508713994, 2159.6436587962967, 2165.447810808234, 2172.174573662014, 2172.73927128744, 8138.064122625915, 8181.468204566743, 8190.7133250335955, 8203.507789532647, 8235.21765432283, 4842.370491836074, 4983.775730092155, 4984.850454486371, 4985.750712464363, 4988.102141614508, 3372.224388390684, 3390.5253264542985, 3421.3157368526395, 3510.7717998330027, 3514.8242587870504, 1092.2245205903819, 1103.564092183591, 1126.9436528173558, 1147.0995268714018, 1196.3719047500044, 11135.721606959809, 11154.888451115467, 11172.162087843444, 11179.60871369498, 11181.273217240934, 4307.504636966726, 4392.604665580113, 4448.621867141329, 4485.215087359699, 4490.2142125127975, 9492.477913714674, 9500.667476638284, 9511.762205944768, 9516.524173791422, 9518.619255229853, 4483.21543729846, 4979.502049795064, 4983.6760610560195, 4985.252212168204, 4989.077020751172, 4546.113507866001, 4699.060187962421, 4700.412448443944, 4714.5521175488275, 4716.646251531149, 3708.9072773180346, 3756.2111956488898, 3807.4859893913967, 3849.4610754494392, 3882.0683036071705, 1232.2668012532529, 1248.6066888929959, 1250.5810553464692, 1257.1200159887933, 1272.853621833501, 960.500539719342, 960.8126415348939, 963.4026903319987, 973.6932866147282, 999.4503023337136, 5559.0, 5600.019996500596, 5664.603477756517, 5765.88468230633, 5895.263092113486, 1003.117256813999, 1053.2995557953875, 1071.908887744535, 1090.334895713614, 1094.2777766674117, 4073.816678249486, 4150.605692459211, 4151.190517848991, 4156.854510092193, 4189.0, 10042.246831487668, 10234.02776736209, 10313.071823535918, 10321.122704570045, 10321.122704570045, 10147.847782283272, 10223.079922806834, 10225.693229203136, 10244.180465562737, 10247.897521024843, 7392.630368481555, 7609.505382150142, 7624.0, 7642.5032372895585, 7829.41279404047, 5360.356757189163, 5539.529140022982, 5678.375378708256, 5736.0, 5845.970770146122, 8731.25784308341, 9091.818163636557, 9222.123898229658, 9229.815403692022, 9271.165595096474, 9332.0, 9427.905720942977, 9430.0, 9455.432674039304, 9479.526023698925, 7110.893336599852, 7551.131619863786, 7806.648700808364, 7828.334591559781, 7962.960185199037, 8003.0, 8003.079645840803, 8085.555294458862, 8091.595420228848, 8100.189981001853, 7123.287671232835, 7296.19741828409, 7311.524750891175, 7431.145418276751, 7481.102267727908, 7188.928110718826, 7196.748113815991, 7215.974661157992, 7237.8914316284245, 7337.376323012603, 6402.295747467868, 6486.383793539606, 6488.091667166695, 6488.967555162194, 6490.415862572391, 4685.742284174403, 4731.905361892812, 4795.808167673254, 4816.181249187716, 4915.3855768029, 4672.392588963549, 4711.8350857719815, 4760.6429517787, 4789.976050119727, 4871.391076115486], "value": 4432.902100441351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2117288537983, 317.65534395181226, 324.9512573114034, 325.4759836662973, 325.59626063681014, 5286.418493965665, 5289.523942845143, 5314.007247282269, 5341.706206158659, 5363.973180134104, 5173.741312934348, 5187.144121220003, 5253.842384728455, 5264.973675131629, 5289.61967114798, 3885.5531613864414, 3982.3030969580354, 4098.897527561805, 4107.466029416171, 4114.0, 4063.2686116499017, 4096.303628383167, 4096.32410652242, 4105.97947010266, 4114.897127571805, 3933.331333673282, 4075.7976396962817, 4078.3882417637296, 4079.1433798902267, 4083.917202226856, 3999.840006399755, 4092.6930480213955, 4111.958880411187, 4114.732542384735, 4121.443605113332, 3592.8742494012586, 3606.6032736398975, 3609.3864043112735, 3631.801505503204, 3634.3639863024127, 5102.540771330561, 5104.770285337132, 5106.08090543702, 5123.410807757118, 5129.307543481619, 4473.0, 4699.389079419688, 4700.5064468230685, 4729.219678753002, 4737.8104875805275, 5424.430434804328, 5444.373897001817, 5448.45515448456, 5468.070428027245, 5538.6399884007415, 3741.7193710471824, 3906.824192911326, 3961.6830653547936, 3969.940450893239, 3970.8808735737975, 5644.8871022579315, 5661.433856614347, 5668.987509434174, 5672.68800215988, 5685.214245019952, 3840.7887566183567, 3857.07430216746, 3857.1514266861245, 3870.6903447724117, 3876.770856757376, 3862.633049860259, 3924.136689928211, 3936.2717897189114, 3937.783421911822, 3954.209158168378, 4480.619147372445, 4511.962248682821, 4519.118771839526, 4531.342955271467, 4539.591436770706, 5464.7814087436855, 5474.91787623186, 5486.1770734389365, 5500.697461639568, 5511.807086751945, 1368.4936573467683, 1393.3381643719151, 1393.888488920884, 1394.9886332408923, 1395.9162450253018, 890.3366991591176, 894.7449976756593, 901.0, 908.7001289574424, 909.5497728624373, 5281.577473802086, 5380.192971054373, 5399.217113518518, 5399.487048730443, 5432.75552600134, 5701.660109874177, 5715.31416230055, 5728.885422291531, 5730.312362516524, 5741.1388291756575, 5181.689098654093, 5370.382406023279, 5396.354111995879, 5419.512243898068, 5431.266778984866, 3010.1571559963245, 3026.379592183597, 3030.65147508035, 3030.8029978051795, 3045.4365942300747, 5629.761452480448, 5834.082958520739, 5840.620359676693, 5843.298804143445, 5915.970420147958, 5815.418458154235, 5838.416158384128, 5843.123531470228, 5846.649201047866, 5854.824355269348, 5870.119482077637, 5899.2007437731045, 5907.202527658797, 5909.172715819875, 5937.287525496968, 5527.0, 5699.4300569944335, 5711.914321285101, 5712.285964254468, 5773.278340207474, 5635.351934527582, 5650.915236271377, 5653.689047102284, 5664.631798933056, 5668.744906479301, 5613.522850557748, 5849.766009359748, 5898.9705051476185, 5904.232449781673, 5929.52563794904, 3872.993021814292, 3905.0, 3907.843686252518, 3920.176762879713, 3938.369860822255, 5683.460071293221, 5709.7430615623225, 5719.598698318939, 5767.865889620867, 5780.508656764222, 5378.220158076979, 5559.44405559457, 5581.776728930798, 5609.691466969356, 5634.492895639412, 5549.529374715623, 5558.91661625084, 5560.332760068818, 5579.916301255404, 5588.888222235451, 5228.640553456053, 5316.0, 5463.617546771688, 5494.945050549603, 5507.0, 5568.77724891016, 5570.022641962045, 5577.693226872561, 5585.301837270341, 5595.440455954372, 5418.783248670009, 5454.890902182014, 5455.1544510600925, 5459.39946605881, 5462.508374246337], "value": 4193.504753391165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.7485317271888, 815.4129027100488, 825.9876101858476, 842.7092653034705, 856.8586183279757, 15128.243587820607, 15200.087994720325, 15653.139077350741, 15829.762553561706, 16300.0, 15319.846801531981, 15468.767968480483, 15497.07017578946, 15521.0, 15534.689306213897, 682.3108660253155, 779.0729032451364, 804.5293503300576, 807.3057170833064, 814.8573999550084, 807.5719868469721, 809.0534075132109, 810.0481933727875, 813.2274339377615, 813.2477458351002, 834.2700137379793, 839.5508403004363, 840.7351684219451, 841.7011960753936, 841.7769291137853, 707.762899428692, 817.207308910356, 836.3351135846985, 837.1126605797813, 837.4723923927886, 615.6275453350748, 616.1189499016405, 616.1251023546574, 616.414406313999, 616.5375968023982, 14898.627534311621, 14930.0, 14940.0, 14949.103053816805, 14955.177465239407, 13202.273874936971, 13375.26436046017, 13377.464901403931, 13645.931770341183, 13947.0, 12336.691582710415, 12519.56181533651, 12548.749025019448, 12555.906895473374, 12822.23066616006, 4224.662027037861, 4271.1671224111315, 4289.528151903288, 4443.089166720814, 4448.510663826976, 62544.0, 62989.055164172576, 63270.367296326905, 63670.68164659193, 63738.362616373706, 10686.389645436208, 10815.513301901434, 11014.44927753609, 11095.889041109647, 11147.832782508269, 19526.31657891967, 19601.901990489958, 19617.901910490356, 19628.313009044614, 19633.0, 8108.75673729789, 8114.107448180695, 8178.3048440882, 8235.629396677165, 8395.748127556182, 4807.61539076873, 4817.181079216542, 4862.489438608965, 4895.069936712013, 4959.876003099951, 3437.793732376015, 3441.7074548663645, 3526.100844284691, 3533.2756784859043, 3535.3459609972238, 654.3783405764448, 657.4181849063613, 659.7756762700704, 672.3545396419395, 680.7685386968355, 761.6762875777772, 773.8916551682769, 779.123486078162, 788.2078511096312, 804.9678012879419, 9928.305018648769, 10642.0, 10642.361458312525, 10705.732356690989, 10712.303700259614, 627.5701144715885, 720.3404525164781, 724.0742299901426, 733.5598640815575, 747.2639450141606, 4650.465196502378, 4763.880902977453, 4767.141914455362, 4778.641601879804, 4855.223164293767, 75975.0, 76056.61971690106, 76249.23750762532, 76598.0, 78359.21640783519, 66376.0, 67006.32993670099, 67940.6602966982, 68200.0, 69746.0, 60025.699871500365, 60723.69638151781, 60733.69633151806, 60995.39004609897, 61554.38445615487, 9368.81262374735, 9386.15524602789, 9461.526923653651, 9491.762705932408, 9502.85745713801, 36378.27243455169, 38805.80597096997, 39382.60617393789, 39888.2022359557, 40317.39523907085, 51138.0, 52172.47827521676, 52179.0, 52467.0, 53115.734421327645, 12275.570355037531, 12316.137870349348, 12470.1270911039, 12581.714733184965, 12745.299008554619, 13953.930230348784, 14526.564203073925, 14589.416423342947, 14646.26768661584, 14732.55802325932, 8543.0, 13073.869261307265, 13258.53595124166, 13497.122687025312, 13816.861831381557, 13131.803022954855, 13388.129771564818, 13657.0, 13717.245551494763, 13926.442942282196, 13138.120229007422, 13319.733605328032, 13455.327233638083, 13603.455861765418, 13796.172229666252, 11035.44822758875, 11209.88790112121, 11347.0, 11372.601958931398, 11395.145592499755, 11018.50416731233, 11416.600418985296, 11613.777842016148, 11837.526498939946, 11931.880681193077], "value": 7180.225381421606, "unit": "score"}], "name": "dromaeo_css", "value": 7123.517225396357, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 111.0, 109.0, 111.0, 111.0, 111.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 130.0, 171.0, 130.0, 125.0, 152.0, 131.0, 184.0, 128.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 115.0, 75.0, 75.0, 75.0, 76.0, 97.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 122.0, 83.0, 82.0, 83.0, 116.0, 82.0, 83.0, 122.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 148.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 52.0, 54.0, 53.0, 67.0, 51.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 62.0, 63.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 79.0, 80.0, 81.0, 80.0, 86.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 119.0, 128.0, 118.0, 126.0, 132.0, 118.0, 160.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 162.0, 164.0, 163.0, 165.0, 162.0, 164.0, 167.0, 161.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 63.0, 63.0, 64.0, 67.0, 62.0, 61.0, 62.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1495.9, "alertThreshold": 2.0}]} 04:43:30 INFO - Return code: 0 04:43:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:43:30 ERROR - # TBPL SUCCESS # 04:43:30 INFO - Running post-action listener: _resource_record_post_action 04:43:30 INFO - ##### 04:43:30 INFO - ##### Finished run-tests step (success) 04:43:30 INFO - ##### 04:43:30 INFO - Running post-run listener: _resource_record_post_run 04:43:30 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539254784; Read time: 8; Write time: 582892 04:43:30 INFO - TinderboxPrint: CPU usage
13.1% 04:43:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:43:30 INFO - TinderboxPrint: I/O write bytes / time
539,254,784 / 582,892 04:43:30 INFO - TinderboxPrint: CPU idle
8,257.2 (86.9%) 04:43:30 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 04:43:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:30 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 247173120; Read time: 0; Write time: 398664 04:43:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292081664; Read time: 8; Write time: 184228 04:43:30 INFO - Running post-run listener: _upload_blobber_files 04:43:30 INFO - Blob upload gear active. 04:43:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:30 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 04:43:30 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:30 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:31 INFO - (blobuploader) - INFO - Done attempting. 04:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:32 INFO - (blobuploader) - INFO - Done attempting. 04:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:39 INFO - (blobuploader) - INFO - Done attempting. 04:43:39 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:39 INFO - Return code: 0 04:43:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e8ddfe89efa054c1b69114efd8b7d731bf191f48ea4e7b26bfbca68452dc25c5e6a856adfa56fbf480d52ff322f27ab13a0073ca063abeb6ade9e18ac3f9932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be312bc70bc4b4bf39a9493ddb8193202990d1ff871f331cad4aec72dd2a452151eaf39e637be8ab6086b92d8f7048bdd454f562dfba3e3d156284fe3a3ff985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1bbf28b9c568ce0d30256dcd8a6927da69c6c990cb7012d185705c7b8e1b1b95c95f8a1ab184b29d65856fad7c1fdad53d275ef658f859165b64df9a043ffe5"} 04:43:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:39 INFO - Contents: 04:43:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e8ddfe89efa054c1b69114efd8b7d731bf191f48ea4e7b26bfbca68452dc25c5e6a856adfa56fbf480d52ff322f27ab13a0073ca063abeb6ade9e18ac3f9932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be312bc70bc4b4bf39a9493ddb8193202990d1ff871f331cad4aec72dd2a452151eaf39e637be8ab6086b92d8f7048bdd454f562dfba3e3d156284fe3a3ff985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1bbf28b9c568ce0d30256dcd8a6927da69c6c990cb7012d185705c7b8e1b1b95c95f8a1ab184b29d65856fad7c1fdad53d275ef658f859165b64df9a043ffe5"} 04:43:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:39 INFO - Copying logs to upload dir... 04:43:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.343827 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-25 04:43:38.867357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 04:43:38.870960) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e8ddfe89efa054c1b69114efd8b7d731bf191f48ea4e7b26bfbca68452dc25c5e6a856adfa56fbf480d52ff322f27ab13a0073ca063abeb6ade9e18ac3f9932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be312bc70bc4b4bf39a9493ddb8193202990d1ff871f331cad4aec72dd2a452151eaf39e637be8ab6086b92d8f7048bdd454f562dfba3e3d156284fe3a3ff985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1bbf28b9c568ce0d30256dcd8a6927da69c6c990cb7012d185705c7b8e1b1b95c95f8a1ab184b29d65856fad7c1fdad53d275ef658f859165b64df9a043ffe5"} build_url:https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/b3dIIW62TkCFCmNLSEV_pg/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/Mozilla-Inbound/sha512/9e8ddfe89efa054c1b69114efd8b7d731bf191f48ea4e7b26bfbca68452dc25c5e6a856adfa56fbf480d52ff322f27ab13a0073ca063abeb6ade9e18ac3f9932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be312bc70bc4b4bf39a9493ddb8193202990d1ff871f331cad4aec72dd2a452151eaf39e637be8ab6086b92d8f7048bdd454f562dfba3e3d156284fe3a3ff985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1bbf28b9c568ce0d30256dcd8a6927da69c6c990cb7012d185705c7b8e1b1b95c95f8a1ab184b29d65856fad7c1fdad53d275ef658f859165b64df9a043ffe5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 04:43:38.901304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:43:38.901673) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464175199.315646-348108812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:43:38.987621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 04:43:38.987947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 04:43:38.988255) ========= ========= Total master_lag: 0.27 =========