builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1464649854.12 results: success (0) buildid: 20160530133025 builduid: 575844494e154ced97d49ebb9ab0e03b revision: 09d0d424f914d064e30071fd85fc890e482fc79c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.123199) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.123699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.123982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.139110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.139591) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:10:54-- 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% 46.9M=0s 2016-05-30 16:10:54 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.266546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.266942) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016302 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:54.318158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:10:54.318521) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 09d0d424f914d064e30071fd85fc890e482fc79c --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 09d0d424f914d064e30071fd85fc890e482fc79c --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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:10:54,422 truncating revision to first 12 chars 2016-05-30 16:10:54,423 Setting DEBUG logging. 2016-05-30 16:10:54,423 attempt 1/10 2016-05-30 16:10:54,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/09d0d424f914?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:10:55,720 unpacking tar archive at: mozilla-inbound-09d0d424f914/testing/mozharness/ program finished with exit code 0 elapsedTime=1.613185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:10:55.946863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:55.947461) ========= script_repo_revision: 09d0d424f914d064e30071fd85fc890e482fc79c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:55.948167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:55.948505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:10:55.960192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 16:10:55.960656) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:10:56 INFO - MultiFileLogger online at 20160530 16:10:56 in /builds/slave/test 16:10:56 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 16:10:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:56 INFO - {'append_to_log': False, 16:10:56 INFO - 'base_work_dir': '/builds/slave/test', 16:10:56 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:10:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:56 INFO - 'branch': 'Mozilla-Inbound', 16:10:56 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:56 INFO - 'config_files': ('talos/linux_config.py',), 16:10:56 INFO - 'default_actions': ('clobber', 16:10:56 INFO - 'read-buildbot-config', 16:10:56 INFO - 'download-and-extract', 16:10:56 INFO - 'populate-webroot', 16:10:56 INFO - 'create-virtualenv', 16:10:56 INFO - 'install', 16:10:56 INFO - 'run-tests'), 16:10:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:56 INFO - 'download_minidump_stackwalk': True, 16:10:56 INFO - 'download_symbols': 'ondemand', 16:10:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:56 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:56 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:56 INFO - 'installer_path': 'installer.exe', 16:10:56 INFO - 'log_level': 'info', 16:10:56 INFO - 'log_name': 'talos', 16:10:56 INFO - 'log_to_console': True, 16:10:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:10:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:10:56 INFO - 'opt_config_files': (), 16:10:56 INFO - 'pip_index': False, 16:10:56 INFO - 'sps_profile': False, 16:10:56 INFO - 'sps_profile_interval': 0, 16:10:56 INFO - 'suite': 'dromaeojs', 16:10:56 INFO - 'system_bits': '32', 16:10:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:56 INFO - 'title': 'talos-linux64-ix-033', 16:10:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:56 INFO - 'use_talos_json': True, 16:10:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:56 INFO - 'work_dir': 'build'} 16:10:56 INFO - ##### 16:10:56 INFO - ##### Running clobber step. 16:10:56 INFO - ##### 16:10:56 INFO - Running pre-action listener: _resource_record_pre_action 16:10:56 INFO - Running main action method: clobber 16:10:56 INFO - rmtree: /builds/slave/test/build 16:10:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:56 INFO - Running post-action listener: _resource_record_post_action 16:10:56 INFO - ##### 16:10:56 INFO - ##### Finished clobber step (success) 16:10:56 INFO - ##### 16:10:56 INFO - ##### 16:10:56 INFO - ##### Running read-buildbot-config step. 16:10:56 INFO - ##### 16:10:56 INFO - Running pre-action listener: _resource_record_pre_action 16:10:56 INFO - Running main action method: read_buildbot_config 16:10:56 INFO - Using buildbot properties: 16:10:56 INFO - { 16:10:56 INFO - "project": "", 16:10:56 INFO - "product": "firefox", 16:10:56 INFO - "script_repo_revision": "production", 16:10:56 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:10:56 INFO - "repository": "", 16:10:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:10:56 INFO - "buildid": "20160530133025", 16:10:56 INFO - "pgo_build": "True", 16:10:56 INFO - "basedir": "/builds/slave/test", 16:10:56 INFO - "buildnumber": 1093, 16:10:56 INFO - "slavename": "talos-linux64-ix-033", 16:10:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:10:56 INFO - "platform": "ubuntu64_hw", 16:10:56 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:10:56 INFO - "branch": "mozilla-inbound", 16:10:56 INFO - "repo_path": "integration/mozilla-inbound", 16:10:56 INFO - "revision": "09d0d424f914d064e30071fd85fc890e482fc79c", 16:10:56 INFO - "stage_platform": "linux64-pgo", 16:10:56 INFO - "builduid": "575844494e154ced97d49ebb9ab0e03b", 16:10:56 INFO - "slavebuilddir": "test" 16:10:56 INFO - } 16:10:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:10:56 INFO - Running post-action listener: _resource_record_post_action 16:10:56 INFO - ##### 16:10:56 INFO - ##### Finished read-buildbot-config step (success) 16:10:56 INFO - ##### 16:10:56 INFO - ##### 16:10:56 INFO - ##### Running download-and-extract step. 16:10:56 INFO - ##### 16:10:56 INFO - Running pre-action listener: _resource_record_pre_action 16:10:56 INFO - Running main action method: download_and_extract 16:10:56 INFO - mkdir: /builds/slave/test/build/tests 16:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:56 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:10:57 INFO - Downloaded 1361 bytes. 16:10:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:57 INFO - Using the following test package requirements: 16:10:57 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:57 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:57 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:10:57 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'jsshell-linux-x86_64.zip'], 16:10:57 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:57 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:57 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:10:57 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:10:57 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:57 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10:57 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')]} 16:10:57 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:10:58 INFO - Downloaded 24412402 bytes. 16:10:58 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'] 16:10:58 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 16:10:59 INFO - Return code: 0 16:10:59 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 16:10: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')]} 16:10:59 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:11:00 INFO - Downloaded 24412402 bytes. 16:11: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'] 16:11: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 16:11:02 INFO - Return code: 0 16:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:02 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:11:03 INFO - Downloaded 10834055 bytes. 16:11:03 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'] 16:11:03 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 16:11:03 INFO - Return code: 0 16:11:03 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')]} 16:11:03 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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 16:11:05 INFO - Downloaded 58955371 bytes. 16:11:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:05 INFO - mkdir: /builds/slave/test/properties 16:11:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:05 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:05 INFO - Contents: 16:11:05 INFO - build_url:https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:05 INFO - Running post-action listener: _resource_record_post_action 16:11:05 INFO - Running post-action listener: set_extra_try_arguments 16:11:05 INFO - ##### 16:11:05 INFO - ##### Finished download-and-extract step (success) 16:11:05 INFO - ##### 16:11:05 INFO - ##### 16:11:05 INFO - ##### Running populate-webroot step. 16:11:05 INFO - ##### 16:11:05 INFO - Running pre-action listener: _resource_record_pre_action 16:11:05 INFO - Running main action method: populate_webroot 16:11:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:05 INFO - '--tppagecycles', 16:11:05 INFO - '7'], 16:11:05 INFO - 'tests': ['tsvgm']}}, 16:11:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['damp', 'tps']}, 16:11:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'tests': ['damp', 'tps']}, 16:11:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['dromaeo_dom']}, 16:11:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['a11yr', 16:11:05 INFO - 'ts_paint', 16:11:05 INFO - 'tpaint', 16:11:05 INFO - 'sessionrestore', 16:11:05 INFO - 'sessionrestore_no_auto_restore', 16:11:05 INFO - 'tabpaint']}, 16:11:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['tsvgx', 16:11:05 INFO - 'tsvgr_opacity', 16:11:05 INFO - 'tart', 16:11:05 INFO - 'tscrollx', 16:11:05 INFO - 'cart']}, 16:11:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:05 INFO - 'tsvgr_opacity', 16:11:05 INFO - 'tart', 16:11:05 INFO - 'tscrollx', 16:11:05 INFO - 'cart']}, 16:11:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'talos_options': ['--disable-e10s'], 16:11:05 INFO - 'tests': ['tp5o']}, 16:11:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'tests': ['tp5o']}, 16:11:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'talos_options': ['--disable-e10s', 16:11:05 INFO - '--xperf_path', 16:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:05 INFO - 'tests': ['tp5n']}, 16:11:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:05 INFO - 'talos_options': ['--xperf_path', 16:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:05 INFO - 'tests': ['tp5n']}}, 16:11:05 INFO - 'talos.zip': {'path': '', 16:11:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:05 INFO - Running post-action listener: _resource_record_post_action 16:11:05 INFO - ##### 16:11:05 INFO - ##### Finished populate-webroot step (success) 16:11:05 INFO - ##### 16:11:05 INFO - ##### 16:11:05 INFO - ##### Running create-virtualenv step. 16:11:05 INFO - ##### 16:11:05 INFO - Running pre-action listener: _resource_record_pre_action 16:11:05 INFO - Running main action method: create_virtualenv 16:11:05 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:05 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 16:11:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:06 INFO - Using real prefix '/usr' 16:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:06 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:08 INFO - Installing pip.................done. 16:11:08 INFO - Return code: 0 16:11:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:08 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:08 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 16:11:08 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 16:11:08 INFO - Using env: {'DISPLAY': ':0', 16:11:08 INFO - 'HOME': '/home/cltbld', 16:11:08 INFO - 'LANG': 'en_US.UTF-8', 16:11:08 INFO - 'LANGUAGE': 'en_US:en', 16:11:08 INFO - 'LOGNAME': 'cltbld', 16:11:08 INFO - 'MAIL': '/var/mail/cltbld', 16:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:08 INFO - 'MOZ_NO_REMOTE': '1', 16:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:08 INFO - 'NO_EM_RESTART': '1', 16:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:08 INFO - 'PWD': '/builds/slave/test', 16:11:08 INFO - 'SHELL': '/bin/bash', 16:11:08 INFO - 'SHLVL': '1', 16:11:08 INFO - 'TERM': 'linux', 16:11:08 INFO - 'TMOUT': '86400', 16:11:08 INFO - 'USER': 'cltbld', 16:11:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:08 INFO - '_': '/tools/buildbot/bin/python'} 16:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:08 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 16:11:08 INFO - Cleaning up... 16:11:08 INFO - Return code: 0 16:11:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:08 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:08 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 16:11:08 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 16:11:08 INFO - Using env: {'DISPLAY': ':0', 16:11:08 INFO - 'HOME': '/home/cltbld', 16:11:08 INFO - 'LANG': 'en_US.UTF-8', 16:11:08 INFO - 'LANGUAGE': 'en_US:en', 16:11:08 INFO - 'LOGNAME': 'cltbld', 16:11:08 INFO - 'MAIL': '/var/mail/cltbld', 16:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:08 INFO - 'MOZ_NO_REMOTE': '1', 16:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:08 INFO - 'NO_EM_RESTART': '1', 16:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:08 INFO - 'PWD': '/builds/slave/test', 16:11:08 INFO - 'SHELL': '/bin/bash', 16:11:08 INFO - 'SHLVL': '1', 16:11:08 INFO - 'TERM': 'linux', 16:11:08 INFO - 'TMOUT': '86400', 16:11:08 INFO - 'USER': 'cltbld', 16:11:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:08 INFO - '_': '/tools/buildbot/bin/python'} 16:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:09 INFO - Downloading/unpacking psutil>=3.1.1 16:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:11 INFO - Installing collected packages: psutil 16:11:11 INFO - Running setup.py install for psutil 16:11:11 INFO - building 'psutil._psutil_linux' extension 16:11:11 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 16:11:11 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 16:11:11 INFO - building 'psutil._psutil_posix' extension 16:11:11 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 16:11:11 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 16:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:11 INFO - Successfully installed psutil 16:11:11 INFO - Cleaning up... 16:11:11 INFO - Return code: 0 16:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:11 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:11 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 16:11:11 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 16:11:11 INFO - Using env: {'DISPLAY': ':0', 16:11:11 INFO - 'HOME': '/home/cltbld', 16:11:11 INFO - 'LANG': 'en_US.UTF-8', 16:11:11 INFO - 'LANGUAGE': 'en_US:en', 16:11:11 INFO - 'LOGNAME': 'cltbld', 16:11:11 INFO - 'MAIL': '/var/mail/cltbld', 16:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:11 INFO - 'MOZ_NO_REMOTE': '1', 16:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:11 INFO - 'NO_EM_RESTART': '1', 16:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:11 INFO - 'PWD': '/builds/slave/test', 16:11:11 INFO - 'SHELL': '/bin/bash', 16:11:11 INFO - 'SHLVL': '1', 16:11:11 INFO - 'TERM': 'linux', 16:11:11 INFO - 'TMOUT': '86400', 16:11:11 INFO - 'USER': 'cltbld', 16:11:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:11 INFO - '_': '/tools/buildbot/bin/python'} 16:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:11:13 INFO - Installing collected packages: mozsystemmonitor 16:11:13 INFO - Running setup.py install for mozsystemmonitor 16:11:13 INFO - Successfully installed mozsystemmonitor 16:11:13 INFO - Cleaning up... 16:11:13 INFO - Return code: 0 16:11:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:13 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')]} 16:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:13 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')]} 16:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:13 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:13 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 16:11:13 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 16:11:13 INFO - Using env: {'DISPLAY': ':0', 16:11:13 INFO - 'HOME': '/home/cltbld', 16:11:13 INFO - 'LANG': 'en_US.UTF-8', 16:11:13 INFO - 'LANGUAGE': 'en_US:en', 16:11:13 INFO - 'LOGNAME': 'cltbld', 16:11:13 INFO - 'MAIL': '/var/mail/cltbld', 16:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:13 INFO - 'MOZ_NO_REMOTE': '1', 16:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:13 INFO - 'NO_EM_RESTART': '1', 16:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:13 INFO - 'PWD': '/builds/slave/test', 16:11:13 INFO - 'SHELL': '/bin/bash', 16:11:13 INFO - 'SHLVL': '1', 16:11:13 INFO - 'TERM': 'linux', 16:11:13 INFO - 'TMOUT': '86400', 16:11:13 INFO - 'USER': 'cltbld', 16:11:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:13 INFO - '_': '/tools/buildbot/bin/python'} 16:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:14 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 16:11:14 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 16:11:14 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 16:11:14 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 16:11:14 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 16:11:14 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 16:11:15 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 INFO - Downloading docopt-0.6.1.tar.gz 16:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:16 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:16 INFO - Running setup.py install for blobuploader 16:11:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:16 INFO - Running setup.py install for requests 16:11:17 INFO - Running setup.py install for docopt 16:11:17 INFO - Successfully installed blobuploader requests docopt 16:11:17 INFO - Cleaning up... 16:11:17 INFO - Return code: 0 16:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:17 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')]} 16:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:17 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')]} 16:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:17 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:17 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 16:11:17 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 16:11:17 INFO - Using env: {'DISPLAY': ':0', 16:11:17 INFO - 'HOME': '/home/cltbld', 16:11:17 INFO - 'LANG': 'en_US.UTF-8', 16:11:17 INFO - 'LANGUAGE': 'en_US:en', 16:11:17 INFO - 'LOGNAME': 'cltbld', 16:11:17 INFO - 'MAIL': '/var/mail/cltbld', 16:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:17 INFO - 'MOZ_NO_REMOTE': '1', 16:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:17 INFO - 'NO_EM_RESTART': '1', 16:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:17 INFO - 'PWD': '/builds/slave/test', 16:11:17 INFO - 'SHELL': '/bin/bash', 16:11:17 INFO - 'SHLVL': '1', 16:11:17 INFO - 'TERM': 'linux', 16:11:17 INFO - 'TMOUT': '86400', 16:11:17 INFO - 'USER': 'cltbld', 16:11:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:17 INFO - '_': '/tools/buildbot/bin/python'} 16:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:17 INFO - Running setup.py (path:/tmp/pip-W8MIyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:17 INFO - Running setup.py (path:/tmp/pip-x0HBgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:17 INFO - Running setup.py (path:/tmp/pip-TNFT3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:17 INFO - Running setup.py (path:/tmp/pip-YMw8dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:17 INFO - Running setup.py (path:/tmp/pip-xLGy5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:17 INFO - Running setup.py (path:/tmp/pip-E_XBij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:17 INFO - Running setup.py (path:/tmp/pip-PWlNGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:18 INFO - Running setup.py (path:/tmp/pip-5316aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:18 INFO - Running setup.py (path:/tmp/pip-uyBr65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:18 INFO - Running setup.py (path:/tmp/pip-OXs_MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:18 INFO - Running setup.py (path:/tmp/pip-EjHLbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:18 INFO - Running setup.py (path:/tmp/pip-eGqB_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:18 INFO - Running setup.py (path:/tmp/pip-dc6pBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:18 INFO - Running setup.py (path:/tmp/pip-he68KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:18 INFO - Running setup.py (path:/tmp/pip-dD3_aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:18 INFO - Running setup.py (path:/tmp/pip-yfJheq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:18 INFO - Running setup.py (path:/tmp/pip-iQSOu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:18 INFO - Running setup.py install for manifestparser 16:11:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:18 INFO - Running setup.py install for mozcrash 16:11:18 INFO - Running setup.py install for mozdebug 16:11:19 INFO - Running setup.py install for mozdevice 16:11:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for mozfile 16:11:19 INFO - Running setup.py install for mozhttpd 16:11:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for mozinfo 16:11:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for mozInstall 16:11:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for mozleak 16:11:19 INFO - Running setup.py install for mozlog 16:11:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for moznetwork 16:11:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:19 INFO - Running setup.py install for mozprocess 16:11:20 INFO - Running setup.py install for mozprofile 16:11:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:20 INFO - Running setup.py install for mozrunner 16:11:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:20 INFO - Running setup.py install for mozscreenshot 16:11:20 INFO - Running setup.py install for moztest 16:11:20 INFO - Running setup.py install for mozversion 16:11:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:20 INFO - Cleaning up... 16:11:20 INFO - Return code: 0 16:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:20 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:20 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 16:11:20 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 16:11:20 INFO - Using env: {'DISPLAY': ':0', 16:11:20 INFO - 'HOME': '/home/cltbld', 16:11:20 INFO - 'LANG': 'en_US.UTF-8', 16:11:20 INFO - 'LANGUAGE': 'en_US:en', 16:11:20 INFO - 'LOGNAME': 'cltbld', 16:11:20 INFO - 'MAIL': '/var/mail/cltbld', 16:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:20 INFO - 'MOZ_NO_REMOTE': '1', 16:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:20 INFO - 'NO_EM_RESTART': '1', 16:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:20 INFO - 'PWD': '/builds/slave/test', 16:11:20 INFO - 'SHELL': '/bin/bash', 16:11:20 INFO - 'SHLVL': '1', 16:11:20 INFO - 'TERM': 'linux', 16:11:20 INFO - 'TMOUT': '86400', 16:11:20 INFO - 'USER': 'cltbld', 16:11:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:20 INFO - '_': '/tools/buildbot/bin/python'} 16:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:20 INFO - Running setup.py (path:/tmp/pip-vl8yQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:20 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)) 16:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:20 INFO - Running setup.py (path:/tmp/pip-VEuZpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:20 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)) 16:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:20 INFO - Running setup.py (path:/tmp/pip-e1v0ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:21 INFO - Running setup.py (path:/tmp/pip-_zRrZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:21 INFO - Running setup.py (path:/tmp/pip-gYwp1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:21 INFO - Running setup.py (path:/tmp/pip-Ob0ly4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:21 INFO - Running setup.py (path:/tmp/pip-4r7I5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:21 INFO - Running setup.py (path:/tmp/pip-CJrsfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:21 INFO - Running setup.py (path:/tmp/pip-IM4iDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:21 INFO - Running setup.py (path:/tmp/pip-W5CmXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:21 INFO - Running setup.py (path:/tmp/pip-vZqdv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:21 INFO - Running setup.py (path:/tmp/pip-AjLOGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:21 INFO - Running setup.py (path:/tmp/pip-xP_HkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:21 INFO - Running setup.py (path:/tmp/pip-gNTT9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:21 INFO - Running setup.py (path:/tmp/pip-Vn2ipw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:21 INFO - Running setup.py (path:/tmp/pip-cJNzrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:21 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)) 16:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:21 INFO - Running setup.py (path:/tmp/pip-HtwH5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:22 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)) 16:11:22 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)) 16:11:22 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)) 16:11:22 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)) 16:11:22 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)) 16:11:22 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)) 16:11:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:23 INFO - Downloading blessings-1.6.tar.gz 16:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:23 INFO - Installing collected packages: blessings 16:11:23 INFO - Running setup.py install for blessings 16:11:24 INFO - Successfully installed blessings 16:11:24 INFO - Cleaning up... 16:11:24 INFO - Return code: 0 16:11:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:24 INFO - Reading from file tmpfile_stdout 16:11:24 INFO - Current package versions: 16:11:24 INFO - argparse == 1.2.1 16:11:24 INFO - blessings == 1.6 16:11:24 INFO - blobuploader == 1.2.4 16:11:24 INFO - docopt == 0.6.1 16:11:24 INFO - manifestparser == 1.1 16:11:24 INFO - mozInstall == 1.12 16:11:24 INFO - mozcrash == 0.17 16:11:24 INFO - mozdebug == 0.1 16:11:24 INFO - mozdevice == 0.48 16:11:24 INFO - mozfile == 1.2 16:11:24 INFO - mozhttpd == 0.7 16:11:24 INFO - mozinfo == 0.9 16:11:24 INFO - mozleak == 0.1 16:11:24 INFO - mozlog == 3.2 16:11:24 INFO - moznetwork == 0.27 16:11:24 INFO - mozprocess == 0.22 16:11:24 INFO - mozprofile == 0.28 16:11:24 INFO - mozrunner == 6.11 16:11:24 INFO - mozscreenshot == 0.1 16:11:24 INFO - mozsystemmonitor == 0.3 16:11:24 INFO - moztest == 0.7 16:11:24 INFO - mozversion == 1.4 16:11:24 INFO - psutil == 3.1.1 16:11:24 INFO - requests == 1.2.3 16:11:24 INFO - wsgiref == 0.1.2 16:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:24 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:24 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 16:11:24 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 16:11:24 INFO - Using env: {'DISPLAY': ':0', 16:11:24 INFO - 'HOME': '/home/cltbld', 16:11:24 INFO - 'LANG': 'en_US.UTF-8', 16:11:24 INFO - 'LANGUAGE': 'en_US:en', 16:11:24 INFO - 'LOGNAME': 'cltbld', 16:11:24 INFO - 'MAIL': '/var/mail/cltbld', 16:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:24 INFO - 'MOZ_NO_REMOTE': '1', 16:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:24 INFO - 'NO_EM_RESTART': '1', 16:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:24 INFO - 'PWD': '/builds/slave/test', 16:11:24 INFO - 'SHELL': '/bin/bash', 16:11:24 INFO - 'SHLVL': '1', 16:11:24 INFO - 'TERM': 'linux', 16:11:24 INFO - 'TMOUT': '86400', 16:11:24 INFO - 'USER': 'cltbld', 16:11:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:24 INFO - '_': '/tools/buildbot/bin/python'} 16:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 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)) 16:11:24 INFO - Cleaning up... 16:11:24 INFO - Return code: 0 16:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:24 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:24 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 16:11:24 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 16:11:24 INFO - Using env: {'DISPLAY': ':0', 16:11:24 INFO - 'HOME': '/home/cltbld', 16:11:24 INFO - 'LANG': 'en_US.UTF-8', 16:11:24 INFO - 'LANGUAGE': 'en_US:en', 16:11:24 INFO - 'LOGNAME': 'cltbld', 16:11:24 INFO - 'MAIL': '/var/mail/cltbld', 16:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:24 INFO - 'MOZ_NO_REMOTE': '1', 16:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:24 INFO - 'NO_EM_RESTART': '1', 16:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:24 INFO - 'PWD': '/builds/slave/test', 16:11:24 INFO - 'SHELL': '/bin/bash', 16:11:24 INFO - 'SHLVL': '1', 16:11:24 INFO - 'TERM': 'linux', 16:11:24 INFO - 'TMOUT': '86400', 16:11:24 INFO - 'USER': 'cltbld', 16:11:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:24 INFO - '_': '/tools/buildbot/bin/python'} 16:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:24 INFO - Downloading/unpacking jsonschema 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:26 INFO - Downloading/unpacking functools32 (from jsonschema) 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:26 INFO - warning: no files found matching '*.txt' 16:11:26 INFO - no previously-included directories found matching 'build' 16:11:26 INFO - no previously-included directories found matching 'dist' 16:11:26 INFO - no previously-included directories found matching '.git*' 16:11:26 INFO - Installing collected packages: jsonschema, functools32 16:11:27 INFO - Running setup.py install for functools32 16:11:27 INFO - warning: no files found matching '*.txt' 16:11:27 INFO - no previously-included directories found matching 'build' 16:11:27 INFO - no previously-included directories found matching 'dist' 16:11:27 INFO - no previously-included directories found matching '.git*' 16:11:27 INFO - Successfully installed jsonschema functools32 16:11:27 INFO - Cleaning up... 16:11:27 INFO - Return code: 0 16:11:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:27 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 0x7fe0962a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', '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 16:11:27 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 16:11:27 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 16:11:27 INFO - Using env: {'DISPLAY': ':0', 16:11:27 INFO - 'HOME': '/home/cltbld', 16:11:27 INFO - 'LANG': 'en_US.UTF-8', 16:11:27 INFO - 'LANGUAGE': 'en_US:en', 16:11:27 INFO - 'LOGNAME': 'cltbld', 16:11:27 INFO - 'MAIL': '/var/mail/cltbld', 16:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:27 INFO - 'MOZ_NO_REMOTE': '1', 16:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:27 INFO - 'NO_EM_RESTART': '1', 16:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:27 INFO - 'PWD': '/builds/slave/test', 16:11:27 INFO - 'SHELL': '/bin/bash', 16:11:27 INFO - 'SHLVL': '1', 16:11:27 INFO - 'TERM': 'linux', 16:11:27 INFO - 'TMOUT': '86400', 16:11:27 INFO - 'USER': 'cltbld', 16:11:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:27 INFO - '_': '/tools/buildbot/bin/python'} 16:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:27 INFO - Downloading/unpacking flake8 16:11:27 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 16:11:27 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 16:11:27 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 16:11:27 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 16:11:27 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 16:11:27 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 16:11:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:11:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:11:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 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 16:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:29 INFO - no previously-included directories found matching 'docs/_build' 16:11:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:11:30 INFO - Running setup.py install for pep8 16:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:30 INFO - no previously-included directories found matching 'docs/_build' 16:11:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:11:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:11:30 INFO - Cleaning up... 16:11:30 INFO - Return code: 0 16:11:30 INFO - Running post-action listener: _resource_record_post_action 16:11:30 INFO - Running post-action listener: _start_resource_monitoring 16:11:30 INFO - Starting resource monitoring. 16:11:30 INFO - ##### 16:11:30 INFO - ##### Finished create-virtualenv step (success) 16:11:30 INFO - ##### 16:11:30 INFO - ##### 16:11:30 INFO - ##### Running install step. 16:11:30 INFO - ##### 16:11:30 INFO - Running pre-action listener: _resource_record_pre_action 16:11:30 INFO - Running main action method: install 16:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:30 INFO - Reading from file tmpfile_stdout 16:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:30 INFO - Reading from file tmpfile_stdout 16:11:30 INFO - Output received: 16:11:30 INFO - Usage: mozinstall [options] installer 16:11:30 INFO - Options: 16:11:30 INFO - -h, --help show this help message and exit 16:11:30 INFO - -d DEST, --destination=DEST 16:11:30 INFO - Directory to install application into. [default: 16:11:30 INFO - "/builds/slave/test"] 16:11:30 INFO - --app=APP Application being installed. [default: firefox] 16:11:30 INFO - mkdir: /builds/slave/test/build/application 16:11:30 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'] 16:11:30 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 16:11:47 INFO - Reading from file tmpfile_stdout 16:11:47 INFO - Output received: 16:11:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:11:47 INFO - Running post-action listener: _resource_record_post_action 16:11:47 INFO - ##### 16:11:47 INFO - ##### Finished install step (success) 16:11:47 INFO - ##### 16:11:47 INFO - ##### 16:11:47 INFO - ##### Running run-tests step. 16:11:47 INFO - ##### 16:11:47 INFO - Running pre-action listener: _resource_record_pre_action 16:11:47 INFO - Running main action method: run_tests 16:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:47 INFO - Python 2.7.3 16:11:47 INFO - Return code: 0 16:11:47 INFO - grabbing minidump binary from tooltool 16:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:47 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 0x10109c0>, '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 0x10118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:47 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 16:11:47 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 16:11:47 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 16:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:48 INFO - Return code: 0 16:11:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:11:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:11:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:11:48 INFO - Return code: 0 16:11:48 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/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 16:11:48 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/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 16:11:48 INFO - Using env: {'DISPLAY': ':0', 16:11:48 INFO - 'HOME': '/home/cltbld', 16:11:48 INFO - 'LANG': 'en_US.UTF-8', 16:11:48 INFO - 'LANGUAGE': 'en_US:en', 16:11:48 INFO - 'LOGNAME': 'cltbld', 16:11:48 INFO - 'MAIL': '/var/mail/cltbld', 16:11:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:48 INFO - 'MOZ_NO_REMOTE': '1', 16:11:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:48 INFO - 'NO_EM_RESTART': '1', 16:11:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:48 INFO - 'PWD': '/builds/slave/test', 16:11:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:48 INFO - 'SHELL': '/bin/bash', 16:11:48 INFO - 'SHLVL': '1', 16:11:48 INFO - 'TERM': 'linux', 16:11:48 INFO - 'TMOUT': '86400', 16:11:48 INFO - 'USER': 'cltbld', 16:11:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822', 16:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:48 INFO - '_': '/tools/buildbot/bin/python'} 16:11:48 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/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 16:11:49 INFO - mozversion application_buildid: 20160530133025 16:11:49 INFO - mozversion application_changeset: 09d0d424f914d064e30071fd85fc890e482fc79c 16:11:49 INFO - mozversion application_display_name: Nightly 16:11:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:49 INFO - mozversion application_name: Firefox 16:11:49 INFO - mozversion application_remotingname: firefox 16:11:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:11:49 INFO - mozversion application_vendor: Mozilla 16:11:49 INFO - mozversion application_version: 49.0a1 16:11:49 INFO - mozversion platform_buildid: 20160530133025 16:11:49 INFO - mozversion platform_changeset: 09d0d424f914d064e30071fd85fc890e482fc79c 16:11:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:11:49 INFO - mozversion platform_version: 49.0a1 16:11:49 INFO - using testdate: 1464649909 16:11:49 INFO - actual date: 1464649909 16:11:49 INFO - starting webserver on 'localhost:58000' 16:11:49 INFO - SUITE-START | Running 2 tests 16:11:49 INFO - TEST-START | dromaeo_css 16:11:49 INFO - operating with platform_type : linux_ 16:11:49 INFO - Initialising browser for dromaeo_css test... 16:11:49 INFO - TEST-INFO | started process 9896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWNRgaj/profile http://localhost:58000/getInfo.html) 16:11:53 INFO - PROCESS | 9896 | __metrics Screen width/height:1600/1200 16:11:53 INFO - PROCESS | 9896 | colorDepth:24 16:11:53 INFO - PROCESS | 9896 | Browser inner width/height: 1024/697 16:11:53 INFO - PROCESS | 9896 | __metrics 16:11:55 ERROR - PROCESS | 9896 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:11:56 INFO - TEST-INFO | 9896: exit 0 16:11:56 INFO - Browser initialized. 16:11:56 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:56 INFO - TEST-INFO | started process 9983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWNRgaj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:08 INFO - PROCESS | 9983 | RSS: Main: 155795456 16:12:08 INFO - PROCESS | 9983 | 16:12:59 INFO - PROCESS | 9983 | 1464649979025 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] 16:15:07 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58000/tests/dromaeo/cssquery-ext.html) 16:15:08 INFO - PROCESS | 9983 | RSS: Main: 246775808 16:15:08 INFO - PROCESS | 9983 | 16:18:10 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-ext.html (next: http://localhost:58000/tests/dromaeo/cssquery-jquery.html) 16:18:11 INFO - PROCESS | 9983 | RSS: Main: 248094720 16:18:11 INFO - PROCESS | 9983 | 16:21:13 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58000/tests/dromaeo/cssquery-mootools.html) 16:21:13 INFO - PROCESS | 9983 | RSS: Main: 250458112 16:21:13 INFO - PROCESS | 9983 | 16:24:15 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58000/tests/dromaeo/cssquery-prototype.html) 16:24:16 INFO - PROCESS | 9983 | RSS: Main: 250597376 16:24:16 INFO - PROCESS | 9983 | 16:27:19 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58000/tests/dromaeo/cssquery-yui.html) 16:27:19 INFO - PROCESS | 9983 | RSS: Main: 224477184 16:27:19 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | Cycle 1(1): loaded http://localhost:58000/tests/dromaeo/cssquery-yui.html (next: http://localhost:58000/tests/dromaeo/cssquery-dojo.html) 16:30:22 INFO - PROCESS | 9983 | RSS: Main: 280797184 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | __start_tp_report 16:30:22 INFO - PROCESS | 9983 | _x_x_mozilla_page_load 16:30:22 INFO - PROCESS | 9983 | _x_x_mozilla_page_load_details 16:30:22 INFO - PROCESS | 9983 | |i|pagename|runs| 16:30:22 INFO - PROCESS | 9983 | |0;dojo.html;3066.1414803854923;3082.244850011746;3106.0526539405478;3110.346827166295;3152.4325621388157;5157.71632560209;5207.843764687056;5277.261183434318;5403.40562538121;5416.972915135424;5266.131088370415;5270.604704647148;5293.735313234332;5376.381716102649;5395.676259424437;4696.29555566666;4708.387909571768;4786.114568804782;4796.064767370364;5011.173156429185;4923.729194894279;4938.48145944676;4949.109160351135;4995.375578052744;5019.498050194988;4698.224792909183;4722.433308003045;4766.642501812378;4798.5441383068555;4809.182438985381;4775.14047471455;4810.470848206694;4884.7069175849565;4886.633502487328;4933.136701077333;4711.387519622462;4776.617870570346;4789.114013907439;4806;4835.178019736653;5219.42586315505;5295.867603309909;5296.09966305729;5338.813141540067;5363.115086010804;5773.278340207474;5782.3639399666;5791.594588378815;5820.767169313222;5830.7084645767545;5557.221988921554;5699.145128230757;5799.2750906136735;5852.941470585325;5857.150713146612;5363;5481.314835645544;5483.616146869721;5486.61593688438;5490.945090549043;5967.19442875215;5985.132155837467;5990.700464976734;5991.131285963511;5991.400859914061;5411.350637923474;5529.225908372831;5559.583031272671;5723.255976723;5754.165645981393;5688.345840228344;5732.828015159552;5741.196232527366;5743.966086104458;5751.827445176651;5631.8592035199445;5674.829755107354;5681.744321505542;5686.715664216856;5688.431156884279;5476.397596264408;5667.149927510906;5677.545796336283;5735.397783232784;5735.885282294331;4380.518143004267;4381.759003254788;4384.4519435070615;4385.6052955233545;4416.072624748775;3896.2207558488417;3912.7456715313415;3919.0202449387652;3956.802159891994;3959.6436320731273;5264.184051472028;5270.262163297141;5321.467853214725;5364.168553874156;5374.032674118696;5742.856428589235;5748.597598168088;5754.280714910637;5783.421657834267;5793.797217097465;5382.596305277119;5397.2443857859935;5401.081816091274;5405.135178371442;5406.243125962368;4810.831620893252;4925.187344088257;4940.7035577865445;4959.950400495949;5004.424491183488;5935.614185077956;5950.375210602911;5954.55340849438;5957.314908785458;5958;5794.188813566104;5803.680797556175;5816.069428891357;5823.94176058234;5829.854253643693;5660.179274005329;5885.852853678521;5889.617174883619;5932.1694962706115;5951.047832346804;5647.943520564741;5676.744546495335;5680.488756011979;5686.203931449518;5687.914681279702;5754.367019627922;5783.537317014713;5804.2744656917885;5805.10020946754;5805.158252053513;5358.089124848707;5576.442355764391;5626.971865140648;5628.690422026664;5665.886682266414;5628.718564071862;5633.0705433604635;5645.463680950304;5646.632968857011;5648.406917273627;5317.946820531745;5555.555555555465;5563.582731295088;5567;5573.944260557505;5735.684537350486;5798.072308430631;5804.82585522435;5811.622244554091;5812.476877081083;5600.915986260128;5637.802676906289;5639.689817060101;5640.0693885508435;5665.943340566707 16:30:22 INFO - PROCESS | 9983 | |1;ext.html;615.234033628133;634.9777757778477;636.7707625254909;644.1786721929542;649.1658219188344;31004.22489437765;33540.4968925466;41873.79063104684;43297.134057318835;43325.566744332624;41891.16217675645;42184.57815421845;42494.15011699764;42754;42761;8516.574171291426;8731.301495880314;8734.563271836414;8737.21365077143;8738.563071846414;8542.914570854306;8714.128587141267;8714.564271786418;8724.258438032743;8734;8707.47755134694;8716.08481109484;8743.562821858914;8750.606222719962;8759.868601970975;8662.52356120413;8708.346873984414;8713.172248636369;8731.432456890281;8738.432001919855;8621.353398495075;8677.132286771272;8697.826043479095;8697.956245250547;8707.737378080206;39464;39707;39917.60082399168;39967.40048899269;39967.40048899269;3444.156181735466;3587.515685382492;4084.1831633673382;4165.12532368203;4287.035417031143;29870.70129298701;30534.236644083852;30844.2288942776;30857.228569285722;31735.04794856158;4273.18809426208;4418.160549495586;4451.888702782424;4476.55234476553;4503.864884053483;283903;283974;284212;285108.5744571285;285309;53357;54300;54430.72784636052;54466.18300725492;54550;56712.43287567154;57313.426865730806;57396.42603573994;57458.712706437036;57512;15961.201939902958;16305.103219323051;16309.51071467858;16317.184140792913;16320.673586528203;11132.220744547803;11159.72100697489;11162.720931976766;11165.162612804072;11201.71995700114;15082.54752357409;15983.520494385188;16083.195840208176;16157.434489793035;16216.432424865308;6078.240219972504;6326.230932901843;6358.205224346957;6384.52116091295;6426.807195784134;1016.2682868334787;1139.1171841822488;1140.811766058591;1148.8104462763552;1160.4255893332854;30493.542596861065;30846.845765771475;30860.691393086232;31157.532637010463;31429.214269642984;1050.3120456101267;1109.4785450838094;1157.6353448663813;1162.2271189658952;1184.319016565461;16177.272022759003;16332.591685207728;16404.589885252964;16425.753613695804;16647.41734039327;427602;428416;428734;433190;434237;51331.12354326333;52235.73882130565;52241;52245;52349;1266.4047897488165;1330.1420583723639;1373.203541945669;1391.589481103077;1392.498700467851;31262.843685781427;32678.509822352207;32717.585964352395;32804.835975819966;33104.1723956903;48264.27603585879;48535.271970921174;48863.755681221366;48878;48900.75549622229;314166;314502;314654;314818;315088;34210.48684269788;39704.404433932934;40337.79831100826;40889.1822163561;41086.38370424386;45530.77234613938;45983.08033839238;46549.767251163525;47094.52905471039;47157.29264061111;38393;40673.593264068164;40686.79656601698;40869.795651022745;41155.58844411517;39082.413763792996;40011.399829002;40268.59731402648;40324.39513407242;40752.1849563013;39607;40290.597094028686;40455.190896181324;40474;40532.39201411922;33216.667833322324;35968;36374.27251455009;36562.26875462529;36600.81699591485;27293.863530682218;27486.587701184097;27696.169114926586;27722.861385692944;27795.861020694767 16:30:22 INFO - PROCESS | 9983 | |2;jquery.html;388.2836167271384;389.52867030892617;394.899300678327;397.5170168245582;415.70692661673525;17990.100494975264;19487.41537753868;19494.415167544998;19524.121414536345;20424;18461.076946152672;18881.62236755264;18901.716474252862;19168.13743381548;19458.318958836444;5533.944660553393;5624.831255062355;5656.830295091154;5669.716514174295;5689.715514224293;5513.972430137844;5596.776128954837;5611.3546942101775;5612.887742245152;5632.408597097307;5509.641873278244;5554.028045092113;5593.804216852411;5599.776008959637;5631.436856314356;5502.5597952163735;5525.4474552544825;5546.195801608765;5551.72241387929;5640.943590564103;4793.161196790583;4994.076095922266;5029.119904016782;5039.3196918415915;5040.571551418134;22643;22808.65787013196;22998.560403087162;23215.651765223534;23356.299311020695;2327.522857814144;2368.301351101429;2446.082718980382;2655.3759866431374;2724.7820174386;13881.722365552632;14288.214148221843;14412.855871441361;14512.346944387527;14897.70204595902;1905.3426567834076;1960.9607807843906;1984.484034151131;2000.899955002244;2001.319551352547;51347.48652513502;70066.2993370065;74679.25320746777;74883.62558187175;86383.99999999937;10762.946185269024;10943.781124377469;11095.746827220673;11104.888951110386;11322.773544529064;15531;15565.610859728371;15619.687606248039;15655.608609784846;15675.686486270211;7671.2712292332135;7756.8448631028195;7825.865249538785;7907.0906845712325;7990.720324788605;7090.680919358641;7151.7854464366155;7215.206327303992;7243.348098671145;7544.283293087148;4647.790849411785;4662.510436404196;4717.504662010508;4737.8341758038305;4781;1932.8163824436656;1933.8162874526897;1950.5611237471455;2002.4793553675859;2017.697345398202;892.9642814287486;1007.9445630490393;1022.9028242316969;1065.6323568369055;1083.6748975307376;18688.349373941597;18864;19112.713309300372;19278.71081933772;19664.803351966297;941.7457286532598;961.0869673809908;967.4582233949011;982.0817535604233;1001.1690297053428;10410.271281010257;10933.070688991365;10936.507857146447;10973.286736362112;10991.230613856953;459488;460484;463540.7760728426;482053;484292;89959;91142;91602.54198728963;92170;92492;1011.0900189829213;1012.9645462408633;1052.957881684724;1068.4871261794383;1081.6052140968648;16655.083970381744;16762.664746705243;16873.91563042226;16996.830031699526;17630.559236019202;39766;40666.1866762669;40733.79633101816;41433.70884743021;41975.58024419717;55065;57084.71457642685;57698.4230157693;58227;59531;8381.748547543584;8451.830963380575;8677;8801.691940782042;8992.235659968714;9206.953965230132;12124.84813942674;12194;12567.120301578801;12583.307918064595;10989.725256868642;11107.888921110685;11207.607733729606;11254.268472549258;11507.712307192387;10418.426986515815;10877.782444351227;10893.07408870255;11022.173336999596;11165.274257173258;9517.428954262767;11329.093672506015;11443.542258309575;11484.770304593694;11590.652280431601;8572.871406928776;8673.826523469621;8730.583824317147;8897.932248130266;8967.192952634294;8511;10670.733231668959;10907.78184436291;10935.945320273348;11201 16:30:22 INFO - PROCESS | 9983 | |3;mootools.html;1310.1287643716928;1524.9542513724589;1550.759392486011;1719.9140042997856;1852.6387354465885;8387.58062096895;8818.514981675997;8822.206001459866;9063.27493800496;9080.182783549479;8773.122687731224;8950.776230594221;8979.191872731453;8981;9006.324525660586;1937.602791427754;2225.0765932138142;2303.4702018535745;2331.5919714050015;2355.7762012608773;2321.686572312733;2333.3000099970027;2333.6849525314037;2334.8248881333884;2340.871252081135;2307.8038366738847;2331.335569362732;2333.0784340185614;2336.334144768741;2339.42684042409;1903.4004288649169;2181.3128864407663;2244.7979681828715;2245.2702871566726;2254.6054440473017;2272.522770218256;2290.633498640226;2295.403195169268;2295.494991101955;2298.643710224918;8580.742577722678;8640.438371505896;8654.134586541359;8664.22022018015;8674;5179.689218646856;5316.20256961455;5316.627836051478;5318.335208098988;5320.255164277004;3202.679732026802;3253.9349213015844;3407.727381809474;3433.7081348085444;3441.7590768646205;1075.150631001508;1105.088302150721;1114.0474893965704;1141.201159188563;1160.1704781081567;11981.46083426248;12005.339706316148;12032.39838008105;12095.39523023854;12096.939515302454;4507.4365704286965;4647.233206520887;4650.720956742606;4767.666263361601;4769.785359658824;10230.386176829414;10246.077852993267;10250.128739057263;10255.7436064099;10256.12822910046;5352.5450336721815;5354.170103633943;5361.490658387525;5363.624546281801;5364.758585863646;4149.792510374469;4789.137955168034;4915.410150781858;4919.262110683426;4981.626378021663;3881.107345310594;3979.10470144221;3990.60328884888;4038.1318016626565;4063.593640635972;1241.7516496700696;1250.4373032135575;1268.8794564516356;1275.6555729953047;1280.4558062823262;855.9144085591515;861.6984055580622;901.833160865242;920.1534588178891;925.847235206197;5576.079946808813;5624.0439125348785;5707.1724599933605;5742.712864356766;5843.29880414353;939.4269495607674;959.9040095990345;970.2965350121247;979.6522234606612;1012.448215722433;3810.1808111256214;3813.218290250492;3835.846566137379;3948.723589348718;3965.088029753173;10799.352038877692;10994.450277486094;11032.393218372907;11076.335419874673;11116.777664446667;10896.564137434414;10994.560217591366;11000.504977276041;11022.614208502664;11023.118150548098;8025.077116131602;8297.668093276201;8397.412181147261;8398.832023359499;8403.705870294632;5363.115086010765;5474.972625136849;5564.610477266552;5620.775168993195;5692.174634678031;10018.849717254392;10163.695089147337;10225.488725563544;10376.844347334645;10483.842742358718;10436.686899393031;10494.108000820015;10539.683809485728;10588.205884558534;10640.361578305326;6574.868502630016;7207.603581803051;7214.242504536948;7404;7618.69525218985;8719.825603488021;8730.432521886058;8765.430247033923;8795;8808.295336373203;7590.696372145052;7824.843503129791;7844.568548729874;7868.84262314762;7942.364610831235;7638.465307428427;7689.538627682357;7711.922880771121;7826;7827.217278272127;6796.456283497209;6809.285025072296;6839.281875403011;6839.589624622538;6840.247572767091;4689.132510485571;4744.312074749211;4860.732659703609;4905.4358748742925;4910.337104490991;4883.121038213156;4939.580135688363;4981.2030075187795;5000.424951130666;5024.145895197898 16:30:22 INFO - PROCESS | 9983 | |4;prototype.html;330.9851056702448;331.75450166876504;336.88882668719316;337.9003194057753;339.8606571305765;5236.188390799422;5284.339457567804;5321.574274058075;5356.375376065729;5356.625036247464;5261.000409922121;5263.736813159337;5266;5268.394134674504;5268.789248430058;3929.5677475477746;3956.8417263309575;4084.1825387702484;4117.897052573695;4119.958800412002;4045.797710114497;4088.325426304656;4092.3452247640384;4092.85675001375;4099.118689481761;3914.667253283474;4056.452378928851;4058.391241313797;4059.4925634295714;4062.8781136565804;3909.1790723948006;4022.859199928018;4031.5363733170766;4036.2331157080353;4046.332355161395;3573.8927832165077;3580.785152890835;3584.9283014339826;3589.0668426209113;3602.423612222032;5039.370078740158;5064.518870707314;5064.670796398223;5080.618953578496;5097.872553186163;4538.546145385468;4637.513061128567;4663.790129444184;4695.201815691341;4701.623870090384;5412.675239485643;5435.673859568438;5454.236406903036;5458.808941687022;5465.9180112298345;3961.336238779719;3968;3968.3452230381954;3968.603139686037;3976.602339766029;5517.69652669103;5586.832395028156;5636.379998200195;5686.715664216773;5698.202251684767;4038.6163314485075;4055.742719756885;4059.4113853491667;4071.432498488103;4082.14262510557;4102.835886564564;4105.876823695294;4106.979465102655;4112.383142528584;4123.092919557693;4371.409859668967;4642.721436713808;4645.6980296280635;4646.605038571759;4663.906721865544;5508.586855985817;5541.778328866801;5546.584006199551;5552.167174923713;5562.443755624486;1402.6353148181547;1419.5457453614952;1419.7799341102145;1420.2685616907302;1423.9572812815632;885.1104639836923;896.3635818568758;903.7257466971539;926.6108234541508;937.2267878999852;5237.554807841376;5264.684118952875;5281.894362112736;5313.57491400687;5316.73416329182;5631.915521267184;5648.435156484401;5649.858753531194;5683.442450897112;5707.971460142673;5114.872128196825;5238.371395432572;5243.292155558951;5253.13323301651;5393.649412788156;2982.478066338382;3001.0943051162667;3014.4121896230026;3031.242189452637;3051.588035615208;5784.855378615568;5785.942140578541;5847.94152058474;5850.94149058504;5879.206307148565;5570.637908535932;5810.908073093683;5816.447437493432;5828.242328497268;5839.445252701072;5800.7099645018425;5801.216835727208;5830.737616807254;5846.824595262149;5862.5896187267335;5386.919196212139;5614.719264036864;5633.718314084362;5674.971625142013;5678.290213723285;5583.804566840141;5595.664260144405;5603.943960560506;5612.831615051555;5653.858653533694;5803.7968671096305;5856.502197313106;5874.148248504029;5901.377121291679;5905.143754155709;3854.9807250963568;4034.556198818186;4059.89850253746;4072.124493233969;4077.286474866946;5669.744861481161;5701.543876489954;5703.942960570341;5706.3152421709665;5723.284589426322;5303.893922121613;5394.460553944731;5539.279893613804;5547.306586676666;5570.916436253378;5500.9823182711325;5506.834794956158;5520;5527.668339899619;5536.52939500147;5184.170532714898;5377.220303056113;5436.592255580768;5443.836684899459;5447.1829225616475;5531.119419397424;5549.639273447213;5552.7778888843995;5566.471185237396;5574.91637625444;5302.655327403706;5354.437784032621;5397.973010134924;5418.674879507243;5438.809641662523 16:30:22 INFO - PROCESS | 9983 | |5;yui.html;747.7382915979407;819.025359821812;822.3256929317957;843.1694780641071;859.793649524114;15251.466198683049;15708.214589270548;15759.684806303896;15802.92098539507;15867.444639437608;14197.089596632692;14339.71320573588;14582.270886455688;14657.56027319182;14676.706465870677;662.0301258656068;803.3252068262673;813.5769399912042;818.7093581778443;819.5697258939075;767.4090949968548;807.1928071928072;809.1503920883079;816.4203415574949;824.7031068815222;845.480029781686;845.5941148248844;848.6266042941118;849.4011721736161;850.6852464588111;677.5325025732278;808.5027707959621;844.2907957315854;845.5603086395101;846.0397448895517;612.5375341617095;619.553921176752;623.1400667079447;624.8625302433458;625.1935003845034;14114.858851411456;14119.223442710647;14143.858561414358;14158.858411415857;14188.077774944595;13881;14251.64370890736;14287.57137285883;14293.285335733275;14680.944667746524;11846.407679615984;12001.399930003552;12210;12243.510259589606;12388.938055309665;4434.35701823237;4462.419885414908;4485.394471746337;4496.830823985754;4502.234620114588;60338.396616033715;60508.39491605072;60790.69604651993;62646.68676656633;63217.05174422387;11211.215214934877;11322.26405283654;11386.658400248005;11486.770264594661;11683.824742628867;20647.17411303531;20975.056122474525;21047.68428473574;21066.15735370568;21268.468288292916;8683.522406267715;8691.956540217385;8755.649774008969;8815.823683526422;8857.02487151297;4660.603848672833;4667.509911459316;4746.38297021385;4749.050189962021;4897.020595880838;3348.68187522185;3447.052060683282;3459.066052165901;3461.2039230977016;3464.185916309665;589.9823005309847;591.8845825064071;601.0593421295658;604.7067172421372;623.0405176028955;633.4868756307313;647.5143642268299;677.552815142004;745.2845268542152;749.9962500187464;8972.76641174148;9415.811683766286;9529.90470095304;9606.423614583147;9809.166220871306;575.9452851979055;620.8261686727724;629.9244090709144;714.4712912444753;732.8241222106763;4099.709222854574;4259.701820872509;4282.400463935051;4286.635635970977;4343.739375637472;65151.34848651453;68196.6590167056;68264;68581;68617.3138268621;61344;62331.68834155891;62594.37405625886;62786;64048.67975660092;56481.71759141178;56521.43478565244;56558.151627725616;56634.43365566374;57401;8080.636371363185;8187.959060204661;8295.917040829756;8352.540610266251;8603;37151.44272835964;37882.43176352412;37920.620793791706;38196.236075278895;38661.6133838658;46476.76761616306;50543.74728126336;50732.49267507425;50753;51104.74447627738;11059;11140.498677559368;11250.324980501196;11423.543058277575;11502.309861408008;12065.638030859089;12212.694682633006;12256.325902075472;12305.876941230474;12407.379631018232;11325.263857849213;11406.372649504357;11566.363849988331;11622.07023438106;11654.766904662029;11330.773384532427;11384.943075284571;11386;11600.071994240272;11945.761084778082;11233.157513186381;11503.712407189887;11559.248648837798;11603.593874214363;11895.524179032742;9504.524773761146;9653.758656033655;9802.264830137625;9977.401355918379;9984.151347135576;9623.374480658735;9738.513074346396;9794.510274486105;9804.55879485439;9843.409395436296 16:30:22 INFO - PROCESS | 9983 | __end_tp_report 16:30:22 INFO - PROCESS | 9983 | __start_cc_report 16:30:22 INFO - PROCESS | 9983 | _x_x_mozilla_cycle_collect,917 16:30:22 INFO - PROCESS | 9983 | __end_cc_report 16:30:22 INFO - PROCESS | 9983 | __startTimestamp1464651022486__endTimestamp 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | ------- Summary: start ------- 16:30:22 INFO - PROCESS | 9983 | Number of tests: 6 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#0] dojo.html Cycles:165 Average:5327.95 Median:5559.58 stddev:619.37 (11.1%) stddev-sans-first:595.32 16:30:22 INFO - PROCESS | 9983 | Values: 3066.1 3082.2 3106.1 3110.3 3152.4 5157.7 5207.8 5277.3 5403.4 5417.0 5266.1 5270.6 5293.7 5376.4 5395.7 4696.3 4708.4 4786.1 4796.1 5011.2 4923.7 4938.5 4949.1 4995.4 5019.5 4698.2 4722.4 4766.6 4798.5 4809.2 4775.1 4810.5 4884.7 4886.6 4933.1 4711.4 4776.6 4789.1 4806.0 4835.2 5219.4 5295.9 5296.1 5338.8 5363.1 5773.3 5782.4 5791.6 5820.8 5830.7 5557.2 5699.1 5799.3 5852.9 5857.2 5363.0 5481.3 5483.6 5486.6 5490.9 5967.2 5985.1 5990.7 5991.1 5991.4 5411.4 5529.2 5559.6 5723.3 5754.2 5688.3 5732.8 5741.2 5744.0 5751.8 5631.9 5674.8 5681.7 5686.7 5688.4 5476.4 5667.1 5677.5 5735.4 5735.9 4380.5 4381.8 4384.5 4385.6 4416.1 3896.2 3912.7 3919.0 3956.8 3959.6 5264.2 5270.3 5321.5 5364.2 5374.0 5742.9 5748.6 5754.3 5783.4 5793.8 5382.6 5397.2 5401.1 5405.1 5406.2 4810.8 4925.2 4940.7 4960.0 5004.4 5935.6 5950.4 5954.6 5957.3 5958.0 5794.2 5803.7 5816.1 5823.9 5829.9 5660.2 5885.9 5889.6 5932.2 5951.0 5647.9 5676.7 5680.5 5686.2 5687.9 5754.4 5783.5 5804.3 5805.1 5805.2 5358.1 5576.4 5627.0 5628.7 5665.9 5628.7 5633.1 5645.5 5646.6 5648.4 5317.9 5555.6 5563.6 5567.0 5573.9 5735.7 5798.1 5804.8 5811.6 5812.5 5600.9 5637.8 5639.7 5640.1 5665.9 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#1] ext.html Cycles:180 Average:51355.42 Median:40503.20 stddev:91758.72 (226.5%) stddev-sans-first:91937.04 16:30:22 INFO - PROCESS | 9983 | Values: 615.2 635.0 636.8 644.2 649.2 31004.2 33540.5 41873.8 43297.1 43325.6 41891.2 42184.6 42494.2 42754.0 42761.0 8516.6 8731.3 8734.6 8737.2 8738.6 8542.9 8714.1 8714.6 8724.3 8734.0 8707.5 8716.1 8743.6 8750.6 8759.9 8662.5 8708.3 8713.2 8731.4 8738.4 8621.4 8677.1 8697.8 8698.0 8707.7 39464.0 39707.0 39917.6 39967.4 39967.4 3444.2 3587.5 4084.2 4165.1 4287.0 29870.7 30534.2 30844.2 30857.2 31735.0 4273.2 4418.2 4451.9 4476.6 4503.9 283903.0 283974.0 284212.0 285108.6 285309.0 53357.0 54300.0 54430.7 54466.2 54550.0 56712.4 57313.4 57396.4 57458.7 57512.0 15961.2 16305.1 16309.5 16317.2 16320.7 11132.2 11159.7 11162.7 11165.2 11201.7 15082.5 15983.5 16083.2 16157.4 16216.4 6078.2 6326.2 6358.2 6384.5 6426.8 1016.3 1139.1 1140.8 1148.8 1160.4 30493.5 30846.8 30860.7 31157.5 31429.2 1050.3 1109.5 1157.6 1162.2 1184.3 16177.3 16332.6 16404.6 16425.8 16647.4 427602.0 428416.0 428734.0 433190.0 434237.0 51331.1 52235.7 52241.0 52245.0 52349.0 1266.4 1330.1 1373.2 1391.6 1392.5 31262.8 32678.5 32717.6 32804.8 33104.2 48264.3 48535.3 48863.8 48878.0 48900.8 314166.0 314502.0 314654.0 314818.0 315088.0 34210.5 39704.4 40337.8 40889.2 41086.4 45530.8 45983.1 46549.8 47094.5 47157.3 38393.0 40673.6 40686.8 40869.8 41155.6 39082.4 40011.4 40268.6 40324.4 40752.2 39607.0 40290.6 40455.2 40474.0 40532.4 33216.7 35968.0 36374.3 36562.3 36600.8 27293.9 27486.6 27696.2 27722.9 27795.9 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#2] jquery.html Cycles:180 Average:28069.28 Median:2690.08 stddev:77478.20 (2880.1%) stddev-sans-first:77667.67 16:30:22 INFO - PROCESS | 9983 | Values: 388.3 389.5 394.9 397.5 415.7 17990.1 19487.4 19494.4 19524.1 20424.0 18461.1 18881.6 18901.7 19168.1 19458.3 5533.9 5624.8 5656.8 5669.7 5689.7 5514.0 5596.8 5611.4 5612.9 5632.4 5509.6 5554.0 5593.8 5599.8 5631.4 5502.6 5525.4 5546.2 5551.7 5640.9 4793.2 4994.1 5029.1 5039.3 5040.6 22643.0 22808.7 22998.6 23215.7 23356.3 2327.5 2368.3 2446.1 2655.4 2724.8 13881.7 14288.2 14412.9 14512.3 14897.7 1905.3 1961.0 1984.5 2000.9 2001.3 51347.5 70066.3 74679.3 74883.6 86384.0 10762.9 10943.8 11095.7 11104.9 11322.8 15531.0 15565.6 15619.7 15655.6 15675.7 7671.3 7756.8 7825.9 7907.1 7990.7 7090.7 7151.8 7215.2 7243.3 7544.3 4647.8 4662.5 4717.5 4737.8 4781.0 1932.8 1933.8 1950.6 2002.5 2017.7 893.0 1007.9 1022.9 1065.6 1083.7 18688.3 18864.0 19112.7 19278.7 19664.8 941.7 961.1 967.5 982.1 1001.2 10410.3 10933.1 10936.5 10973.3 10991.2 459488.0 460484.0 463540.8 482053.0 484292.0 89959.0 91142.0 91602.5 92170.0 92492.0 1011.1 1013.0 1053.0 1068.5 1081.6 16655.1 16762.7 16873.9 16996.8 17630.6 39766.0 40666.2 40733.8 41433.7 41975.6 55065.0 57084.7 57698.4 58227.0 59531.0 8381.7 8451.8 8677.0 8801.7 8992.2 9207.0 12124.8 12194.0 12567.1 12583.3 10989.7 11107.9 11207.6 11254.3 11507.7 10418.4 10877.8 10893.1 11022.2 11165.3 9517.4 11329.1 11443.5 11484.8 11590.7 8572.9 8673.8 8730.6 8897.9 8967.2 8511.0 10670.7 10907.8 10935.9 11201.0 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#3] mootools.html Cycles:180 Average:5767.81 Median:4716.72 stddev:3325.96 (70.5%) stddev-sans-first:3318.42 16:30:22 INFO - PROCESS | 9983 | Values: 1310.1 1525.0 1550.8 1719.9 1852.6 8387.6 8818.5 8822.2 9063.3 9080.2 8773.1 8950.8 8979.2 8981.0 9006.3 1937.6 2225.1 2303.5 2331.6 2355.8 2321.7 2333.3 2333.7 2334.8 2340.9 2307.8 2331.3 2333.1 2336.3 2339.4 1903.4 2181.3 2244.8 2245.3 2254.6 2272.5 2290.6 2295.4 2295.5 2298.6 8580.7 8640.4 8654.1 8664.2 8674.0 5179.7 5316.2 5316.6 5318.3 5320.3 3202.7 3253.9 3407.7 3433.7 3441.8 1075.2 1105.1 1114.0 1141.2 1160.2 11981.5 12005.3 12032.4 12095.4 12096.9 4507.4 4647.2 4650.7 4767.7 4769.8 10230.4 10246.1 10250.1 10255.7 10256.1 5352.5 5354.2 5361.5 5363.6 5364.8 4149.8 4789.1 4915.4 4919.3 4981.6 3881.1 3979.1 3990.6 4038.1 4063.6 1241.8 1250.4 1268.9 1275.7 1280.5 855.9 861.7 901.8 920.2 925.8 5576.1 5624.0 5707.2 5742.7 5843.3 939.4 959.9 970.3 979.7 1012.4 3810.2 3813.2 3835.8 3948.7 3965.1 10799.4 10994.5 11032.4 11076.3 11116.8 10896.6 10994.6 11000.5 11022.6 11023.1 8025.1 8297.7 8397.4 8398.8 8403.7 5363.1 5475.0 5564.6 5620.8 5692.2 10018.8 10163.7 10225.5 10376.8 10483.8 10436.7 10494.1 10539.7 10588.2 10640.4 6574.9 7207.6 7214.2 7404.0 7618.7 8719.8 8730.4 8765.4 8795.0 8808.3 7590.7 7824.8 7844.6 7868.8 7942.4 7638.5 7689.5 7711.9 7826.0 7827.2 6796.5 6809.3 6839.3 6839.6 6840.2 4689.1 4744.3 4860.7 4905.4 4910.3 4883.1 4939.6 4981.2 5000.4 5024.1 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#4] prototype.html Cycles:180 Average:4633.31 Median:5303.27 stddev:1366.62 (25.8%) stddev-sans-first:1331.75 16:30:22 INFO - PROCESS | 9983 | Values: 331.0 331.8 336.9 337.9 339.9 5236.2 5284.3 5321.6 5356.4 5356.6 5261.0 5263.7 5266.0 5268.4 5268.8 3929.6 3956.8 4084.2 4117.9 4120.0 4045.8 4088.3 4092.3 4092.9 4099.1 3914.7 4056.5 4058.4 4059.5 4062.9 3909.2 4022.9 4031.5 4036.2 4046.3 3573.9 3580.8 3584.9 3589.1 3602.4 5039.4 5064.5 5064.7 5080.6 5097.9 4538.5 4637.5 4663.8 4695.2 4701.6 5412.7 5435.7 5454.2 5458.8 5465.9 3961.3 3968.0 3968.3 3968.6 3976.6 5517.7 5586.8 5636.4 5686.7 5698.2 4038.6 4055.7 4059.4 4071.4 4082.1 4102.8 4105.9 4107.0 4112.4 4123.1 4371.4 4642.7 4645.7 4646.6 4663.9 5508.6 5541.8 5546.6 5552.2 5562.4 1402.6 1419.5 1419.8 1420.3 1424.0 885.1 896.4 903.7 926.6 937.2 5237.6 5264.7 5281.9 5313.6 5316.7 5631.9 5648.4 5649.9 5683.4 5708.0 5114.9 5238.4 5243.3 5253.1 5393.6 2982.5 3001.1 3014.4 3031.2 3051.6 5784.9 5785.9 5847.9 5850.9 5879.2 5570.6 5810.9 5816.4 5828.2 5839.4 5800.7 5801.2 5830.7 5846.8 5862.6 5386.9 5614.7 5633.7 5675.0 5678.3 5583.8 5595.7 5603.9 5612.8 5653.9 5803.8 5856.5 5874.1 5901.4 5905.1 3855.0 4034.6 4059.9 4072.1 4077.3 5669.7 5701.5 5703.9 5706.3 5723.3 5303.9 5394.5 5539.3 5547.3 5570.9 5501.0 5506.8 5520.0 5527.7 5536.5 5184.2 5377.2 5436.6 5443.8 5447.2 5531.1 5549.6 5552.8 5566.5 5574.9 5302.7 5354.4 5398.0 5418.7 5438.8 16:30:22 INFO - PROCESS | 9983 | 16:30:22 INFO - PROCESS | 9983 | [#5] yui.html Cycles:180 Average:15760.58 Median:56501.58 stddev:19252.78 (34.1%) stddev-sans-first:19273.79 16:30:22 INFO - PROCESS | 9983 | Values: 747.7 819.0 822.3 843.2 859.8 15251.5 15708.2 15759.7 15802.9 15867.4 14197.1 14339.7 14582.3 14657.6 14676.7 662.0 803.3 813.6 818.7 819.6 767.4 807.2 809.2 816.4 824.7 845.5 845.6 848.6 849.4 850.7 677.5 808.5 844.3 845.6 846.0 612.5 619.6 623.1 624.9 625.2 14114.9 14119.2 14143.9 14158.9 14188.1 13881.0 14251.6 14287.6 14293.3 14680.9 11846.4 12001.4 12210.0 12243.5 12388.9 4434.4 4462.4 4485.4 4496.8 4502.2 60338.4 60508.4 60790.7 62646.7 63217.1 11211.2 11322.3 11386.7 11486.8 11683.8 20647.2 20975.1 21047.7 21066.2 21268.5 8683.5 8692.0 8755.6 8815.8 8857.0 4660.6 4667.5 4746.4 4749.1 4897.0 3348.7 3447.1 3459.1 3461.2 3464.2 590.0 591.9 601.1 604.7 623.0 633.5 647.5 677.6 745.3 750.0 8972.8 9415.8 9529.9 9606.4 9809.2 575.9 620.8 629.9 714.5 732.8 4099.7 4259.7 4282.4 4286.6 4343.7 65151.3 68196.7 68264.0 68581.0 68617.3 61344.0 62331.7 62594.4 62786.0 64048.7 56481.7 56521.4 56558.2 56634.4 57401.0 8080.6 8188.0 8295.9 8352.5 8603.0 37151.4 37882.4 37920.6 38196.2 38661.6 46476.8 50543.7 50732.5 50753.0 51104.7 11059.0 11140.5 11250.3 11423.5 11502.3 12065.6 12212.7 12256.3 12305.9 12407.4 11325.3 11406.4 11566.4 11622.1 11654.8 11330.8 11384.9 11386.0 11600.1 11945.8 11233.2 11503.7 11559.2 11603.6 11895.5 9504.5 9653.8 9802.3 9977.4 9984.2 9623.4 9738.5 9794.5 9804.6 9843.4 16:30:22 INFO - PROCESS | 9983 | -------- Summary: end -------- 16:30:22 INFO - PROCESS | 9983 | 16:30:23 INFO - TEST-INFO | 9983: exit 0 16:30:23 INFO - TEST-OK | dromaeo_css | took 1114082ms 16:30:23 INFO - TEST-START | kraken 16:30:23 INFO - operating with platform_type : linux_ 16:30:23 INFO - Initialising browser for kraken test... 16:30:23 INFO - TEST-INFO | started process 10165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTRESg_/profile http://localhost:58000/getInfo.html) 16:30:27 INFO - PROCESS | 10165 | __metrics Screen width/height:1600/1200 16:30:27 INFO - PROCESS | 10165 | colorDepth:24 16:30:27 INFO - PROCESS | 10165 | Browser inner width/height: 1024/697 16:30:27 INFO - PROCESS | 10165 | __metrics 16:30:29 INFO - PROCESS | 10165 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:30:29 ERROR - PROCESS | 10165 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:30:30 INFO - TEST-INFO | 10165: exit 0 16:30:30 INFO - Browser initialized. 16:30:30 INFO - Running cycle 1/1 for kraken test... 16:30:30 INFO - TEST-INFO | started process 10249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTRESg_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:41 INFO - PROCESS | 10249 | RSS: Main: 155197440 16:30:41 INFO - PROCESS | 10249 | 16:30:44 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58000/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:45 INFO - PROCESS | 10249 | RSS: Main: 213766144 16:30:45 INFO - PROCESS | 10249 | 16:30:47 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58000/tests/kraken/driver.html?testName=audio-dft) 16:30:48 INFO - PROCESS | 10249 | RSS: Main: 198004736 16:30:48 INFO - PROCESS | 10249 | 16:30:51 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58000/tests/kraken/driver.html?testName=audio-fft) 16:30:52 INFO - PROCESS | 10249 | RSS: Main: 269021184 16:30:52 INFO - PROCESS | 10249 | 16:30:54 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58000/tests/kraken/driver.html?testName=audio-oscillator) 16:30:54 INFO - PROCESS | 10249 | RSS: Main: 179576832 16:30:54 INFO - PROCESS | 10249 | 16:30:57 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:57 INFO - PROCESS | 10249 | RSS: Main: 183926784 16:30:57 INFO - PROCESS | 10249 | 16:31:00 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58000/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:01 INFO - PROCESS | 10249 | RSS: Main: 218042368 16:31:01 INFO - PROCESS | 10249 | 16:31:04 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58000/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:05 INFO - PROCESS | 10249 | RSS: Main: 220282880 16:31:05 INFO - PROCESS | 10249 | 16:31:08 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58000/tests/kraken/driver.html?testName=json-parse-financial) 16:31:08 INFO - PROCESS | 10249 | RSS: Main: 220643328 16:31:08 INFO - PROCESS | 10249 | 16:31:10 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:10 INFO - PROCESS | 10249 | RSS: Main: 209121280 16:31:10 INFO - PROCESS | 10249 | 16:31:12 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:13 INFO - PROCESS | 10249 | RSS: Main: 211177472 16:31:13 INFO - PROCESS | 10249 | 16:31:15 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:15 INFO - PROCESS | 10249 | RSS: Main: 216932352 16:31:15 INFO - PROCESS | 10249 | 16:31:18 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:18 INFO - PROCESS | 10249 | RSS: Main: 224288768 16:31:18 INFO - PROCESS | 10249 | 16:31:21 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:22 INFO - PROCESS | 10249 | RSS: Main: 224899072 16:31:22 INFO - PROCESS | 10249 | 16:31:23 INFO - PROCESS | 10249 | Cycle 1(1): loaded http://localhost:58000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58000/tests/kraken/driver.html?testName=ai-astar) 16:31:24 INFO - PROCESS | 10249 | RSS: Main: 267505664 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | __start_tp_report 16:31:24 INFO - PROCESS | 10249 | _x_x_mozilla_page_load 16:31:24 INFO - PROCESS | 10249 | _x_x_mozilla_page_load_details 16:31:24 INFO - PROCESS | 10249 | |i|pagename|runs| 16:31:24 INFO - PROCESS | 10249 | |0;ai-astar;110;105;110;110;111;110;110;110;113;111 16:31:24 INFO - PROCESS | 10249 | |1;audio-beat-detection;157;124;128;180;125;133;159;132;168;124 16:31:24 INFO - PROCESS | 10249 | |2;audio-dft;162;159;161;161;159;160;161;161;160;160 16:31:24 INFO - PROCESS | 10249 | |3;audio-fft;76;75;75;153;74;76;75;74;105;74 16:31:24 INFO - PROCESS | 10249 | |4;audio-oscillator;84;83;110;85;85;85;120;84;85;119 16:31:24 INFO - PROCESS | 10249 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 16:31:24 INFO - PROCESS | 10249 | |6;imaging-darkroom;146;148;146;146;146;147;146;145;145;145 16:31:24 INFO - PROCESS | 10249 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;94 16:31:24 INFO - PROCESS | 10249 | |8;json-parse-financial;53;52;53;53;53;52;54;52;52;51 16:31:24 INFO - PROCESS | 10249 | |9;json-stringify-tinderbox;62;62;61;62;62;61;62;62;62;62 16:31:24 INFO - PROCESS | 10249 | |10;stanford-crypto-aes;80;80;80;81;83;82;81;85;112;84 16:31:24 INFO - PROCESS | 10249 | |11;stanford-crypto-ccm;128;128;121;119;123;119;118;119;137;132 16:31:24 INFO - PROCESS | 10249 | |12;stanford-crypto-pbkdf2;170;161;160;160;159;160;165;159;163;158 16:31:24 INFO - PROCESS | 10249 | |13;stanford-crypto-sha256-iterative;72;63;68;64;63;62;64;62;62;66 16:31:24 INFO - PROCESS | 10249 | __end_tp_report 16:31:24 INFO - PROCESS | 10249 | __start_cc_report 16:31:24 INFO - PROCESS | 10249 | _x_x_mozilla_cycle_collect,1593 16:31:24 INFO - PROCESS | 10249 | __end_cc_report 16:31:24 INFO - PROCESS | 10249 | __startTimestamp1464651084206__endTimestamp 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | ------- Summary: start ------- 16:31:24 INFO - PROCESS | 10249 | Number of tests: 14 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:2.12 16:31:24 INFO - PROCESS | 10249 | Values: 110.0 105.0 110.0 110.0 111.0 110.0 110.0 110.0 113.0 111.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:145.00 stddev:20.92 (14.4%) stddev-sans-first:21.56 16:31:24 INFO - PROCESS | 10249 | Values: 157.0 124.0 128.0 180.0 125.0 133.0 159.0 132.0 168.0 124.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 16:31:24 INFO - PROCESS | 10249 | Values: 162.0 159.0 161.0 161.0 159.0 160.0 161.0 161.0 160.0 160.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#3] audio-fft Cycles:10 Average:85.70 Median:75.00 stddev:25.48 (34.0%) stddev-sans-first:26.79 16:31:24 INFO - PROCESS | 10249 | Values: 76.0 75.0 75.0 153.0 74.0 76.0 75.0 74.0 105.0 74.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.50 stddev:15.64 (18.5%) stddev-sans-first:16.17 16:31:24 INFO - PROCESS | 10249 | Values: 84.0 83.0 110.0 85.0 85.0 85.0 120.0 84.0 85.0 119.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:31:24 INFO - PROCESS | 10249 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 16:31:24 INFO - PROCESS | 10249 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 145.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:31:24 INFO - PROCESS | 10249 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 16:31:24 INFO - PROCESS | 10249 | Values: 53.0 52.0 53.0 53.0 53.0 52.0 54.0 52.0 52.0 51.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:31:24 INFO - PROCESS | 10249 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.50 stddev:9.72 (11.9%) stddev-sans-first:10.15 16:31:24 INFO - PROCESS | 10249 | Values: 80.0 80.0 80.0 81.0 83.0 82.0 81.0 85.0 112.0 84.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.50 stddev:6.54 (5.2%) stddev-sans-first:6.80 16:31:24 INFO - PROCESS | 10249 | Values: 128.0 128.0 121.0 119.0 123.0 119.0 118.0 119.0 137.0 132.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:160.50 stddev:3.63 (2.3%) stddev-sans-first:2.19 16:31:24 INFO - PROCESS | 10249 | Values: 170.0 161.0 160.0 160.0 159.0 160.0 165.0 159.0 163.0 158.0 16:31:24 INFO - PROCESS | 10249 | 16:31:24 INFO - PROCESS | 10249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:3.24 (5.1%) stddev-sans-first:2.05 16:31:24 INFO - PROCESS | 10249 | Values: 72.0 63.0 68.0 64.0 63.0 62.0 64.0 62.0 62.0 66.0 16:31:24 INFO - PROCESS | 10249 | -------- Summary: end -------- 16:31:24 INFO - PROCESS | 10249 | 16:31:25 INFO - TEST-INFO | 10249: exit 0 16:31:25 INFO - TEST-OK | kraken | took 61966ms 16:31:25 INFO - SUITE-END | took 1176s 16:31:25 INFO - Completed test suite (00:19:36) 16:31:25 INFO - javascript benchmark 16:31:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.1414803854923, 3082.244850011746, 3106.0526539405478, 3110.346827166295, 3152.4325621388157, 5157.71632560209, 5207.843764687056, 5277.261183434318, 5403.40562538121, 5416.972915135424, 5266.131088370415, 5270.604704647148, 5293.735313234332, 5376.381716102649, 5395.676259424437, 4696.29555566666, 4708.387909571768, 4786.114568804782, 4796.064767370364, 5011.173156429185, 4923.729194894279, 4938.48145944676, 4949.109160351135, 4995.375578052744, 5019.498050194988, 4698.224792909183, 4722.433308003045, 4766.642501812378, 4798.5441383068555, 4809.182438985381, 4775.14047471455, 4810.470848206694, 4884.7069175849565, 4886.633502487328, 4933.136701077333, 4711.387519622462, 4776.617870570346, 4789.114013907439, 4806.0, 4835.178019736653, 5219.42586315505, 5295.867603309909, 5296.09966305729, 5338.813141540067, 5363.115086010804, 5773.278340207474, 5782.3639399666, 5791.594588378815, 5820.767169313222, 5830.7084645767545, 5557.221988921554, 5699.145128230757, 5799.2750906136735, 5852.941470585325, 5857.150713146612, 5363.0, 5481.314835645544, 5483.616146869721, 5486.61593688438, 5490.945090549043, 5967.19442875215, 5985.132155837467, 5990.700464976734, 5991.131285963511, 5991.400859914061, 5411.350637923474, 5529.225908372831, 5559.583031272671, 5723.255976723, 5754.165645981393, 5688.345840228344, 5732.828015159552, 5741.196232527366, 5743.966086104458, 5751.827445176651, 5631.8592035199445, 5674.829755107354, 5681.744321505542, 5686.715664216856, 5688.431156884279, 5476.397596264408, 5667.149927510906, 5677.545796336283, 5735.397783232784, 5735.885282294331, 4380.518143004267, 4381.759003254788, 4384.4519435070615, 4385.6052955233545, 4416.072624748775, 3896.2207558488417, 3912.7456715313415, 3919.0202449387652, 3956.802159891994, 3959.6436320731273, 5264.184051472028, 5270.262163297141, 5321.467853214725, 5364.168553874156, 5374.032674118696, 5742.856428589235, 5748.597598168088, 5754.280714910637, 5783.421657834267, 5793.797217097465, 5382.596305277119, 5397.2443857859935, 5401.081816091274, 5405.135178371442, 5406.243125962368, 4810.831620893252, 4925.187344088257, 4940.7035577865445, 4959.950400495949, 5004.424491183488, 5935.614185077956, 5950.375210602911, 5954.55340849438, 5957.314908785458, 5958.0, 5794.188813566104, 5803.680797556175, 5816.069428891357, 5823.94176058234, 5829.854253643693, 5660.179274005329, 5885.852853678521, 5889.617174883619, 5932.1694962706115, 5951.047832346804, 5647.943520564741, 5676.744546495335, 5680.488756011979, 5686.203931449518, 5687.914681279702, 5754.367019627922, 5783.537317014713, 5804.2744656917885, 5805.10020946754, 5805.158252053513, 5358.089124848707, 5576.442355764391, 5626.971865140648, 5628.690422026664, 5665.886682266414, 5628.718564071862, 5633.0705433604635, 5645.463680950304, 5646.632968857011, 5648.406917273627, 5317.946820531745, 5555.555555555465, 5563.582731295088, 5567.0, 5573.944260557505, 5735.684537350486, 5798.072308430631, 5804.82585522435, 5811.622244554091, 5812.476877081083, 5600.915986260128, 5637.802676906289, 5639.689817060101, 5640.0693885508435, 5665.943340566707], "value": 5285.605354097155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.234033628133, 634.9777757778477, 636.7707625254909, 644.1786721929542, 649.1658219188344, 31004.22489437765, 33540.4968925466, 41873.79063104684, 43297.134057318835, 43325.566744332624, 41891.16217675645, 42184.57815421845, 42494.15011699764, 42754.0, 42761.0, 8516.574171291426, 8731.301495880314, 8734.563271836414, 8737.21365077143, 8738.563071846414, 8542.914570854306, 8714.128587141267, 8714.564271786418, 8724.258438032743, 8734.0, 8707.47755134694, 8716.08481109484, 8743.562821858914, 8750.606222719962, 8759.868601970975, 8662.52356120413, 8708.346873984414, 8713.172248636369, 8731.432456890281, 8738.432001919855, 8621.353398495075, 8677.132286771272, 8697.826043479095, 8697.956245250547, 8707.737378080206, 39464.0, 39707.0, 39917.60082399168, 39967.40048899269, 39967.40048899269, 3444.156181735466, 3587.515685382492, 4084.1831633673382, 4165.12532368203, 4287.035417031143, 29870.70129298701, 30534.236644083852, 30844.2288942776, 30857.228569285722, 31735.04794856158, 4273.18809426208, 4418.160549495586, 4451.888702782424, 4476.55234476553, 4503.864884053483, 283903.0, 283974.0, 284212.0, 285108.5744571285, 285309.0, 53357.0, 54300.0, 54430.72784636052, 54466.18300725492, 54550.0, 56712.43287567154, 57313.426865730806, 57396.42603573994, 57458.712706437036, 57512.0, 15961.201939902958, 16305.103219323051, 16309.51071467858, 16317.184140792913, 16320.673586528203, 11132.220744547803, 11159.72100697489, 11162.720931976766, 11165.162612804072, 11201.71995700114, 15082.54752357409, 15983.520494385188, 16083.195840208176, 16157.434489793035, 16216.432424865308, 6078.240219972504, 6326.230932901843, 6358.205224346957, 6384.52116091295, 6426.807195784134, 1016.2682868334787, 1139.1171841822488, 1140.811766058591, 1148.8104462763552, 1160.4255893332854, 30493.542596861065, 30846.845765771475, 30860.691393086232, 31157.532637010463, 31429.214269642984, 1050.3120456101267, 1109.4785450838094, 1157.6353448663813, 1162.2271189658952, 1184.319016565461, 16177.272022759003, 16332.591685207728, 16404.589885252964, 16425.753613695804, 16647.41734039327, 427602.0, 428416.0, 428734.0, 433190.0, 434237.0, 51331.12354326333, 52235.73882130565, 52241.0, 52245.0, 52349.0, 1266.4047897488165, 1330.1420583723639, 1373.203541945669, 1391.589481103077, 1392.498700467851, 31262.843685781427, 32678.509822352207, 32717.585964352395, 32804.835975819966, 33104.1723956903, 48264.27603585879, 48535.271970921174, 48863.755681221366, 48878.0, 48900.75549622229, 314166.0, 314502.0, 314654.0, 314818.0, 315088.0, 34210.48684269788, 39704.404433932934, 40337.79831100826, 40889.1822163561, 41086.38370424386, 45530.77234613938, 45983.08033839238, 46549.767251163525, 47094.52905471039, 47157.29264061111, 38393.0, 40673.593264068164, 40686.79656601698, 40869.795651022745, 41155.58844411517, 39082.413763792996, 40011.399829002, 40268.59731402648, 40324.39513407242, 40752.1849563013, 39607.0, 40290.597094028686, 40455.190896181324, 40474.0, 40532.39201411922, 33216.667833322324, 35968.0, 36374.27251455009, 36562.26875462529, 36600.81699591485, 27293.863530682218, 27486.587701184097, 27696.169114926586, 27722.861385692944, 27795.861020694767], "value": 19333.504261564904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2836167271384, 389.52867030892617, 394.899300678327, 397.5170168245582, 415.70692661673525, 17990.100494975264, 19487.41537753868, 19494.415167544998, 19524.121414536345, 20424.0, 18461.076946152672, 18881.62236755264, 18901.716474252862, 19168.13743381548, 19458.318958836444, 5533.944660553393, 5624.831255062355, 5656.830295091154, 5669.716514174295, 5689.715514224293, 5513.972430137844, 5596.776128954837, 5611.3546942101775, 5612.887742245152, 5632.408597097307, 5509.641873278244, 5554.028045092113, 5593.804216852411, 5599.776008959637, 5631.436856314356, 5502.5597952163735, 5525.4474552544825, 5546.195801608765, 5551.72241387929, 5640.943590564103, 4793.161196790583, 4994.076095922266, 5029.119904016782, 5039.3196918415915, 5040.571551418134, 22643.0, 22808.65787013196, 22998.560403087162, 23215.651765223534, 23356.299311020695, 2327.522857814144, 2368.301351101429, 2446.082718980382, 2655.3759866431374, 2724.7820174386, 13881.722365552632, 14288.214148221843, 14412.855871441361, 14512.346944387527, 14897.70204595902, 1905.3426567834076, 1960.9607807843906, 1984.484034151131, 2000.899955002244, 2001.319551352547, 51347.48652513502, 70066.2993370065, 74679.25320746777, 74883.62558187175, 86383.99999999937, 10762.946185269024, 10943.781124377469, 11095.746827220673, 11104.888951110386, 11322.773544529064, 15531.0, 15565.610859728371, 15619.687606248039, 15655.608609784846, 15675.686486270211, 7671.2712292332135, 7756.8448631028195, 7825.865249538785, 7907.0906845712325, 7990.720324788605, 7090.680919358641, 7151.7854464366155, 7215.206327303992, 7243.348098671145, 7544.283293087148, 4647.790849411785, 4662.510436404196, 4717.504662010508, 4737.8341758038305, 4781.0, 1932.8163824436656, 1933.8162874526897, 1950.5611237471455, 2002.4793553675859, 2017.697345398202, 892.9642814287486, 1007.9445630490393, 1022.9028242316969, 1065.6323568369055, 1083.6748975307376, 18688.349373941597, 18864.0, 19112.713309300372, 19278.71081933772, 19664.803351966297, 941.7457286532598, 961.0869673809908, 967.4582233949011, 982.0817535604233, 1001.1690297053428, 10410.271281010257, 10933.070688991365, 10936.507857146447, 10973.286736362112, 10991.230613856953, 459488.0, 460484.0, 463540.7760728426, 482053.0, 484292.0, 89959.0, 91142.0, 91602.54198728963, 92170.0, 92492.0, 1011.0900189829213, 1012.9645462408633, 1052.957881684724, 1068.4871261794383, 1081.6052140968648, 16655.083970381744, 16762.664746705243, 16873.91563042226, 16996.830031699526, 17630.559236019202, 39766.0, 40666.1866762669, 40733.79633101816, 41433.70884743021, 41975.58024419717, 55065.0, 57084.71457642685, 57698.4230157693, 58227.0, 59531.0, 8381.748547543584, 8451.830963380575, 8677.0, 8801.691940782042, 8992.235659968714, 9206.953965230132, 12124.84813942674, 12194.0, 12567.120301578801, 12583.307918064595, 10989.725256868642, 11107.888921110685, 11207.607733729606, 11254.268472549258, 11507.712307192387, 10418.426986515815, 10877.782444351227, 10893.07408870255, 11022.173336999596, 11165.274257173258, 9517.428954262767, 11329.093672506015, 11443.542258309575, 11484.770304593694, 11590.652280431601, 8572.871406928776, 8673.826523469621, 8730.583824317147, 8897.932248130266, 8967.192952634294, 8511.0, 10670.733231668959, 10907.78184436291, 10935.945320273348, 11201.0], "value": 9110.184200799235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.1287643716928, 1524.9542513724589, 1550.759392486011, 1719.9140042997856, 1852.6387354465885, 8387.58062096895, 8818.514981675997, 8822.206001459866, 9063.27493800496, 9080.182783549479, 8773.122687731224, 8950.776230594221, 8979.191872731453, 8981.0, 9006.324525660586, 1937.602791427754, 2225.0765932138142, 2303.4702018535745, 2331.5919714050015, 2355.7762012608773, 2321.686572312733, 2333.3000099970027, 2333.6849525314037, 2334.8248881333884, 2340.871252081135, 2307.8038366738847, 2331.335569362732, 2333.0784340185614, 2336.334144768741, 2339.42684042409, 1903.4004288649169, 2181.3128864407663, 2244.7979681828715, 2245.2702871566726, 2254.6054440473017, 2272.522770218256, 2290.633498640226, 2295.403195169268, 2295.494991101955, 2298.643710224918, 8580.742577722678, 8640.438371505896, 8654.134586541359, 8664.22022018015, 8674.0, 5179.689218646856, 5316.20256961455, 5316.627836051478, 5318.335208098988, 5320.255164277004, 3202.679732026802, 3253.9349213015844, 3407.727381809474, 3433.7081348085444, 3441.7590768646205, 1075.150631001508, 1105.088302150721, 1114.0474893965704, 1141.201159188563, 1160.1704781081567, 11981.46083426248, 12005.339706316148, 12032.39838008105, 12095.39523023854, 12096.939515302454, 4507.4365704286965, 4647.233206520887, 4650.720956742606, 4767.666263361601, 4769.785359658824, 10230.386176829414, 10246.077852993267, 10250.128739057263, 10255.7436064099, 10256.12822910046, 5352.5450336721815, 5354.170103633943, 5361.490658387525, 5363.624546281801, 5364.758585863646, 4149.792510374469, 4789.137955168034, 4915.410150781858, 4919.262110683426, 4981.626378021663, 3881.107345310594, 3979.10470144221, 3990.60328884888, 4038.1318016626565, 4063.593640635972, 1241.7516496700696, 1250.4373032135575, 1268.8794564516356, 1275.6555729953047, 1280.4558062823262, 855.9144085591515, 861.6984055580622, 901.833160865242, 920.1534588178891, 925.847235206197, 5576.079946808813, 5624.0439125348785, 5707.1724599933605, 5742.712864356766, 5843.29880414353, 939.4269495607674, 959.9040095990345, 970.2965350121247, 979.6522234606612, 1012.448215722433, 3810.1808111256214, 3813.218290250492, 3835.846566137379, 3948.723589348718, 3965.088029753173, 10799.352038877692, 10994.450277486094, 11032.393218372907, 11076.335419874673, 11116.777664446667, 10896.564137434414, 10994.560217591366, 11000.504977276041, 11022.614208502664, 11023.118150548098, 8025.077116131602, 8297.668093276201, 8397.412181147261, 8398.832023359499, 8403.705870294632, 5363.115086010765, 5474.972625136849, 5564.610477266552, 5620.775168993195, 5692.174634678031, 10018.849717254392, 10163.695089147337, 10225.488725563544, 10376.844347334645, 10483.842742358718, 10436.686899393031, 10494.108000820015, 10539.683809485728, 10588.205884558534, 10640.361578305326, 6574.868502630016, 7207.603581803051, 7214.242504536948, 7404.0, 7618.69525218985, 8719.825603488021, 8730.432521886058, 8765.430247033923, 8795.0, 8808.295336373203, 7590.696372145052, 7824.843503129791, 7844.568548729874, 7868.84262314762, 7942.364610831235, 7638.465307428427, 7689.538627682357, 7711.922880771121, 7826.0, 7827.217278272127, 6796.456283497209, 6809.285025072296, 6839.281875403011, 6839.589624622538, 6840.247572767091, 4689.132510485571, 4744.312074749211, 4860.732659703609, 4905.4358748742925, 4910.337104490991, 4883.121038213156, 4939.580135688363, 4981.2030075187795, 5000.424951130666, 5024.145895197898], "value": 4594.199936841345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.9851056702448, 331.75450166876504, 336.88882668719316, 337.9003194057753, 339.8606571305765, 5236.188390799422, 5284.339457567804, 5321.574274058075, 5356.375376065729, 5356.625036247464, 5261.000409922121, 5263.736813159337, 5266.0, 5268.394134674504, 5268.789248430058, 3929.5677475477746, 3956.8417263309575, 4084.1825387702484, 4117.897052573695, 4119.958800412002, 4045.797710114497, 4088.325426304656, 4092.3452247640384, 4092.85675001375, 4099.118689481761, 3914.667253283474, 4056.452378928851, 4058.391241313797, 4059.4925634295714, 4062.8781136565804, 3909.1790723948006, 4022.859199928018, 4031.5363733170766, 4036.2331157080353, 4046.332355161395, 3573.8927832165077, 3580.785152890835, 3584.9283014339826, 3589.0668426209113, 3602.423612222032, 5039.370078740158, 5064.518870707314, 5064.670796398223, 5080.618953578496, 5097.872553186163, 4538.546145385468, 4637.513061128567, 4663.790129444184, 4695.201815691341, 4701.623870090384, 5412.675239485643, 5435.673859568438, 5454.236406903036, 5458.808941687022, 5465.9180112298345, 3961.336238779719, 3968.0, 3968.3452230381954, 3968.603139686037, 3976.602339766029, 5517.69652669103, 5586.832395028156, 5636.379998200195, 5686.715664216773, 5698.202251684767, 4038.6163314485075, 4055.742719756885, 4059.4113853491667, 4071.432498488103, 4082.14262510557, 4102.835886564564, 4105.876823695294, 4106.979465102655, 4112.383142528584, 4123.092919557693, 4371.409859668967, 4642.721436713808, 4645.6980296280635, 4646.605038571759, 4663.906721865544, 5508.586855985817, 5541.778328866801, 5546.584006199551, 5552.167174923713, 5562.443755624486, 1402.6353148181547, 1419.5457453614952, 1419.7799341102145, 1420.2685616907302, 1423.9572812815632, 885.1104639836923, 896.3635818568758, 903.7257466971539, 926.6108234541508, 937.2267878999852, 5237.554807841376, 5264.684118952875, 5281.894362112736, 5313.57491400687, 5316.73416329182, 5631.915521267184, 5648.435156484401, 5649.858753531194, 5683.442450897112, 5707.971460142673, 5114.872128196825, 5238.371395432572, 5243.292155558951, 5253.13323301651, 5393.649412788156, 2982.478066338382, 3001.0943051162667, 3014.4121896230026, 3031.242189452637, 3051.588035615208, 5784.855378615568, 5785.942140578541, 5847.94152058474, 5850.94149058504, 5879.206307148565, 5570.637908535932, 5810.908073093683, 5816.447437493432, 5828.242328497268, 5839.445252701072, 5800.7099645018425, 5801.216835727208, 5830.737616807254, 5846.824595262149, 5862.5896187267335, 5386.919196212139, 5614.719264036864, 5633.718314084362, 5674.971625142013, 5678.290213723285, 5583.804566840141, 5595.664260144405, 5603.943960560506, 5612.831615051555, 5653.858653533694, 5803.7968671096305, 5856.502197313106, 5874.148248504029, 5901.377121291679, 5905.143754155709, 3854.9807250963568, 4034.556198818186, 4059.89850253746, 4072.124493233969, 4077.286474866946, 5669.744861481161, 5701.543876489954, 5703.942960570341, 5706.3152421709665, 5723.284589426322, 5303.893922121613, 5394.460553944731, 5539.279893613804, 5547.306586676666, 5570.916436253378, 5500.9823182711325, 5506.834794956158, 5520.0, 5527.668339899619, 5536.52939500147, 5184.170532714898, 5377.220303056113, 5436.592255580768, 5443.836684899459, 5447.1829225616475, 5531.119419397424, 5549.639273447213, 5552.7778888843995, 5566.471185237396, 5574.91637625444, 5302.655327403706, 5354.437784032621, 5397.973010134924, 5418.674879507243, 5438.809641662523], "value": 4198.1258305520705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.7382915979407, 819.025359821812, 822.3256929317957, 843.1694780641071, 859.793649524114, 15251.466198683049, 15708.214589270548, 15759.684806303896, 15802.92098539507, 15867.444639437608, 14197.089596632692, 14339.71320573588, 14582.270886455688, 14657.56027319182, 14676.706465870677, 662.0301258656068, 803.3252068262673, 813.5769399912042, 818.7093581778443, 819.5697258939075, 767.4090949968548, 807.1928071928072, 809.1503920883079, 816.4203415574949, 824.7031068815222, 845.480029781686, 845.5941148248844, 848.6266042941118, 849.4011721736161, 850.6852464588111, 677.5325025732278, 808.5027707959621, 844.2907957315854, 845.5603086395101, 846.0397448895517, 612.5375341617095, 619.553921176752, 623.1400667079447, 624.8625302433458, 625.1935003845034, 14114.858851411456, 14119.223442710647, 14143.858561414358, 14158.858411415857, 14188.077774944595, 13881.0, 14251.64370890736, 14287.57137285883, 14293.285335733275, 14680.944667746524, 11846.407679615984, 12001.399930003552, 12210.0, 12243.510259589606, 12388.938055309665, 4434.35701823237, 4462.419885414908, 4485.394471746337, 4496.830823985754, 4502.234620114588, 60338.396616033715, 60508.39491605072, 60790.69604651993, 62646.68676656633, 63217.05174422387, 11211.215214934877, 11322.26405283654, 11386.658400248005, 11486.770264594661, 11683.824742628867, 20647.17411303531, 20975.056122474525, 21047.68428473574, 21066.15735370568, 21268.468288292916, 8683.522406267715, 8691.956540217385, 8755.649774008969, 8815.823683526422, 8857.02487151297, 4660.603848672833, 4667.509911459316, 4746.38297021385, 4749.050189962021, 4897.020595880838, 3348.68187522185, 3447.052060683282, 3459.066052165901, 3461.2039230977016, 3464.185916309665, 589.9823005309847, 591.8845825064071, 601.0593421295658, 604.7067172421372, 623.0405176028955, 633.4868756307313, 647.5143642268299, 677.552815142004, 745.2845268542152, 749.9962500187464, 8972.76641174148, 9415.811683766286, 9529.90470095304, 9606.423614583147, 9809.166220871306, 575.9452851979055, 620.8261686727724, 629.9244090709144, 714.4712912444753, 732.8241222106763, 4099.709222854574, 4259.701820872509, 4282.400463935051, 4286.635635970977, 4343.739375637472, 65151.34848651453, 68196.6590167056, 68264.0, 68581.0, 68617.3138268621, 61344.0, 62331.68834155891, 62594.37405625886, 62786.0, 64048.67975660092, 56481.71759141178, 56521.43478565244, 56558.151627725616, 56634.43365566374, 57401.0, 8080.636371363185, 8187.959060204661, 8295.917040829756, 8352.540610266251, 8603.0, 37151.44272835964, 37882.43176352412, 37920.620793791706, 38196.236075278895, 38661.6133838658, 46476.76761616306, 50543.74728126336, 50732.49267507425, 50753.0, 51104.74447627738, 11059.0, 11140.498677559368, 11250.324980501196, 11423.543058277575, 11502.309861408008, 12065.638030859089, 12212.694682633006, 12256.325902075472, 12305.876941230474, 12407.379631018232, 11325.263857849213, 11406.372649504357, 11566.363849988331, 11622.07023438106, 11654.766904662029, 11330.773384532427, 11384.943075284571, 11386.0, 11600.071994240272, 11945.761084778082, 11233.157513186381, 11503.712407189887, 11559.248648837798, 11603.593874214363, 11895.524179032742, 9504.524773761146, 9653.758656033655, 9802.264830137625, 9977.401355918379, 9984.151347135576, 9623.374480658735, 9738.513074346396, 9794.510274486105, 9804.55879485439, 9843.409395436296], "value": 6808.10301029013, "unit": "score"}], "name": "dromaeo_css", "value": 7044.951684886109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 113.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 128.0, 180.0, 125.0, 133.0, 159.0, 132.0, 168.0, 124.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 153.0, 74.0, 76.0, 75.0, 74.0, 105.0, 74.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 110.0, 85.0, 85.0, 85.0, 120.0, 84.0, 85.0, 119.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 52.0, 54.0, 52.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 81.0, 83.0, 82.0, 81.0, 85.0, 112.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 121.0, 119.0, 123.0, 119.0, 118.0, 119.0, 137.0, 132.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 161.0, 160.0, 160.0, 159.0, 160.0, 165.0, 159.0, 163.0, 158.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 68.0, 64.0, 63.0, 62.0, 64.0, 62.0, 62.0, 66.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1500.1999999999998, "alertThreshold": 2.0}]} 16:31:25 INFO - Return code: 0 16:31:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:31:25 ERROR - # TBPL SUCCESS # 16:31:25 INFO - Running post-action listener: _resource_record_post_action 16:31:25 INFO - ##### 16:31:25 INFO - ##### Finished run-tests step (success) 16:31:25 INFO - ##### 16:31:25 INFO - Running post-run listener: _resource_record_post_run 16:31:25 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 545001472; Read time: 0; Write time: 1502820 16:31:25 INFO - TinderboxPrint: CPU usage
13.3% 16:31:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:31:25 INFO - TinderboxPrint: I/O write bytes / time
545,001,472 / 1,502,820 16:31:25 INFO - TinderboxPrint: CPU idle
8,272.3 (86.7%) 16:31:25 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 16:31:25 INFO - TinderboxPrint: Swap in / out
0 / 0 16:31:25 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 254197760; Read time: 0; Write time: 700520 16:31:25 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 290803712; Read time: 0; Write time: 802300 16:31:26 INFO - Running post-run listener: _upload_blobber_files 16:31:26 INFO - Blob upload gear active. 16:31:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:26 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 16:31:26 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'] 16:31:26 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 16:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:30 INFO - (blobuploader) - INFO - Done attempting. 16:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:31 INFO - (blobuploader) - INFO - Done attempting. 16:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:31 INFO - (blobuploader) - INFO - Done attempting. 16:31:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:31 INFO - Return code: 0 16:31:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb537c79798342db9c4b643bdfc18881e890a6efc2e4093fe34f2e1cc7903beaf486cbc9a248291b0907fc1f85fa49c348960108c32e287a9db8aabfce8541f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/096b898d5efb54bb7d169a3393266ed76fe93a40057bf8f5b665a4a0ebf1b5dd778da2aedfbdcfc2079e341a3fba2cb6269397402cace1e91deee592263e46bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee24a10a49a24c778ec2ccfa2fac5983d652ffa98550c71497f31d2a895711aa24de497dc85600df0d1537f874c7ad6e49c3820476709e38d97f53b25142cb44"} 16:31:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:31 INFO - Contents: 16:31:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb537c79798342db9c4b643bdfc18881e890a6efc2e4093fe34f2e1cc7903beaf486cbc9a248291b0907fc1f85fa49c348960108c32e287a9db8aabfce8541f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/096b898d5efb54bb7d169a3393266ed76fe93a40057bf8f5b665a4a0ebf1b5dd778da2aedfbdcfc2079e341a3fba2cb6269397402cace1e91deee592263e46bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee24a10a49a24c778ec2ccfa2fac5983d652ffa98550c71497f31d2a895711aa24de497dc85600df0d1537f874c7ad6e49c3820476709e38d97f53b25142cb44"} 16:31:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:31 INFO - Copying logs to upload dir... 16:31:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.807911 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 16:31:31.796904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:31:31.801065) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 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/bb537c79798342db9c4b643bdfc18881e890a6efc2e4093fe34f2e1cc7903beaf486cbc9a248291b0907fc1f85fa49c348960108c32e287a9db8aabfce8541f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/096b898d5efb54bb7d169a3393266ed76fe93a40057bf8f5b665a4a0ebf1b5dd778da2aedfbdcfc2079e341a3fba2cb6269397402cace1e91deee592263e46bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee24a10a49a24c778ec2ccfa2fac5983d652ffa98550c71497f31d2a895711aa24de497dc85600df0d1537f874c7ad6e49c3820476709e38d97f53b25142cb44"} build_url:https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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/bb537c79798342db9c4b643bdfc18881e890a6efc2e4093fe34f2e1cc7903beaf486cbc9a248291b0907fc1f85fa49c348960108c32e287a9db8aabfce8541f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/096b898d5efb54bb7d169a3393266ed76fe93a40057bf8f5b665a4a0ebf1b5dd778da2aedfbdcfc2079e341a3fba2cb6269397402cace1e91deee592263e46bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee24a10a49a24c778ec2ccfa2fac5983d652ffa98550c71497f31d2a895711aa24de497dc85600df0d1537f874c7ad6e49c3820476709e38d97f53b25142cb44"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:31:31.827254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:31:31.827632) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464649853.534324-1276451822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:31:31.910628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:31:31.910953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:31:31.911244) ========= ========= Total master_lag: 0.19 =========