builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1464088378.86 results: success (0) buildid: 20160524013022 builduid: c72cd9a1f4bb47afa27f396b109fdae9 revision: 8e697c3542ffbe810d6ecc9912a510216471e99b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.864964) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.865391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.865684) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.878237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.878509) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 04:12:59-- 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% 69.6M=0s 2016-05-24 04:12:59 (69.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:58.999970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:59.000284) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:12:59.049234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 04:12:59.049597) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8e697c3542ffbe810d6ecc9912a510216471e99b --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 8e697c3542ffbe810d6ecc9912a510216471e99b --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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 04:12:59,240 truncating revision to first 12 chars 2016-05-24 04:12:59,240 Setting DEBUG logging. 2016-05-24 04:12:59,241 attempt 1/10 2016-05-24 04:12:59,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8e697c3542ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 04:13:00,294 unpacking tar archive at: mozilla-inbound-8e697c3542ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 04:13:00.434872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:13:00.435261) ========= script_repo_revision: 8e697c3542ffbe810d6ecc9912a510216471e99b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:13:00.435760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:13:00.436037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:13:00.444321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-24 04:13:00.444602) ========= /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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:00 INFO - MultiFileLogger online at 20160524 04:13:00 in /builds/slave/test 04:13:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:13:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:00 INFO - {'append_to_log': False, 04:13:00 INFO - 'base_work_dir': '/builds/slave/test', 04:13:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:13:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:00 INFO - 'branch': 'Mozilla-Inbound', 04:13:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:00 INFO - 'config_files': ('talos/linux_config.py',), 04:13:00 INFO - 'default_actions': ('clobber', 04:13:00 INFO - 'read-buildbot-config', 04:13:00 INFO - 'download-and-extract', 04:13:00 INFO - 'populate-webroot', 04:13:00 INFO - 'create-virtualenv', 04:13:00 INFO - 'install', 04:13:00 INFO - 'run-tests'), 04:13:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:00 INFO - 'download_minidump_stackwalk': True, 04:13:00 INFO - 'download_symbols': 'ondemand', 04:13:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:00 INFO - 'installer_path': 'installer.exe', 04:13:00 INFO - 'log_level': 'info', 04:13:00 INFO - 'log_name': 'talos', 04:13:00 INFO - 'log_to_console': True, 04:13:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:00 INFO - 'opt_config_files': (), 04:13:00 INFO - 'pip_index': False, 04:13:00 INFO - 'sps_profile': False, 04:13:00 INFO - 'sps_profile_interval': 0, 04:13:00 INFO - 'suite': 'dromaeojs', 04:13:00 INFO - 'system_bits': '32', 04:13:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:00 INFO - 'title': 'talos-linux64-ix-039', 04:13:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:00 INFO - 'use_talos_json': True, 04:13:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:00 INFO - 'work_dir': 'build'} 04:13:00 INFO - ##### 04:13:00 INFO - ##### Running clobber step. 04:13:00 INFO - ##### 04:13:00 INFO - Running pre-action listener: _resource_record_pre_action 04:13:00 INFO - Running main action method: clobber 04:13:00 INFO - rmtree: /builds/slave/test/build 04:13:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:01 INFO - Running post-action listener: _resource_record_post_action 04:13:01 INFO - ##### 04:13:01 INFO - ##### Finished clobber step (success) 04:13:01 INFO - ##### 04:13:01 INFO - ##### 04:13:01 INFO - ##### Running read-buildbot-config step. 04:13:01 INFO - ##### 04:13:01 INFO - Running pre-action listener: _resource_record_pre_action 04:13:01 INFO - Running main action method: read_buildbot_config 04:13:01 INFO - Using buildbot properties: 04:13:01 INFO - { 04:13:01 INFO - "project": "", 04:13:01 INFO - "product": "firefox", 04:13:01 INFO - "script_repo_revision": "production", 04:13:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:13:01 INFO - "repository": "", 04:13:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:13:01 INFO - "buildid": "20160524013022", 04:13:01 INFO - "pgo_build": "True", 04:13:01 INFO - "basedir": "/builds/slave/test", 04:13:01 INFO - "buildnumber": 1050, 04:13:01 INFO - "slavename": "talos-linux64-ix-039", 04:13:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:13:01 INFO - "platform": "ubuntu64_hw", 04:13:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:13:01 INFO - "branch": "mozilla-inbound", 04:13:01 INFO - "repo_path": "integration/mozilla-inbound", 04:13:01 INFO - "revision": "8e697c3542ffbe810d6ecc9912a510216471e99b", 04:13:01 INFO - "stage_platform": "linux64-pgo", 04:13:01 INFO - "builduid": "c72cd9a1f4bb47afa27f396b109fdae9", 04:13:01 INFO - "slavebuilddir": "test" 04:13:01 INFO - } 04:13:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:13:01 INFO - Running post-action listener: _resource_record_post_action 04:13:01 INFO - ##### 04:13:01 INFO - ##### Finished read-buildbot-config step (success) 04:13:01 INFO - ##### 04:13:01 INFO - ##### 04:13:01 INFO - ##### Running download-and-extract step. 04:13:01 INFO - ##### 04:13:01 INFO - Running pre-action listener: _resource_record_pre_action 04:13:01 INFO - Running main action method: download_and_extract 04:13:01 INFO - mkdir: /builds/slave/test/build/tests 04:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:01 INFO - https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:13:02 INFO - Downloaded 1361 bytes. 04:13:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:13:02 INFO - Using the following test package requirements: 04:13:02 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'jsshell-linux-x86_64.zip'], 04:13:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:02 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13: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')]} 04:13:02 INFO - https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:03 INFO - Downloaded 24417007 bytes. 04:13:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:04 INFO - Return code: 0 04:13:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:05 INFO - Downloaded 24417007 bytes. 04:13:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:07 INFO - Return code: 0 04:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:07 INFO - https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:08 INFO - Downloaded 10840359 bytes. 04:13:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:13:08 INFO - Return code: 0 04:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:08 INFO - https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:09 INFO - Downloaded 58618336 bytes. 04:13:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:13:09 INFO - mkdir: /builds/slave/test/properties 04:13:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:09 INFO - Contents: 04:13:09 INFO - build_url:https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:13:10 INFO - Running post-action listener: _resource_record_post_action 04:13:10 INFO - Running post-action listener: set_extra_try_arguments 04:13:10 INFO - ##### 04:13:10 INFO - ##### Finished download-and-extract step (success) 04:13:10 INFO - ##### 04:13:10 INFO - ##### 04:13:10 INFO - ##### Running populate-webroot step. 04:13:10 INFO - ##### 04:13:10 INFO - Running pre-action listener: _resource_record_pre_action 04:13:10 INFO - Running main action method: populate_webroot 04:13:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:10 INFO - '--tppagecycles', 04:13:10 INFO - '7'], 04:13:10 INFO - 'tests': ['tsvgm']}}, 04:13:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['damp', 'tps']}, 04:13:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'tests': ['damp', 'tps']}, 04:13:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['dromaeo_dom']}, 04:13:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['a11yr', 04:13:10 INFO - 'ts_paint', 04:13:10 INFO - 'tpaint', 04:13:10 INFO - 'sessionrestore', 04:13:10 INFO - 'sessionrestore_no_auto_restore', 04:13:10 INFO - 'tabpaint']}, 04:13:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['tsvgx', 04:13:10 INFO - 'tsvgr_opacity', 04:13:10 INFO - 'tart', 04:13:10 INFO - 'tscrollx', 04:13:10 INFO - 'cart']}, 04:13:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:10 INFO - 'tsvgr_opacity', 04:13:10 INFO - 'tart', 04:13:10 INFO - 'tscrollx', 04:13:10 INFO - 'cart']}, 04:13:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'talos_options': ['--disable-e10s'], 04:13:10 INFO - 'tests': ['tp5o']}, 04:13:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'tests': ['tp5o']}, 04:13:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'talos_options': ['--disable-e10s', 04:13:10 INFO - '--xperf_path', 04:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:10 INFO - 'tests': ['tp5n']}, 04:13:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:10 INFO - 'talos_options': ['--xperf_path', 04:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:10 INFO - 'tests': ['tp5n']}}, 04:13:10 INFO - 'talos.zip': {'path': '', 04:13:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:10 INFO - Running post-action listener: _resource_record_post_action 04:13:10 INFO - ##### 04:13:10 INFO - ##### Finished populate-webroot step (success) 04:13:10 INFO - ##### 04:13:10 INFO - ##### 04:13:10 INFO - ##### Running create-virtualenv step. 04:13:10 INFO - ##### 04:13:10 INFO - Running pre-action listener: _resource_record_pre_action 04:13:10 INFO - Running main action method: create_virtualenv 04:13:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:13:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:10 INFO - Using real prefix '/usr' 04:13:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:13 INFO - Installing pip.................done. 04:13:13 INFO - Return code: 0 04:13:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13: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', 'pip>=1.5'] in /builds/slave/test/build 04:13: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 pip>=1.5 04:13:13 INFO - Using env: {'DISPLAY': ':0', 04:13:13 INFO - 'HOME': '/home/cltbld', 04:13:13 INFO - 'LANG': 'en_US.UTF-8', 04:13:13 INFO - 'LANGUAGE': 'en_US:en', 04:13:13 INFO - 'LOGNAME': 'cltbld', 04:13:13 INFO - 'MAIL': '/var/mail/cltbld', 04:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:13 INFO - 'MOZ_NO_REMOTE': '1', 04:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:13 INFO - 'NO_EM_RESTART': '1', 04:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:13 INFO - 'PWD': '/builds/slave/test', 04:13:13 INFO - 'SHELL': '/bin/bash', 04:13:13 INFO - 'SHLVL': '1', 04:13:13 INFO - 'TERM': 'linux', 04:13:13 INFO - 'TMOUT': '86400', 04:13:13 INFO - 'USER': 'cltbld', 04:13:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:13 INFO - '_': '/tools/buildbot/bin/python'} 04:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:13:13 INFO - Cleaning up... 04:13:13 INFO - Return code: 0 04:13:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', '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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13: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 psutil>=3.1.1 04:13:13 INFO - Using env: {'DISPLAY': ':0', 04:13:13 INFO - 'HOME': '/home/cltbld', 04:13:13 INFO - 'LANG': 'en_US.UTF-8', 04:13:13 INFO - 'LANGUAGE': 'en_US:en', 04:13:13 INFO - 'LOGNAME': 'cltbld', 04:13:13 INFO - 'MAIL': '/var/mail/cltbld', 04:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:13 INFO - 'MOZ_NO_REMOTE': '1', 04:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:13 INFO - 'NO_EM_RESTART': '1', 04:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:13 INFO - 'PWD': '/builds/slave/test', 04:13:13 INFO - 'SHELL': '/bin/bash', 04:13:13 INFO - 'SHLVL': '1', 04:13:13 INFO - 'TERM': 'linux', 04:13:13 INFO - 'TMOUT': '86400', 04:13:13 INFO - 'USER': 'cltbld', 04:13:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:13 INFO - '_': '/tools/buildbot/bin/python'} 04:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:13 INFO - Downloading/unpacking psutil>=3.1.1 04:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:15 INFO - Installing collected packages: psutil 04:13:15 INFO - Running setup.py install for psutil 04:13:15 INFO - building 'psutil._psutil_linux' extension 04:13:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:13:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:15 INFO - building 'psutil._psutil_posix' extension 04:13:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:13:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:16 INFO - Successfully installed psutil 04:13:16 INFO - Cleaning up... 04:13:16 INFO - Return code: 0 04:13:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:16 INFO - Using env: {'DISPLAY': ':0', 04:13:16 INFO - 'HOME': '/home/cltbld', 04:13:16 INFO - 'LANG': 'en_US.UTF-8', 04:13:16 INFO - 'LANGUAGE': 'en_US:en', 04:13:16 INFO - 'LOGNAME': 'cltbld', 04:13:16 INFO - 'MAIL': '/var/mail/cltbld', 04:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:16 INFO - 'MOZ_NO_REMOTE': '1', 04:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:16 INFO - 'NO_EM_RESTART': '1', 04:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:16 INFO - 'PWD': '/builds/slave/test', 04:13:16 INFO - 'SHELL': '/bin/bash', 04:13:16 INFO - 'SHLVL': '1', 04:13:16 INFO - 'TERM': 'linux', 04:13:16 INFO - 'TMOUT': '86400', 04:13:16 INFO - 'USER': 'cltbld', 04:13:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:16 INFO - '_': '/tools/buildbot/bin/python'} 04:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:18 INFO - Installing collected packages: mozsystemmonitor 04:13:18 INFO - Running setup.py install for mozsystemmonitor 04:13:18 INFO - Successfully installed mozsystemmonitor 04:13:18 INFO - Cleaning up... 04:13:18 INFO - Return code: 0 04:13:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:18 INFO - Using env: {'DISPLAY': ':0', 04:13:18 INFO - 'HOME': '/home/cltbld', 04:13:18 INFO - 'LANG': 'en_US.UTF-8', 04:13:18 INFO - 'LANGUAGE': 'en_US:en', 04:13:18 INFO - 'LOGNAME': 'cltbld', 04:13:18 INFO - 'MAIL': '/var/mail/cltbld', 04:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:18 INFO - 'MOZ_NO_REMOTE': '1', 04:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:18 INFO - 'NO_EM_RESTART': '1', 04:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:18 INFO - 'PWD': '/builds/slave/test', 04:13:18 INFO - 'SHELL': '/bin/bash', 04:13:18 INFO - 'SHLVL': '1', 04:13:18 INFO - 'TERM': 'linux', 04:13:18 INFO - 'TMOUT': '86400', 04:13:18 INFO - 'USER': 'cltbld', 04:13:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:18 INFO - '_': '/tools/buildbot/bin/python'} 04:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:21 INFO - Downloading docopt-0.6.1.tar.gz 04:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:21 INFO - Running setup.py install for blobuploader 04:13:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:21 INFO - Running setup.py install for requests 04:13:21 INFO - Running setup.py install for docopt 04:13:21 INFO - Successfully installed blobuploader requests docopt 04:13:21 INFO - Cleaning up... 04:13:22 INFO - Return code: 0 04:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:22 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:22 INFO - Using env: {'DISPLAY': ':0', 04:13:22 INFO - 'HOME': '/home/cltbld', 04:13:22 INFO - 'LANG': 'en_US.UTF-8', 04:13:22 INFO - 'LANGUAGE': 'en_US:en', 04:13:22 INFO - 'LOGNAME': 'cltbld', 04:13:22 INFO - 'MAIL': '/var/mail/cltbld', 04:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:22 INFO - 'MOZ_NO_REMOTE': '1', 04:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:22 INFO - 'NO_EM_RESTART': '1', 04:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:22 INFO - 'PWD': '/builds/slave/test', 04:13:22 INFO - 'SHELL': '/bin/bash', 04:13:22 INFO - 'SHLVL': '1', 04:13:22 INFO - 'TERM': 'linux', 04:13:22 INFO - 'TMOUT': '86400', 04:13:22 INFO - 'USER': 'cltbld', 04:13:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:22 INFO - '_': '/tools/buildbot/bin/python'} 04:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:22 INFO - Running setup.py (path:/tmp/pip-b2cjch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:22 INFO - Running setup.py (path:/tmp/pip-uzRWZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:22 INFO - Running setup.py (path:/tmp/pip-You1md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:22 INFO - Running setup.py (path:/tmp/pip-WEiDEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:22 INFO - Running setup.py (path:/tmp/pip-zjdvRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:22 INFO - Running setup.py (path:/tmp/pip-tI67UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:22 INFO - Running setup.py (path:/tmp/pip-YOEwZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:22 INFO - Running setup.py (path:/tmp/pip-kaJXK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:22 INFO - Running setup.py (path:/tmp/pip-Ds0j5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:22 INFO - Running setup.py (path:/tmp/pip-t0vC91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:22 INFO - Running setup.py (path:/tmp/pip-0_hSzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:23 INFO - Running setup.py (path:/tmp/pip-8seZxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:23 INFO - Running setup.py (path:/tmp/pip-MGFy23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:23 INFO - Running setup.py (path:/tmp/pip-Poumur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:23 INFO - Running setup.py (path:/tmp/pip-3CzKNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:23 INFO - Running setup.py (path:/tmp/pip-XLHPFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:23 INFO - Running setup.py (path:/tmp/pip-LQ54Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:23 INFO - Running setup.py install for manifestparser 04:13:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:23 INFO - Running setup.py install for mozcrash 04:13:23 INFO - Running setup.py install for mozdebug 04:13:23 INFO - Running setup.py install for mozdevice 04:13:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:23 INFO - Running setup.py install for mozfile 04:13:23 INFO - Running setup.py install for mozhttpd 04:13:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozinfo 04:13:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozInstall 04:13:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozleak 04:13:24 INFO - Running setup.py install for mozlog 04:13:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for moznetwork 04:13:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozprocess 04:13:24 INFO - Running setup.py install for mozprofile 04:13:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozrunner 04:13:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:24 INFO - Running setup.py install for mozscreenshot 04:13:25 INFO - Running setup.py install for moztest 04:13:25 INFO - Running setup.py install for mozversion 04:13:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:25 INFO - Cleaning up... 04:13:25 INFO - Return code: 0 04:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:25 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:25 INFO - Using env: {'DISPLAY': ':0', 04:13:25 INFO - 'HOME': '/home/cltbld', 04:13:25 INFO - 'LANG': 'en_US.UTF-8', 04:13:25 INFO - 'LANGUAGE': 'en_US:en', 04:13:25 INFO - 'LOGNAME': 'cltbld', 04:13:25 INFO - 'MAIL': '/var/mail/cltbld', 04:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:25 INFO - 'MOZ_NO_REMOTE': '1', 04:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:25 INFO - 'NO_EM_RESTART': '1', 04:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:25 INFO - 'PWD': '/builds/slave/test', 04:13:25 INFO - 'SHELL': '/bin/bash', 04:13:25 INFO - 'SHLVL': '1', 04:13:25 INFO - 'TERM': 'linux', 04:13:25 INFO - 'TMOUT': '86400', 04:13:25 INFO - 'USER': 'cltbld', 04:13:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:25 INFO - '_': '/tools/buildbot/bin/python'} 04:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:25 INFO - Running setup.py (path:/tmp/pip-EnAOlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:25 INFO - Running setup.py (path:/tmp/pip-hygpLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:25 INFO - Running setup.py (path:/tmp/pip-vf_6aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:25 INFO - Running setup.py (path:/tmp/pip-Md0Qes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:25 INFO - Running setup.py (path:/tmp/pip-N1XOfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:25 INFO - Running setup.py (path:/tmp/pip-_eltGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:25 INFO - Running setup.py (path:/tmp/pip-stb2Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:25 INFO - Running setup.py (path:/tmp/pip-XQmpdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:26 INFO - Running setup.py (path:/tmp/pip-ptrRmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:26 INFO - Running setup.py (path:/tmp/pip-RlRNMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:26 INFO - Running setup.py (path:/tmp/pip-uNwuKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:26 INFO - Running setup.py (path:/tmp/pip-jGHg4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:26 INFO - Running setup.py (path:/tmp/pip-y7Kl42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:26 INFO - Running setup.py (path:/tmp/pip-_Il5F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:26 INFO - Running setup.py (path:/tmp/pip-PPgLpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:26 INFO - Running setup.py (path:/tmp/pip-TRLFXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:26 INFO - Running setup.py (path:/tmp/pip-LLUTc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:28 INFO - Downloading blessings-1.6.tar.gz 04:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:28 INFO - Installing collected packages: blessings 04:13:28 INFO - Running setup.py install for blessings 04:13:28 INFO - Successfully installed blessings 04:13:28 INFO - Cleaning up... 04:13:28 INFO - Return code: 0 04:13:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:29 INFO - Reading from file tmpfile_stdout 04:13:29 INFO - Current package versions: 04:13:29 INFO - argparse == 1.2.1 04:13:29 INFO - blessings == 1.6 04:13:29 INFO - blobuploader == 1.2.4 04:13:29 INFO - docopt == 0.6.1 04:13:29 INFO - manifestparser == 1.1 04:13:29 INFO - mozInstall == 1.12 04:13:29 INFO - mozcrash == 0.17 04:13:29 INFO - mozdebug == 0.1 04:13:29 INFO - mozdevice == 0.48 04:13:29 INFO - mozfile == 1.2 04:13:29 INFO - mozhttpd == 0.7 04:13:29 INFO - mozinfo == 0.9 04:13:29 INFO - mozleak == 0.1 04:13:29 INFO - mozlog == 3.2 04:13:29 INFO - moznetwork == 0.27 04:13:29 INFO - mozprocess == 0.22 04:13:29 INFO - mozprofile == 0.28 04:13:29 INFO - mozrunner == 6.11 04:13:29 INFO - mozscreenshot == 0.1 04:13:29 INFO - mozsystemmonitor == 0.3 04:13:29 INFO - moztest == 0.7 04:13:29 INFO - mozversion == 1.4 04:13:29 INFO - psutil == 3.1.1 04:13:29 INFO - requests == 1.2.3 04:13:29 INFO - wsgiref == 0.1.2 04:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:29 INFO - Using env: {'DISPLAY': ':0', 04:13:29 INFO - 'HOME': '/home/cltbld', 04:13:29 INFO - 'LANG': 'en_US.UTF-8', 04:13:29 INFO - 'LANGUAGE': 'en_US:en', 04:13:29 INFO - 'LOGNAME': 'cltbld', 04:13:29 INFO - 'MAIL': '/var/mail/cltbld', 04:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:29 INFO - 'MOZ_NO_REMOTE': '1', 04:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:29 INFO - 'NO_EM_RESTART': '1', 04:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:29 INFO - 'PWD': '/builds/slave/test', 04:13:29 INFO - 'SHELL': '/bin/bash', 04:13:29 INFO - 'SHLVL': '1', 04:13:29 INFO - 'TERM': 'linux', 04:13:29 INFO - 'TMOUT': '86400', 04:13:29 INFO - 'USER': 'cltbld', 04:13:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:29 INFO - '_': '/tools/buildbot/bin/python'} 04:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:29 INFO - Cleaning up... 04:13:29 INFO - Return code: 0 04:13:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:29 INFO - Using env: {'DISPLAY': ':0', 04:13:29 INFO - 'HOME': '/home/cltbld', 04:13:29 INFO - 'LANG': 'en_US.UTF-8', 04:13:29 INFO - 'LANGUAGE': 'en_US:en', 04:13:29 INFO - 'LOGNAME': 'cltbld', 04:13:29 INFO - 'MAIL': '/var/mail/cltbld', 04:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:29 INFO - 'MOZ_NO_REMOTE': '1', 04:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:29 INFO - 'NO_EM_RESTART': '1', 04:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:29 INFO - 'PWD': '/builds/slave/test', 04:13:29 INFO - 'SHELL': '/bin/bash', 04:13:29 INFO - 'SHLVL': '1', 04:13:29 INFO - 'TERM': 'linux', 04:13:29 INFO - 'TMOUT': '86400', 04:13:29 INFO - 'USER': 'cltbld', 04:13:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:29 INFO - '_': '/tools/buildbot/bin/python'} 04:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:29 INFO - Downloading/unpacking jsonschema 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:31 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:31 INFO - warning: no files found matching '*.txt' 04:13:31 INFO - no previously-included directories found matching 'build' 04:13:31 INFO - no previously-included directories found matching 'dist' 04:13:31 INFO - no previously-included directories found matching '.git*' 04:13:31 INFO - Installing collected packages: jsonschema, functools32 04:13:31 INFO - Running setup.py install for functools32 04:13:31 INFO - warning: no files found matching '*.txt' 04:13:31 INFO - no previously-included directories found matching 'build' 04:13:31 INFO - no previously-included directories found matching 'dist' 04:13:31 INFO - no previously-included directories found matching '.git*' 04:13:31 INFO - Successfully installed jsonschema functools32 04:13:31 INFO - Cleaning up... 04:13:31 INFO - Return code: 0 04:13:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 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 0x7f78aa175f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:13:31 INFO - Using env: {'DISPLAY': ':0', 04:13:31 INFO - 'HOME': '/home/cltbld', 04:13:31 INFO - 'LANG': 'en_US.UTF-8', 04:13:31 INFO - 'LANGUAGE': 'en_US:en', 04:13:31 INFO - 'LOGNAME': 'cltbld', 04:13:31 INFO - 'MAIL': '/var/mail/cltbld', 04:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:31 INFO - 'MOZ_NO_REMOTE': '1', 04:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:31 INFO - 'NO_EM_RESTART': '1', 04:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:31 INFO - 'PWD': '/builds/slave/test', 04:13:31 INFO - 'SHELL': '/bin/bash', 04:13:31 INFO - 'SHLVL': '1', 04:13:31 INFO - 'TERM': 'linux', 04:13:31 INFO - 'TMOUT': '86400', 04:13:31 INFO - 'USER': 'cltbld', 04:13:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:31 INFO - '_': '/tools/buildbot/bin/python'} 04:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:32 INFO - Downloading/unpacking flake8 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:34 INFO - no previously-included directories found matching 'docs/_build' 04:13:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:34 INFO - Running setup.py install for pep8 04:13:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:34 INFO - no previously-included directories found matching 'docs/_build' 04:13:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - Running post-action listener: _start_resource_monitoring 04:13:35 INFO - Starting resource monitoring. 04:13:35 INFO - ##### 04:13:35 INFO - ##### Finished create-virtualenv step (success) 04:13:35 INFO - ##### 04:13:35 INFO - ##### 04:13:35 INFO - ##### Running install step. 04:13:35 INFO - ##### 04:13:35 INFO - Running pre-action listener: _resource_record_pre_action 04:13:35 INFO - Running main action method: install 04:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:35 INFO - Reading from file tmpfile_stdout 04:13:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:35 INFO - Reading from file tmpfile_stdout 04:13:35 INFO - Output received: 04:13:35 INFO - Usage: mozinstall [options] installer 04:13:35 INFO - Options: 04:13:35 INFO - -h, --help show this help message and exit 04:13:35 INFO - -d DEST, --destination=DEST 04:13:35 INFO - Directory to install application into. [default: 04:13:35 INFO - "/builds/slave/test"] 04:13:35 INFO - --app=APP Application being installed. [default: firefox] 04:13:35 INFO - mkdir: /builds/slave/test/build/application 04:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:51 INFO - Reading from file tmpfile_stdout 04:13:51 INFO - Output received: 04:13:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:51 INFO - Running post-action listener: _resource_record_post_action 04:13:51 INFO - ##### 04:13:51 INFO - ##### Finished install step (success) 04:13:51 INFO - ##### 04:13:51 INFO - ##### 04:13:51 INFO - ##### Running run-tests step. 04:13:51 INFO - ##### 04:13:51 INFO - Running pre-action listener: _resource_record_pre_action 04:13:51 INFO - Running main action method: run_tests 04:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:51 INFO - Python 2.7.3 04:13:51 INFO - Return code: 0 04:13:51 INFO - grabbing minidump binary from tooltool 04:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:51 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 0x22819c0>, '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 0x22828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2282d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:52 INFO - Return code: 0 04:13:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:13:52 INFO - Return code: 0 04:13:52 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/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:13:52 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/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:13:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 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/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:13:53 INFO - mozversion application_buildid: 20160524013022 04:13:53 INFO - mozversion application_changeset: 8e697c3542ffbe810d6ecc9912a510216471e99b 04:13:53 INFO - mozversion application_display_name: Nightly 04:13:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:53 INFO - mozversion application_name: Firefox 04:13:53 INFO - mozversion application_remotingname: firefox 04:13:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:13:53 INFO - mozversion application_vendor: Mozilla 04:13:53 INFO - mozversion application_version: 49.0a1 04:13:53 INFO - mozversion platform_buildid: 20160524013022 04:13:53 INFO - mozversion platform_changeset: 8e697c3542ffbe810d6ecc9912a510216471e99b 04:13:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:13:53 INFO - mozversion platform_version: 49.0a1 04:13:53 INFO - using testdate: 1464088433 04:13:53 INFO - actual date: 1464088433 04:13:53 INFO - starting webserver on 'localhost:41281' 04:13:53 INFO - SUITE-START | Running 2 tests 04:13:53 INFO - TEST-START | dromaeo_css 04:13:53 INFO - operating with platform_type : linux_ 04:13:53 INFO - Initialising browser for dromaeo_css test... 04:13:53 INFO - TEST-INFO | started process 8243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHF4J9/profile http://localhost:41281/getInfo.html) 04:13:57 INFO - PROCESS | 8243 | __metrics Screen width/height:1600/1200 04:13:57 INFO - PROCESS | 8243 | colorDepth:24 04:13:57 INFO - PROCESS | 8243 | Browser inner width/height: 1024/697 04:13:57 INFO - PROCESS | 8243 | __metrics 04:13:58 ERROR - PROCESS | 8243 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:13:59 INFO - TEST-INFO | 8243: exit 0 04:13:59 INFO - Browser initialized. 04:13:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:59 INFO - TEST-INFO | started process 8323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHF4J9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:11 INFO - PROCESS | 8323 | RSS: Main: 153509888 04:14:11 INFO - PROCESS | 8323 | 04:15:02 INFO - PROCESS | 8323 | 1464088502221 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:17:10 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41281/tests/dromaeo/cssquery-ext.html) 04:17:11 INFO - PROCESS | 8323 | RSS: Main: 281993216 04:17:11 INFO - PROCESS | 8323 | 04:20:14 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-ext.html (next: http://localhost:41281/tests/dromaeo/cssquery-jquery.html) 04:20:14 INFO - PROCESS | 8323 | RSS: Main: 240996352 04:20:14 INFO - PROCESS | 8323 | 04:23:16 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41281/tests/dromaeo/cssquery-mootools.html) 04:23:17 INFO - PROCESS | 8323 | RSS: Main: 237330432 04:23:17 INFO - PROCESS | 8323 | 04:26:19 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41281/tests/dromaeo/cssquery-prototype.html) 04:26:19 INFO - PROCESS | 8323 | RSS: Main: 232132608 04:26:19 INFO - PROCESS | 8323 | 04:29:22 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41281/tests/dromaeo/cssquery-yui.html) 04:29:23 INFO - PROCESS | 8323 | RSS: Main: 217370624 04:29:23 INFO - PROCESS | 8323 | 04:32:25 INFO - PROCESS | 8323 | Cycle 1(1): loaded http://localhost:41281/tests/dromaeo/cssquery-yui.html (next: http://localhost:41281/tests/dromaeo/cssquery-dojo.html) 04:32:26 INFO - PROCESS | 8323 | RSS: Main: 268730368 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | __start_tp_report 04:32:26 INFO - PROCESS | 8323 | _x_x_mozilla_page_load 04:32:26 INFO - PROCESS | 8323 | _x_x_mozilla_page_load_details 04:32:26 INFO - PROCESS | 8323 | |i|pagename|runs| 04:32:26 INFO - PROCESS | 8323 | |0;dojo.html;3118.2516196112933;3127.0306205076413;3136.6392864820546;3160.7313378362837;3184.5382419549164;5335.173048177529;5358.785648574058;5397.649152805065;5472.534834539064;5495.917561236584;5291.576673866091;5363.088274993251;5370.3287089113865;5435.211894275328;5479.04116779564;4826.1554228010045;4851.054044461332;5043.42000669924;5112.437631860493;5115.104856650071;5024.949750502503;5069.569086627641;5084.4661310562415;5099.107656160176;5100.209467532539;4839.588634966014;4949.950500495003;4975.800967961277;4998.425181104147;5013.248012798073;5027.748612569357;5028.220625803006;5041.445441001487;5043.67216130954;5097.286379906816;4971.229459433794;4997.350344455234;5007.399112106534;5019.824306149268;5031.440288306201;5204.037253108149;5265.762545801734;5311.654742441768;5397.811076612339;5411.621186516906;5841.970790146022;5876.177335173079;5876.324222714357;5877.823665290048;5878.588498805086;5636.323641163046;5867.794627188028;5888.087346461305;5910.1430292607765;5921.763129474816;5304.257403963448;5381.2197231401615;5385.461453854622;5388.218708287276;5389.622726409153;5895.882082358329;5917.970410147922;5941.643501389931;6017.909731354033;6029.095635654599;5747.971260143756;5761.596688231783;5803.912941305884;5824.271966004249;5836.533077353802;5625.324961004624;5872.677002764804;5892.351841297454;5902.05567109269;5928.555358348055;5810.070388737781;5838.2702162229725;5841.824745257649;5849.064149736022;5856.326522449973;5843.649381037067;5870.589058765845;5871.55963302754;5872.853178670482;5881.5000724938;4259.297215959332;4383.276759334738;4449.532799056117;4462.776861156929;4493;3927.66614837742;3949.348357520977;3950.743201691881;3969.126792105732;4000.2799496090984;5553.444655534414;5565.332160140728;5567.610267281251;5570.860728481739;5571.052921003439;5709.229254050733;5830.737616807169;5887.264091988502;5901.616394934315;5960.165576819249;5574.052411090124;5576.888462230814;5590.468905453975;5593.524550413179;5614.129809879475;5057.039162559102;5060.7722652480725;5065.468125846806;5072.467390923974;5114.002769459994;5805.303363596396;6062.2725272966645;6108.053251745987;6122.418370254908;6123.755049797958;5921.792737254175;5929.0513517836935;5952.613080149949;5960.791372301948;5963.880722385615;6097.75608975636;6141.109539116714;6146.723397447215;6147.600405973598;6148.047052706837;5532.197831314517;5732.369439361751;5753.568482363756;5775.422457754191;5803.129530570448;5815.360310365941;5857.384974577608;5859.765609375748;5861.443162899518;5868.413158684098;5484.012877682056;5625.578081643975;5691.573132015033;5695.259616249861;5695.544356451557;5665;5715.599908006566;5727.828165155052;5765.394633563583;5774.0761478163295;5681.460261275172;5682.715864206856;5686.8578285541535;5690.402507736628;5691;5490.835274941758;5723.284589426322;5783.161441590862;5792.9710351447975;5827.446392592697;5352.785888564414;5385;5572.442755724395;5577.721113944368;5611.242482264842 04:32:26 INFO - PROCESS | 8323 | |1;ext.html;604.4952464691982;647.7085311609774;650.2229835346759;657.4247533408268;662.2218892800959;30304.54543181851;30668.386632267368;32615.67384326156;42127.36808947868;43069.13861722764;44474.33288500675;44983.77508112455;44990.55009449904;45044.774776126076;45054.324185137164;8590.44162129461;8770.56147192641;8780.604872780708;8785.472871627722;8787.297016238717;8586.441881277697;8761.649534018663;8774;8774.868376974351;8778;8760.386772925898;8798.6920457784;8812.339074569432;8820.735377938672;8828.73513794584;8752.343574231927;8763.079876612928;8795.164459376349;8807.735767926972;8817.29461643067;8583.828323433496;8655;8698.869516957251;8760.342974276955;8763.605637746254;40121;40403.797981010204;40478.392824107665;40488;40566.59433405658;3604.9279014419567;3614.9096272593133;3682.963170368289;3700.907477313062;3781.357169281229;30973.690263097305;33413;33766.49350259748;34917;34948.301033979435;4276.593723596254;4362.323839804835;4397.2304846651705;4407.60331570157;4444;348312;349563;352188;354581;355525;54530;64452.35547644558;65530;65586;65602.7198640066;64351.67824160849;66699.66650166718;66800.66599667068;73534.63232683802;73785.63107184538;15237.161956092521;15392.230388480531;15451.150186739613;15459.845401546065;15484.458043968407;10310.896891031143;11026.889731102587;11540.769184616262;11646.126540509496;11663.650090497298;19582.38375114945;20197;20367.59264814725;20465.795342046687;20483.180672773222;7577.280158384945;7606.467547271748;7709.229077092358;7770.45606807518;7823.447452229277;1039.2205845615788;1108.534415545473;1144.1933436926947;1178.8270670682555;1207.4626791077885;32667.67332326694;33234.33531329408;33301.83349083239;33399.165020874185;34005.82997084999;1107.496089279392;1141.4292853573213;1145.3471521232984;1190.7916114679897;1228.655976326612;17306.740398894028;17421.303147874198;17465.38871139504;17467.301307947793;17684.64630707379;539247;542873;544531;545002;546284;56519.15221271684;57035.71482142646;57091.71454142703;57115;57225.85257810777;1143.54258296682;1351.8175046368615;1385.2727318158047;1386;1386.6949271160329;33368;34358;34596.30807383889;34602;34638.30723385468;47913.56259312226;48486.75756621194;48560.271595925384;48593.5140648589;48618.5138148614;389612;394337;396809;398143;399049;25949.740502594734;37496;42288.577114228465;43238;44164.77917610391;42273;44358.778206108764;45073.0985380284;45290.547094528636;45603.315950261436;38617.42073868838;39541.60458395494;40276.597234027286;43986;44455.555444446436;41330;42254;42480;42635.786821065696;43273.78363108164;41411.7929410351;41750.16499670051;41986;42635.78682106694;42800;36227.63772362243;37316.25367492689;37460;37597.33367720416;38328.80835595804;28755;28929.56605650959;29033;29118.56322155127;29279.707202927697 04:32:26 INFO - PROCESS | 8323 | |2;jquery.html;384.2641341830395;385.5219527785547;385.81434729064017;398.11220977220796;408.93457046872487;14395.928020359883;16720.58198545037;18058.90970545147;19493.99999999998;19496.512587185327;13524;15904.681906361895;16031.919840400782;16784.916075419605;17070.573235669115;5459.071957767169;5573.23651142288;5638.661680299195;5667.263255776764;5680.9715951420185;3961.683065354779;5478.849441617265;5536.640118392312;5603.831885043455;5973.1040343948325;6201.286852012031;6252.187215661957;6253.7185826637915;6292.276388215368;6317.147185129995;6191.226096737908;6244.344343843876;6264.21697287839;6267.435930766253;6277.403646653561;5347.197920311945;5469.644473109275;5472.480114389126;5480.972595136999;5489.149181876815;20953;21470.248541301135;21943.780562194494;22185.11259549616;22283.44291392712;2320.083566991029;2355.9764402355927;2365.455945132629;2597.6882774067235;2871.913842584726;13237.470501180038;13437.126586771927;13550;13864.4454221831;14362.066465679802;1927.884326940388;1940.3596813051659;1947.1237942925598;1968.6062787442568;2034.5930813837292;74980;77386.22613773902;77704.11723656619;78323.21676783274;99038.50480747622;16540.676745860303;16821.663566728595;17380.47858564245;17801.46595602134;17856.46430607084;31264.843675781474;31499.212519687193;31562.842185789385;31921.840390797897;32071.51892721611;8066.7579972600915;8367.163283671583;8778.648854045767;8804.559772011375;9079.54602269897;7332.376747976375;7536.284053014955;7564.243575642502;7793.883091753628;7804.765857024298;8592.613332400057;8730.86903696445;8770.649174032967;8893;8906.376553641183;3271.6074071111143;3320.8505617246797;3389.8135602542097;3451.8964431067106;3517.2262102337445;911.6490151291667;945.550863339908;956.0200794186015;1023.9385636861812;1066.258950029722;18154.63690726178;18287.634247315244;18458;18515.907420462812;18720.53198670017;979.9804003919882;1000.2797985450464;1008.4655132779639;1026.0560284538242;1027.5838285494237;9781.853272200922;10334.483275836328;10356.948215259026;10453;10541.57833686644;474047.4528614811;475166;475284;479055;483062;87037;90497;91770.19953303911;92107.53946230226;92112.53943730373;998.3959704378891;1018.0888105145852;1019.7858449725641;1041.692700653294;1044.378594736146;16524;16597.668046639243;16729.247183876512;16769.32922683079;17000.149992500574;30517;37569.81215093907;38438.693678379386;40359.79820100881;40721.79639101786;51741.48258517367;52386.47613523816;54381.45618543764;54819.725901370235;55032.17451738147;8344.707935222237;8374.83250335002;8388.748337549883;8422.83154336922;8448.155184481502;12363.258204507398;12740.235585864877;12856.228626282453;12894.548690795777;12927.418266177856;11176.888231117584;11287.943560282147;11306.038986685895;11421.885781142082;11473.598424055119;11111.222214444912;11312.773744525228;11373.14701397415;11455.713607159887;11667.416629168338;11503.654890353302;11618.186726929034;11731.41342932833;11743.17797754149;11785.882141178821;7214.567125972459;7247.202807691045;7361.1166660001145;8413.284870785807;8499.617517211616;8905.73282801517;11455.198136130392;11554.133439991867;11615.883841161818;11619.941900290445 04:32:26 INFO - PROCESS | 8323 | |3;mootools.html;1339.4909934224993;1486.5466032859977;1526.503886236973;1688.36686242659;1839.3562253211378;8527.573621318932;8881.866771998417;8890.466572005676;9167.854018247719;9178.816423671538;8824.735257942257;9026.368154229207;9030.954845225764;9031.322650801183;9034.232090272319;2068.7207227024387;2289.9656505152434;2351.423901144222;2382.7736365045334;2416.709994800626;2376.4177776444794;2384.1655420602824;2387.331547166796;2387.7612238776155;2388.0925248405583;2342.3207269891795;2348.2602980061224;2374.097842819726;2378.52429514097;2381.4879800842814;1983.623111608797;2259.186692790594;2284.303287497313;2333.230034088747;2342.4378149244058;2296.5062511559927;2304.5275718477674;2317.6523521471745;2318.976810231893;2324.7675232476786;9050.77373065672;9094.63621455141;9108.81782364349;9109.772255693595;9159.542022898895;5148.897022059537;5273.393559740641;5279.498447647506;5280.049591073605;5283.101872681654;3360.949585756191;3472.791632502033;3488.9127771805656;3523.189666376722;3531.311394278117;984.3700031979539;1058.6188971970084;1074.2426589254558;1096.8793432722393;1104.320842681753;12083.27500349973;12095.758084838342;12161;12191.878081219164;12200.877991220063;4274;4344.1311737652595;4444.755538445416;4447;4450;9492.477913714813;9580.329376943548;9593.376430531993;9605;9609.615615375447;5008.173651347487;5058.873528161826;5061.266116413173;5071.492850714899;5077.111505486525;4376.081022985145;4674.0651869625535;4789.616830653539;4795.808167673254;4854.660173787801;3854.3062248795486;3876.341022026262;3944.9211015779524;3985.442038114666;4004.7196696231567;1146.7075895646556;1148.9885101148882;1154.705550084723;1160.3386069940223;1165.114512970132;976;979.2313034268066;985.4087547471603;998.0618218874235;1011.2466212671607;5805.709714514257;5991.64050156992;6168.414000669929;6193.597416167935;6322.209723784527;912.9908700913039;942.9151376376159;970.4129001953858;981.749653838281;1007.677543186188;4222.218889505451;4313.158934007838;4436.889077773081;4501.077279157765;4523.592876641118;11385.08919286455;11442.713932151762;11567.76864462706;11569.537218511334;11587.130965177645;11321;11424.714382140346;11428.485718142703;11438.828417573743;11443;8077.474964127313;8397;8406.327493800482;8423.873641895376;8563.657453701782;6022.277326720821;6217.409346112112;6266.154069200599;6270.498360131087;6419.35806419373;10403.94798026005;10454.11140053104;10483.318584291997;10643.467826608483;10672.786544268916;10739.624113156002;10792.352458852494;10815.080718138732;10847.78304433891;10938.398388088413;7918.841623167389;8034.357251419756;8091.109977902308;8143.75568732939;8149.755507334789;8686;8727.08365621626;8747.125287471203;8767.254783343487;8836.337274704294;7887.881681774663;7963.203679631991;7993.040835099593;8039.397045221514;8082.070561885458;7661.885071723817;7679.232076792499;7708.267714567107;7717.961410192913;7874.05511338643;7119.252478489684;7222.819429514304;7223.205447400676;7242.710291588488;7257.383122434441;5273.419923808301;5348.5186333230195;5360.731963401737;5415.783368665367;5561.63849349791;5362.356517217959;5516.834494965157;5538.47384498472;5556.527695145796;5611.943880561143 04:32:26 INFO - PROCESS | 8323 | |4;prototype.html;308.2924687841404;322.09330733983836;323.24683487474186;323.6795572383341;327.973762099032;5326.2543243945875;5377.327834020747;5391.304347826087;5411.404745477999;5423;5275.261463395128;5278.736063196844;5283.867903302419;5289.603279754024;5341.1988201769755;3944.684425245973;3976.886471787904;4092.1406504634065;4110.157417729359;4114.938275925849;4065.6340929316357;4099.938500922489;4111.301078816608;4111.635809409587;4112.527059388179;3942;4075.9796201018953;4092.3043082676018;4102.692298077641;4120.814563344642;3954;4103.589641035887;4124.288420305569;4149.2531344358;4154.5222299435345;3610.9277814443826;3632.745707800455;3637.3089113068695;3646.726495512847;3661.6634928251265;5048.1670524363435;5074.441811400779;5108.897822043576;5150.072986862363;5170.663906846043;4487.640988720895;4709.764511774398;4714.905701885943;4737.786799594027;4757.452892917324;5497.615166938316;5525.336959564878;5531.668099914018;5537.031019571559;5542.362628297717;3959.5050618672667;3969.1069509360163;3972.7616343019513;3982.143839074613;3995.5005624296964;5621.522170615503;5687.459691329358;5751.245870009645;5755.251817263729;5795.826125216292;4046.9392959105635;4072.816723247461;4076.449679293317;4084.346504559256;4091.013560101143;4104.445899803488;4106.178764247163;4122.711410201317;4155.10665206982;4159.500859896832;4383.715058521186;4622.14490319292;4650.6046986005895;4691.7948564174785;4756.881077973078;5512.448755124456;5564.582656300794;5578.043636872464;5624.85937851557;5635.802037205493;1384.55002124308;1401.9439222431192;1405.9086159399606;1410.5133728863525;1413.6536548545673;881.5944665453964;882.1839798186652;902.5261737587688;913.2420091324185;926.9016215784317;5329.440408757102;5330.866728331823;5341.4894999350245;5381.811636592779;5385.353757549119;5597.524210442077;5602.159676048625;5613.887722245614;5629.268195134607;5665.49010589049;5199.350081239845;5228.084604598885;5298.841034768963;5305.54097623149;5366.490183432567;2980.6423229212633;2981.344104297051;2993.4911065118545;3001.834899080528;3014.754008263814;5679.716014199274;5688.175214593861;5696.914546281726;5708.343540492813;5725.312962444534;5519.972400137974;5681.744321505542;5709.716912775171;5734.397888221677;5735.139729040678;5760.740766665426;5800.8259752207505;5819.505342045889;5820.330661973927;5862.530997520188;5395.487428694268;5596.300462442195;5640.717964101696;5652.745626446737;5660.462256085665;5566.526845218202;5570.994442000958;5593.161025845993;5594.300712410949;5596.440355964533;5780.075187969905;5783;5809.680467574324;5814.680192589279;5815.5929084963645;3811.2187001665147;3970.543387510473;3981.800909954549;3994.201159768;4011.217812526646;5646.576506761927;5651.8304450866535;5691.686957217393;5696.971515142398;5697.287839020122;5378.300820893259;5387.75755091014;5499.230107784833;5574.414686457863;5620.634658747168;5479;5486.0923710433535;5500.752466138953;5572.86067848307;5579.9163012555655;5267.9736601316745;5426.918596221139;5427.891442171213;5433.886053358973;5448.983875965918;5603;5605.411431799603;5655.915161272666;5675;5676.091825308096;5442.891142177055;5516.434857791146;5547.528460080938;5551.306086739158;5551.306086739158 04:32:26 INFO - PROCESS | 8323 | |5;yui.html;764.2319468933721;767.0335377424443;805.6012273924406;826.6569373709909;889.0798024045107;14586.854131458682;15182.62043448913;15258.771118433233;15307.158106304149;15352.46266380677;11873;13515.729685406286;13552.525661601845;13562.525311614096;13565.52520661777;774.6823802241069;816.6202715737181;817.448222449847;818.7502811642447;819.8032472206687;807.475141158246;809.3080416244114;811.8498077855586;815.9918400816005;816.049302562514;700.1353328639127;857.2327766648876;859.4070091636781;859.9011113721908;860.096898256831;806.5281810141074;840.7099550655014;841.5581819544788;841.6212704283097;843.6288033265374;618.7494064903722;619.5198720991223;619.9070139479114;620.2216218645616;620.5376994139395;14475;14604.269786510738;14627.63430914225;14633.926830365886;14645.707085858223;13406.39671214788;13644.454221831114;13770;13820.723585528334;14005.649858753512;12707.682307942283;12834.614961551168;13056.934715326457;13058.869411305861;13070.085094043421;4456.22016147173;4497.370368148462;4538.954610453886;4559.70361926477;4636.443626764776;53452.46547534514;53522.73238633821;54332.72833635846;59358.70320648369;59699.104513432336;10757.515911783832;10787.137029037658;10914.890851091388;10948.945255273673;11141;20195.596088078157;20401.081951312226;20436.0803763831;20477;20491;8353.749387518385;8355.582220888931;8373.581320933929;8443;8449.704260350858;4466.419365482531;4552.416948478178;4561.429821272341;4583.179730389478;4634.142683603544;3326.800391976489;3426.862925482953;3428.674275943831;3438;3440.7935523868646;606.5329696133953;651.3811878715239;674.7166190200128;689.4449967775988;719.9856002879914;681.8295426143465;701.4949236549676;763.4884627299723;764.8929149919015;801.2388231180402;9614.9038509614;9976.501174941224;10335.741606459898;10336.638217662496;10352.741181470523;663.4857985061616;725.7242247945852;750.1635676220974;792.359815182578;795;4724.966143551318;4838.782254798542;4886.0225280113955;4901.607871370282;4940.219278662542;71335.28664713391;72744.63627681934;73570.26429735633;73757;74096.25903740893;52677.20984185164;54101;54130.729346353015;58804;64488.67755661192;57293;57371;57429.71285143548;57519.712401437726;58773.41226587765;9727.221822254343;9839.458829764431;9978.550965206729;10214.131798796889;10302.433366164933;36625.63374366222;37088.6291137096;37546.624533754315;37902.43146352862;38042.429363559015;49669.25496117633;49903.25145122754;49945.25082123699;49990;50223.24665129953;11847.170698051053;11880.643580692593;11917.404129793302;12798.936005320285;12942.223466592035;13184.73630527365;13980.231087290296;14515.92742036283;14533.563993080224;14583.270836457923;7727.729529466442;12411.937940310241;13477.797833032708;13578.45686172542;13904.791428128789;12637.494500219887;12806.67983300425;12863.807042894552;13170.07809453329;13587.184768913898;13239;13914.652133696738;13985.160890346611;14115.788263175855;14124.929375353058;11005.61480348184;11341.667998082734;11524.711882203012;11566.248193867372;11645.215305025731;10936.289141205796;11405.315681059163;11564.13269004845;11618.360990145624;11658.12564057716 04:32:26 INFO - PROCESS | 8323 | __end_tp_report 04:32:26 INFO - PROCESS | 8323 | __start_cc_report 04:32:26 INFO - PROCESS | 8323 | _x_x_mozilla_cycle_collect,1038 04:32:26 INFO - PROCESS | 8323 | __end_cc_report 04:32:26 INFO - PROCESS | 8323 | __startTimestamp1464089546081__endTimestamp 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | ------- Summary: start ------- 04:32:26 INFO - PROCESS | 8323 | Number of tests: 6 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#0] dojo.html Cycles:165 Average:5429.12 Median:5614.13 stddev:625.00 (11.1%) stddev-sans-first:600.05 04:32:26 INFO - PROCESS | 8323 | Values: 3118.3 3127.0 3136.6 3160.7 3184.5 5335.2 5358.8 5397.6 5472.5 5495.9 5291.6 5363.1 5370.3 5435.2 5479.0 4826.2 4851.1 5043.4 5112.4 5115.1 5024.9 5069.6 5084.5 5099.1 5100.2 4839.6 4950.0 4975.8 4998.4 5013.2 5027.7 5028.2 5041.4 5043.7 5097.3 4971.2 4997.4 5007.4 5019.8 5031.4 5204.0 5265.8 5311.7 5397.8 5411.6 5842.0 5876.2 5876.3 5877.8 5878.6 5636.3 5867.8 5888.1 5910.1 5921.8 5304.3 5381.2 5385.5 5388.2 5389.6 5895.9 5918.0 5941.6 6017.9 6029.1 5748.0 5761.6 5803.9 5824.3 5836.5 5625.3 5872.7 5892.4 5902.1 5928.6 5810.1 5838.3 5841.8 5849.1 5856.3 5843.6 5870.6 5871.6 5872.9 5881.5 4259.3 4383.3 4449.5 4462.8 4493.0 3927.7 3949.3 3950.7 3969.1 4000.3 5553.4 5565.3 5567.6 5570.9 5571.1 5709.2 5830.7 5887.3 5901.6 5960.2 5574.1 5576.9 5590.5 5593.5 5614.1 5057.0 5060.8 5065.5 5072.5 5114.0 5805.3 6062.3 6108.1 6122.4 6123.8 5921.8 5929.1 5952.6 5960.8 5963.9 6097.8 6141.1 6146.7 6147.6 6148.0 5532.2 5732.4 5753.6 5775.4 5803.1 5815.4 5857.4 5859.8 5861.4 5868.4 5484.0 5625.6 5691.6 5695.3 5695.5 5665.0 5715.6 5727.8 5765.4 5774.1 5681.5 5682.7 5686.9 5690.4 5691.0 5490.8 5723.3 5783.2 5793.0 5827.4 5352.8 5385.0 5572.4 5577.7 5611.2 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#1] ext.html Cycles:180 Average:59852.64 Median:41868.08 stddev:116073.69 (277.2%) stddev-sans-first:116314.07 04:32:26 INFO - PROCESS | 8323 | Values: 604.5 647.7 650.2 657.4 662.2 30304.5 30668.4 32615.7 42127.4 43069.1 44474.3 44983.8 44990.6 45044.8 45054.3 8590.4 8770.6 8780.6 8785.5 8787.3 8586.4 8761.6 8774.0 8774.9 8778.0 8760.4 8798.7 8812.3 8820.7 8828.7 8752.3 8763.1 8795.2 8807.7 8817.3 8583.8 8655.0 8698.9 8760.3 8763.6 40121.0 40403.8 40478.4 40488.0 40566.6 3604.9 3614.9 3683.0 3700.9 3781.4 30973.7 33413.0 33766.5 34917.0 34948.3 4276.6 4362.3 4397.2 4407.6 4444.0 348312.0 349563.0 352188.0 354581.0 355525.0 54530.0 64452.4 65530.0 65586.0 65602.7 64351.7 66699.7 66800.7 73534.6 73785.6 15237.2 15392.2 15451.2 15459.8 15484.5 10310.9 11026.9 11540.8 11646.1 11663.7 19582.4 20197.0 20367.6 20465.8 20483.2 7577.3 7606.5 7709.2 7770.5 7823.4 1039.2 1108.5 1144.2 1178.8 1207.5 32667.7 33234.3 33301.8 33399.2 34005.8 1107.5 1141.4 1145.3 1190.8 1228.7 17306.7 17421.3 17465.4 17467.3 17684.6 539247.0 542873.0 544531.0 545002.0 546284.0 56519.2 57035.7 57091.7 57115.0 57225.9 1143.5 1351.8 1385.3 1386.0 1386.7 33368.0 34358.0 34596.3 34602.0 34638.3 47913.6 48486.8 48560.3 48593.5 48618.5 389612.0 394337.0 396809.0 398143.0 399049.0 25949.7 37496.0 42288.6 43238.0 44164.8 42273.0 44358.8 45073.1 45290.5 45603.3 38617.4 39541.6 40276.6 43986.0 44455.6 41330.0 42254.0 42480.0 42635.8 43273.8 41411.8 41750.2 41986.0 42635.8 42800.0 36227.6 37316.3 37460.0 37597.3 38328.8 28755.0 28929.6 29033.0 29118.6 29279.7 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#2] jquery.html Cycles:180 Average:28986.66 Median:3355.33 stddev:78627.03 (2343.3%) stddev-sans-first:78818.27 04:32:26 INFO - PROCESS | 8323 | Values: 384.3 385.5 385.8 398.1 408.9 14395.9 16720.6 18058.9 19494.0 19496.5 13524.0 15904.7 16031.9 16784.9 17070.6 5459.1 5573.2 5638.7 5667.3 5681.0 3961.7 5478.8 5536.6 5603.8 5973.1 6201.3 6252.2 6253.7 6292.3 6317.1 6191.2 6244.3 6264.2 6267.4 6277.4 5347.2 5469.6 5472.5 5481.0 5489.1 20953.0 21470.2 21943.8 22185.1 22283.4 2320.1 2356.0 2365.5 2597.7 2871.9 13237.5 13437.1 13550.0 13864.4 14362.1 1927.9 1940.4 1947.1 1968.6 2034.6 74980.0 77386.2 77704.1 78323.2 99038.5 16540.7 16821.7 17380.5 17801.5 17856.5 31264.8 31499.2 31562.8 31921.8 32071.5 8066.8 8367.2 8778.6 8804.6 9079.5 7332.4 7536.3 7564.2 7793.9 7804.8 8592.6 8730.9 8770.6 8893.0 8906.4 3271.6 3320.9 3389.8 3451.9 3517.2 911.6 945.6 956.0 1023.9 1066.3 18154.6 18287.6 18458.0 18515.9 18720.5 980.0 1000.3 1008.5 1026.1 1027.6 9781.9 10334.5 10356.9 10453.0 10541.6 474047.5 475166.0 475284.0 479055.0 483062.0 87037.0 90497.0 91770.2 92107.5 92112.5 998.4 1018.1 1019.8 1041.7 1044.4 16524.0 16597.7 16729.2 16769.3 17000.1 30517.0 37569.8 38438.7 40359.8 40721.8 51741.5 52386.5 54381.5 54819.7 55032.2 8344.7 8374.8 8388.7 8422.8 8448.2 12363.3 12740.2 12856.2 12894.5 12927.4 11176.9 11287.9 11306.0 11421.9 11473.6 11111.2 11312.8 11373.1 11455.7 11667.4 11503.7 11618.2 11731.4 11743.2 11785.9 7214.6 7247.2 7361.1 8413.3 8499.6 8905.7 11455.2 11554.1 11615.9 11619.9 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#3] mootools.html Cycles:180 Average:5915.51 Median:4931.42 stddev:3393.94 (68.8%) stddev-sans-first:3386.04 04:32:26 INFO - PROCESS | 8323 | Values: 1339.5 1486.5 1526.5 1688.4 1839.4 8527.6 8881.9 8890.5 9167.9 9178.8 8824.7 9026.4 9031.0 9031.3 9034.2 2068.7 2290.0 2351.4 2382.8 2416.7 2376.4 2384.2 2387.3 2387.8 2388.1 2342.3 2348.3 2374.1 2378.5 2381.5 1983.6 2259.2 2284.3 2333.2 2342.4 2296.5 2304.5 2317.7 2319.0 2324.8 9050.8 9094.6 9108.8 9109.8 9159.5 5148.9 5273.4 5279.5 5280.0 5283.1 3360.9 3472.8 3488.9 3523.2 3531.3 984.4 1058.6 1074.2 1096.9 1104.3 12083.3 12095.8 12161.0 12191.9 12200.9 4274.0 4344.1 4444.8 4447.0 4450.0 9492.5 9580.3 9593.4 9605.0 9609.6 5008.2 5058.9 5061.3 5071.5 5077.1 4376.1 4674.1 4789.6 4795.8 4854.7 3854.3 3876.3 3944.9 3985.4 4004.7 1146.7 1149.0 1154.7 1160.3 1165.1 976.0 979.2 985.4 998.1 1011.2 5805.7 5991.6 6168.4 6193.6 6322.2 913.0 942.9 970.4 981.7 1007.7 4222.2 4313.2 4436.9 4501.1 4523.6 11385.1 11442.7 11567.8 11569.5 11587.1 11321.0 11424.7 11428.5 11438.8 11443.0 8077.5 8397.0 8406.3 8423.9 8563.7 6022.3 6217.4 6266.2 6270.5 6419.4 10403.9 10454.1 10483.3 10643.5 10672.8 10739.6 10792.4 10815.1 10847.8 10938.4 7918.8 8034.4 8091.1 8143.8 8149.8 8686.0 8727.1 8747.1 8767.3 8836.3 7887.9 7963.2 7993.0 8039.4 8082.1 7661.9 7679.2 7708.3 7718.0 7874.1 7119.3 7222.8 7223.2 7242.7 7257.4 5273.4 5348.5 5360.7 5415.8 5561.6 5362.4 5516.8 5538.5 5556.5 5611.9 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#4] prototype.html Cycles:180 Average:4647.35 Median:5377.81 stddev:1370.77 (25.5%) stddev-sans-first:1335.37 04:32:26 INFO - PROCESS | 8323 | Values: 308.3 322.1 323.2 323.7 328.0 5326.3 5377.3 5391.3 5411.4 5423.0 5275.3 5278.7 5283.9 5289.6 5341.2 3944.7 3976.9 4092.1 4110.2 4114.9 4065.6 4099.9 4111.3 4111.6 4112.5 3942.0 4076.0 4092.3 4102.7 4120.8 3954.0 4103.6 4124.3 4149.3 4154.5 3610.9 3632.7 3637.3 3646.7 3661.7 5048.2 5074.4 5108.9 5150.1 5170.7 4487.6 4709.8 4714.9 4737.8 4757.5 5497.6 5525.3 5531.7 5537.0 5542.4 3959.5 3969.1 3972.8 3982.1 3995.5 5621.5 5687.5 5751.2 5755.3 5795.8 4046.9 4072.8 4076.4 4084.3 4091.0 4104.4 4106.2 4122.7 4155.1 4159.5 4383.7 4622.1 4650.6 4691.8 4756.9 5512.4 5564.6 5578.0 5624.9 5635.8 1384.6 1401.9 1405.9 1410.5 1413.7 881.6 882.2 902.5 913.2 926.9 5329.4 5330.9 5341.5 5381.8 5385.4 5597.5 5602.2 5613.9 5629.3 5665.5 5199.4 5228.1 5298.8 5305.5 5366.5 2980.6 2981.3 2993.5 3001.8 3014.8 5679.7 5688.2 5696.9 5708.3 5725.3 5520.0 5681.7 5709.7 5734.4 5735.1 5760.7 5800.8 5819.5 5820.3 5862.5 5395.5 5596.3 5640.7 5652.7 5660.5 5566.5 5571.0 5593.2 5594.3 5596.4 5780.1 5783.0 5809.7 5814.7 5815.6 3811.2 3970.5 3981.8 3994.2 4011.2 5646.6 5651.8 5691.7 5697.0 5697.3 5378.3 5387.8 5499.2 5574.4 5620.6 5479.0 5486.1 5500.8 5572.9 5579.9 5268.0 5426.9 5427.9 5433.9 5449.0 5603.0 5605.4 5655.9 5675.0 5676.1 5442.9 5516.4 5547.5 5551.3 5551.3 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - PROCESS | 8323 | [#5] yui.html Cycles:180 Average:15921.69 Median:4572.30 stddev:18936.96 (414.2%) stddev-sans-first:18955.87 04:32:26 INFO - PROCESS | 8323 | Values: 764.2 767.0 805.6 826.7 889.1 14586.9 15182.6 15258.8 15307.2 15352.5 11873.0 13515.7 13552.5 13562.5 13565.5 774.7 816.6 817.4 818.8 819.8 807.5 809.3 811.8 816.0 816.0 700.1 857.2 859.4 859.9 860.1 806.5 840.7 841.6 841.6 843.6 618.7 619.5 619.9 620.2 620.5 14475.0 14604.3 14627.6 14633.9 14645.7 13406.4 13644.5 13770.0 13820.7 14005.6 12707.7 12834.6 13056.9 13058.9 13070.1 4456.2 4497.4 4539.0 4559.7 4636.4 53452.5 53522.7 54332.7 59358.7 59699.1 10757.5 10787.1 10914.9 10948.9 11141.0 20195.6 20401.1 20436.1 20477.0 20491.0 8353.7 8355.6 8373.6 8443.0 8449.7 4466.4 4552.4 4561.4 4583.2 4634.1 3326.8 3426.9 3428.7 3438.0 3440.8 606.5 651.4 674.7 689.4 720.0 681.8 701.5 763.5 764.9 801.2 9614.9 9976.5 10335.7 10336.6 10352.7 663.5 725.7 750.2 792.4 795.0 4725.0 4838.8 4886.0 4901.6 4940.2 71335.3 72744.6 73570.3 73757.0 74096.3 52677.2 54101.0 54130.7 58804.0 64488.7 57293.0 57371.0 57429.7 57519.7 58773.4 9727.2 9839.5 9978.6 10214.1 10302.4 36625.6 37088.6 37546.6 37902.4 38042.4 49669.3 49903.3 49945.3 49990.0 50223.2 11847.2 11880.6 11917.4 12798.9 12942.2 13184.7 13980.2 14515.9 14533.6 14583.3 7727.7 12411.9 13477.8 13578.5 13904.8 12637.5 12806.7 12863.8 13170.1 13587.2 13239.0 13914.7 13985.2 14115.8 14124.9 11005.6 11341.7 11524.7 11566.2 11645.2 10936.3 11405.3 11564.1 11618.4 11658.1 04:32:26 INFO - PROCESS | 8323 | -------- Summary: end -------- 04:32:26 INFO - PROCESS | 8323 | 04:32:26 INFO - TEST-INFO | 8323: exit 0 04:32:26 INFO - TEST-OK | dromaeo_css | took 1113620ms 04:32:26 INFO - TEST-START | kraken 04:32:26 INFO - operating with platform_type : linux_ 04:32:26 INFO - Initialising browser for kraken test... 04:32:26 INFO - TEST-INFO | started process 8508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEZQAI/profile http://localhost:41281/getInfo.html) 04:32:31 INFO - PROCESS | 8508 | __metrics Screen width/height:1600/1200 04:32:31 INFO - PROCESS | 8508 | colorDepth:24 04:32:31 INFO - PROCESS | 8508 | Browser inner width/height: 1024/697 04:32:31 INFO - PROCESS | 8508 | __metrics 04:32:32 ERROR - PROCESS | 8508 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:33 INFO - TEST-INFO | 8508: exit 0 04:32:33 INFO - Browser initialized. 04:32:33 INFO - Running cycle 1/1 for kraken test... 04:32:33 INFO - TEST-INFO | started process 8592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEZQAI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:44 INFO - PROCESS | 8592 | RSS: Main: 152793088 04:32:44 INFO - PROCESS | 8592 | 04:32:47 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41281/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:48 INFO - PROCESS | 8592 | RSS: Main: 209813504 04:32:48 INFO - PROCESS | 8592 | 04:32:51 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41281/tests/kraken/driver.html?testName=audio-dft) 04:32:51 INFO - PROCESS | 8592 | RSS: Main: 195936256 04:32:51 INFO - PROCESS | 8592 | 04:32:54 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41281/tests/kraken/driver.html?testName=audio-fft) 04:32:55 INFO - PROCESS | 8592 | RSS: Main: 265826304 04:32:55 INFO - PROCESS | 8592 | 04:32:57 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41281/tests/kraken/driver.html?testName=audio-oscillator) 04:32:58 INFO - PROCESS | 8592 | RSS: Main: 175071232 04:32:58 INFO - PROCESS | 8592 | 04:33:00 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:00 INFO - PROCESS | 8592 | RSS: Main: 178962432 04:33:00 INFO - PROCESS | 8592 | 04:33:03 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41281/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:04 INFO - PROCESS | 8592 | RSS: Main: 215363584 04:33:04 INFO - PROCESS | 8592 | 04:33:07 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41281/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:08 INFO - PROCESS | 8592 | RSS: Main: 215187456 04:33:08 INFO - PROCESS | 8592 | 04:33:11 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41281/tests/kraken/driver.html?testName=json-parse-financial) 04:33:11 INFO - PROCESS | 8592 | RSS: Main: 215941120 04:33:11 INFO - PROCESS | 8592 | 04:33:13 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:13 INFO - PROCESS | 8592 | RSS: Main: 205320192 04:33:13 INFO - PROCESS | 8592 | 04:33:15 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:16 INFO - PROCESS | 8592 | RSS: Main: 208855040 04:33:16 INFO - PROCESS | 8592 | 04:33:18 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:18 INFO - PROCESS | 8592 | RSS: Main: 218292224 04:33:18 INFO - PROCESS | 8592 | 04:33:21 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:22 INFO - PROCESS | 8592 | RSS: Main: 224010240 04:33:22 INFO - PROCESS | 8592 | 04:33:24 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:25 INFO - PROCESS | 8592 | RSS: Main: 220844032 04:33:25 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | Cycle 1(1): loaded http://localhost:41281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41281/tests/kraken/driver.html?testName=ai-astar) 04:33:27 INFO - PROCESS | 8592 | RSS: Main: 267362304 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | __start_tp_report 04:33:27 INFO - PROCESS | 8592 | _x_x_mozilla_page_load 04:33:27 INFO - PROCESS | 8592 | _x_x_mozilla_page_load_details 04:33:27 INFO - PROCESS | 8592 | |i|pagename|runs| 04:33:27 INFO - PROCESS | 8592 | |0;ai-astar;112;107;110;111;110;110;111;111;109;112 04:33:27 INFO - PROCESS | 8592 | |1;audio-beat-detection;156;125;127;189;134;134;147;124;178;125 04:33:27 INFO - PROCESS | 8592 | |2;audio-dft;161;161;159;162;161;160;162;161;161;161 04:33:27 INFO - PROCESS | 8592 | |3;audio-fft;75;74;76;119;75;76;74;74;100;76 04:33:27 INFO - PROCESS | 8592 | |4;audio-oscillator;82;83;133;84;84;84;116;84;83;126 04:33:27 INFO - PROCESS | 8592 | |5;imaging-gaussian-blur;117;117;118;116;117;117;117;116;117;117 04:33:27 INFO - PROCESS | 8592 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;145 04:33:27 INFO - PROCESS | 8592 | |7;imaging-desaturate;94;94;94;97;95;95;94;95;95;94 04:33:27 INFO - PROCESS | 8592 | |8;json-parse-financial;55;54;55;54;54;55;54;73;53;54 04:33:27 INFO - PROCESS | 8592 | |9;json-stringify-tinderbox;61;62;60;63;63;61;61;61;61;68 04:33:27 INFO - PROCESS | 8592 | |10;stanford-crypto-aes;80;85;82;84;79;81;81;78;80;85 04:33:27 INFO - PROCESS | 8592 | |11;stanford-crypto-ccm;130;138;127;120;119;121;130;119;183;121 04:33:27 INFO - PROCESS | 8592 | |12;stanford-crypto-pbkdf2;161;160;162;160;159;157;169;162;159;162 04:33:27 INFO - PROCESS | 8592 | |13;stanford-crypto-sha256-iterative;63;63;64;66;63;61;63;62;62;63 04:33:27 INFO - PROCESS | 8592 | __end_tp_report 04:33:27 INFO - PROCESS | 8592 | __start_cc_report 04:33:27 INFO - PROCESS | 8592 | _x_x_mozilla_cycle_collect,1650 04:33:27 INFO - PROCESS | 8592 | __end_cc_report 04:33:27 INFO - PROCESS | 8592 | __startTimestamp1464089607385__endTimestamp 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | ------- Summary: start ------- 04:33:27 INFO - PROCESS | 8592 | Number of tests: 14 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:1.45 04:33:27 INFO - PROCESS | 8592 | Values: 112.0 107.0 110.0 111.0 110.0 110.0 111.0 111.0 109.0 112.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:140.50 stddev:23.44 (16.7%) stddev-sans-first:24.45 04:33:27 INFO - PROCESS | 8592 | Values: 156.0 125.0 127.0 189.0 134.0 134.0 147.0 124.0 178.0 125.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:33:27 INFO - PROCESS | 8592 | Values: 161.0 161.0 159.0 162.0 161.0 160.0 162.0 161.0 161.0 161.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.24 (20.3%) stddev-sans-first:15.96 04:33:27 INFO - PROCESS | 8592 | Values: 75.0 74.0 76.0 119.0 75.0 76.0 74.0 74.0 100.0 76.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.50 stddev:20.49 (24.5%) stddev-sans-first:21.11 04:33:27 INFO - PROCESS | 8592 | Values: 82.0 83.0 133.0 84.0 84.0 84.0 116.0 84.0 83.0 126.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:33:27 INFO - PROCESS | 8592 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:33:27 INFO - PROCESS | 8592 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 04:33:27 INFO - PROCESS | 8592 | Values: 94.0 94.0 94.0 97.0 95.0 95.0 94.0 95.0 95.0 94.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.50 stddev:5.97 (11.0%) stddev-sans-first:6.32 04:33:27 INFO - PROCESS | 8592 | Values: 55.0 54.0 55.0 54.0 54.0 55.0 54.0 73.0 53.0 54.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:61.50 stddev:2.28 (3.7%) stddev-sans-first:2.39 04:33:27 INFO - PROCESS | 8592 | Values: 61.0 62.0 60.0 63.0 63.0 61.0 61.0 61.0 61.0 68.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.46 (3.0%) stddev-sans-first:2.55 04:33:27 INFO - PROCESS | 8592 | Values: 80.0 85.0 82.0 84.0 79.0 81.0 81.0 78.0 80.0 85.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:128.50 stddev:19.38 (15.1%) stddev-sans-first:20.55 04:33:27 INFO - PROCESS | 8592 | Values: 130.0 138.0 127.0 120.0 119.0 121.0 130.0 119.0 183.0 121.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:3.21 (2.0%) stddev-sans-first:3.41 04:33:27 INFO - PROCESS | 8592 | Values: 161.0 160.0 162.0 160.0 159.0 157.0 169.0 162.0 159.0 162.0 04:33:27 INFO - PROCESS | 8592 | 04:33:27 INFO - PROCESS | 8592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.41 04:33:27 INFO - PROCESS | 8592 | Values: 63.0 63.0 64.0 66.0 63.0 61.0 63.0 62.0 62.0 63.0 04:33:27 INFO - PROCESS | 8592 | -------- Summary: end -------- 04:33:27 INFO - PROCESS | 8592 | 04:33:28 INFO - TEST-INFO | 8592: exit 0 04:33:28 INFO - TEST-OK | kraken | took 61508ms 04:33:28 INFO - SUITE-END | took 1175s 04:33:28 INFO - Completed test suite (00:19:35) 04:33:28 INFO - javascript benchmark 04:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.2516196112933, 3127.0306205076413, 3136.6392864820546, 3160.7313378362837, 3184.5382419549164, 5335.173048177529, 5358.785648574058, 5397.649152805065, 5472.534834539064, 5495.917561236584, 5291.576673866091, 5363.088274993251, 5370.3287089113865, 5435.211894275328, 5479.04116779564, 4826.1554228010045, 4851.054044461332, 5043.42000669924, 5112.437631860493, 5115.104856650071, 5024.949750502503, 5069.569086627641, 5084.4661310562415, 5099.107656160176, 5100.209467532539, 4839.588634966014, 4949.950500495003, 4975.800967961277, 4998.425181104147, 5013.248012798073, 5027.748612569357, 5028.220625803006, 5041.445441001487, 5043.67216130954, 5097.286379906816, 4971.229459433794, 4997.350344455234, 5007.399112106534, 5019.824306149268, 5031.440288306201, 5204.037253108149, 5265.762545801734, 5311.654742441768, 5397.811076612339, 5411.621186516906, 5841.970790146022, 5876.177335173079, 5876.324222714357, 5877.823665290048, 5878.588498805086, 5636.323641163046, 5867.794627188028, 5888.087346461305, 5910.1430292607765, 5921.763129474816, 5304.257403963448, 5381.2197231401615, 5385.461453854622, 5388.218708287276, 5389.622726409153, 5895.882082358329, 5917.970410147922, 5941.643501389931, 6017.909731354033, 6029.095635654599, 5747.971260143756, 5761.596688231783, 5803.912941305884, 5824.271966004249, 5836.533077353802, 5625.324961004624, 5872.677002764804, 5892.351841297454, 5902.05567109269, 5928.555358348055, 5810.070388737781, 5838.2702162229725, 5841.824745257649, 5849.064149736022, 5856.326522449973, 5843.649381037067, 5870.589058765845, 5871.55963302754, 5872.853178670482, 5881.5000724938, 4259.297215959332, 4383.276759334738, 4449.532799056117, 4462.776861156929, 4493.0, 3927.66614837742, 3949.348357520977, 3950.743201691881, 3969.126792105732, 4000.2799496090984, 5553.444655534414, 5565.332160140728, 5567.610267281251, 5570.860728481739, 5571.052921003439, 5709.229254050733, 5830.737616807169, 5887.264091988502, 5901.616394934315, 5960.165576819249, 5574.052411090124, 5576.888462230814, 5590.468905453975, 5593.524550413179, 5614.129809879475, 5057.039162559102, 5060.7722652480725, 5065.468125846806, 5072.467390923974, 5114.002769459994, 5805.303363596396, 6062.2725272966645, 6108.053251745987, 6122.418370254908, 6123.755049797958, 5921.792737254175, 5929.0513517836935, 5952.613080149949, 5960.791372301948, 5963.880722385615, 6097.75608975636, 6141.109539116714, 6146.723397447215, 6147.600405973598, 6148.047052706837, 5532.197831314517, 5732.369439361751, 5753.568482363756, 5775.422457754191, 5803.129530570448, 5815.360310365941, 5857.384974577608, 5859.765609375748, 5861.443162899518, 5868.413158684098, 5484.012877682056, 5625.578081643975, 5691.573132015033, 5695.259616249861, 5695.544356451557, 5665.0, 5715.599908006566, 5727.828165155052, 5765.394633563583, 5774.0761478163295, 5681.460261275172, 5682.715864206856, 5686.8578285541535, 5690.402507736628, 5691.0, 5490.835274941758, 5723.284589426322, 5783.161441590862, 5792.9710351447975, 5827.446392592697, 5352.785888564414, 5385.0, 5572.442755724395, 5577.721113944368, 5611.242482264842], "value": 5386.448386349436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.4952464691982, 647.7085311609774, 650.2229835346759, 657.4247533408268, 662.2218892800959, 30304.54543181851, 30668.386632267368, 32615.67384326156, 42127.36808947868, 43069.13861722764, 44474.33288500675, 44983.77508112455, 44990.55009449904, 45044.774776126076, 45054.324185137164, 8590.44162129461, 8770.56147192641, 8780.604872780708, 8785.472871627722, 8787.297016238717, 8586.441881277697, 8761.649534018663, 8774.0, 8774.868376974351, 8778.0, 8760.386772925898, 8798.6920457784, 8812.339074569432, 8820.735377938672, 8828.73513794584, 8752.343574231927, 8763.079876612928, 8795.164459376349, 8807.735767926972, 8817.29461643067, 8583.828323433496, 8655.0, 8698.869516957251, 8760.342974276955, 8763.605637746254, 40121.0, 40403.797981010204, 40478.392824107665, 40488.0, 40566.59433405658, 3604.9279014419567, 3614.9096272593133, 3682.963170368289, 3700.907477313062, 3781.357169281229, 30973.690263097305, 33413.0, 33766.49350259748, 34917.0, 34948.301033979435, 4276.593723596254, 4362.323839804835, 4397.2304846651705, 4407.60331570157, 4444.0, 348312.0, 349563.0, 352188.0, 354581.0, 355525.0, 54530.0, 64452.35547644558, 65530.0, 65586.0, 65602.7198640066, 64351.67824160849, 66699.66650166718, 66800.66599667068, 73534.63232683802, 73785.63107184538, 15237.161956092521, 15392.230388480531, 15451.150186739613, 15459.845401546065, 15484.458043968407, 10310.896891031143, 11026.889731102587, 11540.769184616262, 11646.126540509496, 11663.650090497298, 19582.38375114945, 20197.0, 20367.59264814725, 20465.795342046687, 20483.180672773222, 7577.280158384945, 7606.467547271748, 7709.229077092358, 7770.45606807518, 7823.447452229277, 1039.2205845615788, 1108.534415545473, 1144.1933436926947, 1178.8270670682555, 1207.4626791077885, 32667.67332326694, 33234.33531329408, 33301.83349083239, 33399.165020874185, 34005.82997084999, 1107.496089279392, 1141.4292853573213, 1145.3471521232984, 1190.7916114679897, 1228.655976326612, 17306.740398894028, 17421.303147874198, 17465.38871139504, 17467.301307947793, 17684.64630707379, 539247.0, 542873.0, 544531.0, 545002.0, 546284.0, 56519.15221271684, 57035.71482142646, 57091.71454142703, 57115.0, 57225.85257810777, 1143.54258296682, 1351.8175046368615, 1385.2727318158047, 1386.0, 1386.6949271160329, 33368.0, 34358.0, 34596.30807383889, 34602.0, 34638.30723385468, 47913.56259312226, 48486.75756621194, 48560.271595925384, 48593.5140648589, 48618.5138148614, 389612.0, 394337.0, 396809.0, 398143.0, 399049.0, 25949.740502594734, 37496.0, 42288.577114228465, 43238.0, 44164.77917610391, 42273.0, 44358.778206108764, 45073.0985380284, 45290.547094528636, 45603.315950261436, 38617.42073868838, 39541.60458395494, 40276.597234027286, 43986.0, 44455.555444446436, 41330.0, 42254.0, 42480.0, 42635.786821065696, 43273.78363108164, 41411.7929410351, 41750.16499670051, 41986.0, 42635.78682106694, 42800.0, 36227.63772362243, 37316.25367492689, 37460.0, 37597.33367720416, 38328.80835595804, 28755.0, 28929.56605650959, 29033.0, 29118.56322155127, 29279.707202927697], "value": 20393.186265520606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.2641341830395, 385.5219527785547, 385.81434729064017, 398.11220977220796, 408.93457046872487, 14395.928020359883, 16720.58198545037, 18058.90970545147, 19493.99999999998, 19496.512587185327, 13524.0, 15904.681906361895, 16031.919840400782, 16784.916075419605, 17070.573235669115, 5459.071957767169, 5573.23651142288, 5638.661680299195, 5667.263255776764, 5680.9715951420185, 3961.683065354779, 5478.849441617265, 5536.640118392312, 5603.831885043455, 5973.1040343948325, 6201.286852012031, 6252.187215661957, 6253.7185826637915, 6292.276388215368, 6317.147185129995, 6191.226096737908, 6244.344343843876, 6264.21697287839, 6267.435930766253, 6277.403646653561, 5347.197920311945, 5469.644473109275, 5472.480114389126, 5480.972595136999, 5489.149181876815, 20953.0, 21470.248541301135, 21943.780562194494, 22185.11259549616, 22283.44291392712, 2320.083566991029, 2355.9764402355927, 2365.455945132629, 2597.6882774067235, 2871.913842584726, 13237.470501180038, 13437.126586771927, 13550.0, 13864.4454221831, 14362.066465679802, 1927.884326940388, 1940.3596813051659, 1947.1237942925598, 1968.6062787442568, 2034.5930813837292, 74980.0, 77386.22613773902, 77704.11723656619, 78323.21676783274, 99038.50480747622, 16540.676745860303, 16821.663566728595, 17380.47858564245, 17801.46595602134, 17856.46430607084, 31264.843675781474, 31499.212519687193, 31562.842185789385, 31921.840390797897, 32071.51892721611, 8066.7579972600915, 8367.163283671583, 8778.648854045767, 8804.559772011375, 9079.54602269897, 7332.376747976375, 7536.284053014955, 7564.243575642502, 7793.883091753628, 7804.765857024298, 8592.613332400057, 8730.86903696445, 8770.649174032967, 8893.0, 8906.376553641183, 3271.6074071111143, 3320.8505617246797, 3389.8135602542097, 3451.8964431067106, 3517.2262102337445, 911.6490151291667, 945.550863339908, 956.0200794186015, 1023.9385636861812, 1066.258950029722, 18154.63690726178, 18287.634247315244, 18458.0, 18515.907420462812, 18720.53198670017, 979.9804003919882, 1000.2797985450464, 1008.4655132779639, 1026.0560284538242, 1027.5838285494237, 9781.853272200922, 10334.483275836328, 10356.948215259026, 10453.0, 10541.57833686644, 474047.4528614811, 475166.0, 475284.0, 479055.0, 483062.0, 87037.0, 90497.0, 91770.19953303911, 92107.53946230226, 92112.53943730373, 998.3959704378891, 1018.0888105145852, 1019.7858449725641, 1041.692700653294, 1044.378594736146, 16524.0, 16597.668046639243, 16729.247183876512, 16769.32922683079, 17000.149992500574, 30517.0, 37569.81215093907, 38438.693678379386, 40359.79820100881, 40721.79639101786, 51741.48258517367, 52386.47613523816, 54381.45618543764, 54819.725901370235, 55032.17451738147, 8344.707935222237, 8374.83250335002, 8388.748337549883, 8422.83154336922, 8448.155184481502, 12363.258204507398, 12740.235585864877, 12856.228626282453, 12894.548690795777, 12927.418266177856, 11176.888231117584, 11287.943560282147, 11306.038986685895, 11421.885781142082, 11473.598424055119, 11111.222214444912, 11312.773744525228, 11373.14701397415, 11455.713607159887, 11667.416629168338, 11503.654890353302, 11618.186726929034, 11731.41342932833, 11743.17797754149, 11785.882141178821, 7214.567125972459, 7247.202807691045, 7361.1166660001145, 8413.284870785807, 8499.617517211616, 8905.73282801517, 11455.198136130392, 11554.133439991867, 11615.883841161818, 11619.941900290445], "value": 9708.793959001774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.4909934224993, 1486.5466032859977, 1526.503886236973, 1688.36686242659, 1839.3562253211378, 8527.573621318932, 8881.866771998417, 8890.466572005676, 9167.854018247719, 9178.816423671538, 8824.735257942257, 9026.368154229207, 9030.954845225764, 9031.322650801183, 9034.232090272319, 2068.7207227024387, 2289.9656505152434, 2351.423901144222, 2382.7736365045334, 2416.709994800626, 2376.4177776444794, 2384.1655420602824, 2387.331547166796, 2387.7612238776155, 2388.0925248405583, 2342.3207269891795, 2348.2602980061224, 2374.097842819726, 2378.52429514097, 2381.4879800842814, 1983.623111608797, 2259.186692790594, 2284.303287497313, 2333.230034088747, 2342.4378149244058, 2296.5062511559927, 2304.5275718477674, 2317.6523521471745, 2318.976810231893, 2324.7675232476786, 9050.77373065672, 9094.63621455141, 9108.81782364349, 9109.772255693595, 9159.542022898895, 5148.897022059537, 5273.393559740641, 5279.498447647506, 5280.049591073605, 5283.101872681654, 3360.949585756191, 3472.791632502033, 3488.9127771805656, 3523.189666376722, 3531.311394278117, 984.3700031979539, 1058.6188971970084, 1074.2426589254558, 1096.8793432722393, 1104.320842681753, 12083.27500349973, 12095.758084838342, 12161.0, 12191.878081219164, 12200.877991220063, 4274.0, 4344.1311737652595, 4444.755538445416, 4447.0, 4450.0, 9492.477913714813, 9580.329376943548, 9593.376430531993, 9605.0, 9609.615615375447, 5008.173651347487, 5058.873528161826, 5061.266116413173, 5071.492850714899, 5077.111505486525, 4376.081022985145, 4674.0651869625535, 4789.616830653539, 4795.808167673254, 4854.660173787801, 3854.3062248795486, 3876.341022026262, 3944.9211015779524, 3985.442038114666, 4004.7196696231567, 1146.7075895646556, 1148.9885101148882, 1154.705550084723, 1160.3386069940223, 1165.114512970132, 976.0, 979.2313034268066, 985.4087547471603, 998.0618218874235, 1011.2466212671607, 5805.709714514257, 5991.64050156992, 6168.414000669929, 6193.597416167935, 6322.209723784527, 912.9908700913039, 942.9151376376159, 970.4129001953858, 981.749653838281, 1007.677543186188, 4222.218889505451, 4313.158934007838, 4436.889077773081, 4501.077279157765, 4523.592876641118, 11385.08919286455, 11442.713932151762, 11567.76864462706, 11569.537218511334, 11587.130965177645, 11321.0, 11424.714382140346, 11428.485718142703, 11438.828417573743, 11443.0, 8077.474964127313, 8397.0, 8406.327493800482, 8423.873641895376, 8563.657453701782, 6022.277326720821, 6217.409346112112, 6266.154069200599, 6270.498360131087, 6419.35806419373, 10403.94798026005, 10454.11140053104, 10483.318584291997, 10643.467826608483, 10672.786544268916, 10739.624113156002, 10792.352458852494, 10815.080718138732, 10847.78304433891, 10938.398388088413, 7918.841623167389, 8034.357251419756, 8091.109977902308, 8143.75568732939, 8149.755507334789, 8686.0, 8727.08365621626, 8747.125287471203, 8767.254783343487, 8836.337274704294, 7887.881681774663, 7963.203679631991, 7993.040835099593, 8039.397045221514, 8082.070561885458, 7661.885071723817, 7679.232076792499, 7708.267714567107, 7717.961410192913, 7874.05511338643, 7119.252478489684, 7222.819429514304, 7223.205447400676, 7242.710291588488, 7257.383122434441, 5273.419923808301, 5348.5186333230195, 5360.731963401737, 5415.783368665367, 5561.63849349791, 5362.356517217959, 5516.834494965157, 5538.47384498472, 5556.527695145796, 5611.943880561143], "value": 4699.104589909294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2924687841404, 322.09330733983836, 323.24683487474186, 323.6795572383341, 327.973762099032, 5326.2543243945875, 5377.327834020747, 5391.304347826087, 5411.404745477999, 5423.0, 5275.261463395128, 5278.736063196844, 5283.867903302419, 5289.603279754024, 5341.1988201769755, 3944.684425245973, 3976.886471787904, 4092.1406504634065, 4110.157417729359, 4114.938275925849, 4065.6340929316357, 4099.938500922489, 4111.301078816608, 4111.635809409587, 4112.527059388179, 3942.0, 4075.9796201018953, 4092.3043082676018, 4102.692298077641, 4120.814563344642, 3954.0, 4103.589641035887, 4124.288420305569, 4149.2531344358, 4154.5222299435345, 3610.9277814443826, 3632.745707800455, 3637.3089113068695, 3646.726495512847, 3661.6634928251265, 5048.1670524363435, 5074.441811400779, 5108.897822043576, 5150.072986862363, 5170.663906846043, 4487.640988720895, 4709.764511774398, 4714.905701885943, 4737.786799594027, 4757.452892917324, 5497.615166938316, 5525.336959564878, 5531.668099914018, 5537.031019571559, 5542.362628297717, 3959.5050618672667, 3969.1069509360163, 3972.7616343019513, 3982.143839074613, 3995.5005624296964, 5621.522170615503, 5687.459691329358, 5751.245870009645, 5755.251817263729, 5795.826125216292, 4046.9392959105635, 4072.816723247461, 4076.449679293317, 4084.346504559256, 4091.013560101143, 4104.445899803488, 4106.178764247163, 4122.711410201317, 4155.10665206982, 4159.500859896832, 4383.715058521186, 4622.14490319292, 4650.6046986005895, 4691.7948564174785, 4756.881077973078, 5512.448755124456, 5564.582656300794, 5578.043636872464, 5624.85937851557, 5635.802037205493, 1384.55002124308, 1401.9439222431192, 1405.9086159399606, 1410.5133728863525, 1413.6536548545673, 881.5944665453964, 882.1839798186652, 902.5261737587688, 913.2420091324185, 926.9016215784317, 5329.440408757102, 5330.866728331823, 5341.4894999350245, 5381.811636592779, 5385.353757549119, 5597.524210442077, 5602.159676048625, 5613.887722245614, 5629.268195134607, 5665.49010589049, 5199.350081239845, 5228.084604598885, 5298.841034768963, 5305.54097623149, 5366.490183432567, 2980.6423229212633, 2981.344104297051, 2993.4911065118545, 3001.834899080528, 3014.754008263814, 5679.716014199274, 5688.175214593861, 5696.914546281726, 5708.343540492813, 5725.312962444534, 5519.972400137974, 5681.744321505542, 5709.716912775171, 5734.397888221677, 5735.139729040678, 5760.740766665426, 5800.8259752207505, 5819.505342045889, 5820.330661973927, 5862.530997520188, 5395.487428694268, 5596.300462442195, 5640.717964101696, 5652.745626446737, 5660.462256085665, 5566.526845218202, 5570.994442000958, 5593.161025845993, 5594.300712410949, 5596.440355964533, 5780.075187969905, 5783.0, 5809.680467574324, 5814.680192589279, 5815.5929084963645, 3811.2187001665147, 3970.543387510473, 3981.800909954549, 3994.201159768, 4011.217812526646, 5646.576506761927, 5651.8304450866535, 5691.686957217393, 5696.971515142398, 5697.287839020122, 5378.300820893259, 5387.75755091014, 5499.230107784833, 5574.414686457863, 5620.634658747168, 5479.0, 5486.0923710433535, 5500.752466138953, 5572.86067848307, 5579.9163012555655, 5267.9736601316745, 5426.918596221139, 5427.891442171213, 5433.886053358973, 5448.983875965918, 5603.0, 5605.411431799603, 5655.915161272666, 5675.0, 5676.091825308096, 5442.891142177055, 5516.434857791146, 5547.528460080938, 5551.306086739158, 5551.306086739158], "value": 4204.089121393665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.2319468933721, 767.0335377424443, 805.6012273924406, 826.6569373709909, 889.0798024045107, 14586.854131458682, 15182.62043448913, 15258.771118433233, 15307.158106304149, 15352.46266380677, 11873.0, 13515.729685406286, 13552.525661601845, 13562.525311614096, 13565.52520661777, 774.6823802241069, 816.6202715737181, 817.448222449847, 818.7502811642447, 819.8032472206687, 807.475141158246, 809.3080416244114, 811.8498077855586, 815.9918400816005, 816.049302562514, 700.1353328639127, 857.2327766648876, 859.4070091636781, 859.9011113721908, 860.096898256831, 806.5281810141074, 840.7099550655014, 841.5581819544788, 841.6212704283097, 843.6288033265374, 618.7494064903722, 619.5198720991223, 619.9070139479114, 620.2216218645616, 620.5376994139395, 14475.0, 14604.269786510738, 14627.63430914225, 14633.926830365886, 14645.707085858223, 13406.39671214788, 13644.454221831114, 13770.0, 13820.723585528334, 14005.649858753512, 12707.682307942283, 12834.614961551168, 13056.934715326457, 13058.869411305861, 13070.085094043421, 4456.22016147173, 4497.370368148462, 4538.954610453886, 4559.70361926477, 4636.443626764776, 53452.46547534514, 53522.73238633821, 54332.72833635846, 59358.70320648369, 59699.104513432336, 10757.515911783832, 10787.137029037658, 10914.890851091388, 10948.945255273673, 11141.0, 20195.596088078157, 20401.081951312226, 20436.0803763831, 20477.0, 20491.0, 8353.749387518385, 8355.582220888931, 8373.581320933929, 8443.0, 8449.704260350858, 4466.419365482531, 4552.416948478178, 4561.429821272341, 4583.179730389478, 4634.142683603544, 3326.800391976489, 3426.862925482953, 3428.674275943831, 3438.0, 3440.7935523868646, 606.5329696133953, 651.3811878715239, 674.7166190200128, 689.4449967775988, 719.9856002879914, 681.8295426143465, 701.4949236549676, 763.4884627299723, 764.8929149919015, 801.2388231180402, 9614.9038509614, 9976.501174941224, 10335.741606459898, 10336.638217662496, 10352.741181470523, 663.4857985061616, 725.7242247945852, 750.1635676220974, 792.359815182578, 795.0, 4724.966143551318, 4838.782254798542, 4886.0225280113955, 4901.607871370282, 4940.219278662542, 71335.28664713391, 72744.63627681934, 73570.26429735633, 73757.0, 74096.25903740893, 52677.20984185164, 54101.0, 54130.729346353015, 58804.0, 64488.67755661192, 57293.0, 57371.0, 57429.71285143548, 57519.712401437726, 58773.41226587765, 9727.221822254343, 9839.458829764431, 9978.550965206729, 10214.131798796889, 10302.433366164933, 36625.63374366222, 37088.6291137096, 37546.624533754315, 37902.43146352862, 38042.429363559015, 49669.25496117633, 49903.25145122754, 49945.25082123699, 49990.0, 50223.24665129953, 11847.170698051053, 11880.643580692593, 11917.404129793302, 12798.936005320285, 12942.223466592035, 13184.73630527365, 13980.231087290296, 14515.92742036283, 14533.563993080224, 14583.270836457923, 7727.729529466442, 12411.937940310241, 13477.797833032708, 13578.45686172542, 13904.791428128789, 12637.494500219887, 12806.67983300425, 12863.807042894552, 13170.07809453329, 13587.184768913898, 13239.0, 13914.652133696738, 13985.160890346611, 14115.788263175855, 14124.929375353058, 11005.61480348184, 11341.667998082734, 11524.711882203012, 11566.248193867372, 11645.215305025731, 10936.289141205796, 11405.315681059163, 11564.13269004845, 11618.360990145624, 11658.12564057716], "value": 7060.426915124004, "unit": "score"}], "name": "dromaeo_css", "value": 7279.241494262635, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 109.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 127.0, 189.0, 134.0, 134.0, 147.0, 124.0, 178.0, 125.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 119.0, 75.0, 76.0, 74.0, 74.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 133.0, 84.0, 84.0, 84.0, 116.0, 84.0, 83.0, 126.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 97.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 73.0, 53.0, 54.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 63.0, 63.0, 61.0, 61.0, 61.0, 61.0, 68.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 82.0, 84.0, 79.0, 81.0, 81.0, 78.0, 80.0, 85.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 127.0, 120.0, 119.0, 121.0, 130.0, 119.0, 183.0, 121.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 159.0, 157.0, 169.0, 162.0, 159.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 66.0, 63.0, 61.0, 63.0, 62.0, 62.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1504.6999999999998, "alertThreshold": 2.0}]} 04:33:28 INFO - Return code: 0 04:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:33:28 ERROR - # TBPL SUCCESS # 04:33:28 INFO - Running post-action listener: _resource_record_post_action 04:33:28 INFO - ##### 04:33:28 INFO - ##### Finished run-tests step (success) 04:33:28 INFO - ##### 04:33:28 INFO - Running post-run listener: _resource_record_post_run 04:33:28 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537305088; Read time: 12; Write time: 671392 04:33:28 INFO - TinderboxPrint: CPU usage
13.2% 04:33:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:33:28 INFO - TinderboxPrint: I/O write bytes / time
537,305,088 / 671,392 04:33:28 INFO - TinderboxPrint: CPU idle
8,268.1 (86.8%) 04:33:28 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 04:33:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247275520; Read time: 0; Write time: 326944 04:33:28 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289898496; Read time: 12; Write time: 344448 04:33:29 INFO - Running post-run listener: _upload_blobber_files 04:33:29 INFO - Blob upload gear active. 04:33:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:36 INFO - (blobuploader) - INFO - Done attempting. 04:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:36 INFO - (blobuploader) - INFO - Done attempting. 04:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:37 INFO - (blobuploader) - INFO - Done attempting. 04:33:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:37 INFO - Return code: 0 04:33:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3415e8c51cdeb88e34abe6d29bb492a1f4980f21a12fc1eb7a847fe032d9777a4a5e756e58c18eac97500280faa340988777d37ce52435eea2bd395fda0b3281", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ece1f75cacee7d2dbc59260df21f667bad9429caee1452fe33fa7aad22119cf6fb7d750c554ecb72de574245ce9194d0c65e4782c786cd3e11f0a75b8be7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4bd02f2047a49721c603a119ee533e76a0078297817cc6f5044ce0f4e0374bf1acad3d91337fd6e751d54f1e7a248c72c53fd58878148acee0c1396589d186"} 04:33:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:37 INFO - Contents: 04:33:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3415e8c51cdeb88e34abe6d29bb492a1f4980f21a12fc1eb7a847fe032d9777a4a5e756e58c18eac97500280faa340988777d37ce52435eea2bd395fda0b3281", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ece1f75cacee7d2dbc59260df21f667bad9429caee1452fe33fa7aad22119cf6fb7d750c554ecb72de574245ce9194d0c65e4782c786cd3e11f0a75b8be7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4bd02f2047a49721c603a119ee533e76a0078297817cc6f5044ce0f4e0374bf1acad3d91337fd6e751d54f1e7a248c72c53fd58878148acee0c1396589d186"} 04:33:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:37 INFO - Copying logs to upload dir... 04:33:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.214770 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-24 04:33:37.669418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:33:37.672865) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 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/3415e8c51cdeb88e34abe6d29bb492a1f4980f21a12fc1eb7a847fe032d9777a4a5e756e58c18eac97500280faa340988777d37ce52435eea2bd395fda0b3281", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ece1f75cacee7d2dbc59260df21f667bad9429caee1452fe33fa7aad22119cf6fb7d750c554ecb72de574245ce9194d0c65e4782c786cd3e11f0a75b8be7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4bd02f2047a49721c603a119ee533e76a0078297817cc6f5044ce0f4e0374bf1acad3d91337fd6e751d54f1e7a248c72c53fd58878148acee0c1396589d186"} build_url:https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/eWt0mfFjSAiHNW3p5C90Wg/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/3415e8c51cdeb88e34abe6d29bb492a1f4980f21a12fc1eb7a847fe032d9777a4a5e756e58c18eac97500280faa340988777d37ce52435eea2bd395fda0b3281", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ece1f75cacee7d2dbc59260df21f667bad9429caee1452fe33fa7aad22119cf6fb7d750c554ecb72de574245ce9194d0c65e4782c786cd3e11f0a75b8be7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4bd02f2047a49721c603a119ee533e76a0078297817cc6f5044ce0f4e0374bf1acad3d91337fd6e751d54f1e7a248c72c53fd58878148acee0c1396589d186"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:33:37.697902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:33:37.698219) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464088378.339500-1915321319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:33:37.782239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:33:37.782610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:33:37.782890) ========= ========= Total master_lag: 0.16 =========