builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1464379575.72 results: success (0) buildid: 20160527115136 builduid: 77542bbabf124b2cbd6b8f5e5ef0d0b8 revision: a41a34f7d93659363d352eaad705d4da6d8f465c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:15.724176) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:15.724696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:15.724973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:15.740788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 13:06:15.741043) ========= 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=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 13:06:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-27 13:06:18 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.116351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 13:06:16.871536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:16.871873) ========= 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=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:16.921343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 13:06:16.921672) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a41a34f7d93659363d352eaad705d4da6d8f465c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a41a34f7d93659363d352eaad705d4da6d8f465c --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=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 13:06:18,285 truncating revision to first 12 chars 2016-05-27 13:06:18,285 Setting DEBUG logging. 2016-05-27 13:06:18,285 attempt 1/10 2016-05-27 13:06:18,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a41a34f7d936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 13:06:19,418 unpacking tar archive at: mozilla-central-a41a34f7d936/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461359 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 13:06:18.396379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:18.399699) ========= script_repo_revision: a41a34f7d93659363d352eaad705d4da6d8f465c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:18.400107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:18.400387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:06:18.418946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 13:06:18.419221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:19 INFO - MultiFileLogger online at 20160527 13:06:19 in /builds/slave/test 13:06:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:06:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:06:19 INFO - {'append_to_log': False, 13:06:19 INFO - 'base_work_dir': '/builds/slave/test', 13:06:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:06:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:06:19 INFO - 'branch': 'Firefox-Non-PGO', 13:06:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:19 INFO - 'config_files': ('talos/linux_config.py',), 13:06:19 INFO - 'default_actions': ('clobber', 13:06:19 INFO - 'read-buildbot-config', 13:06:19 INFO - 'download-and-extract', 13:06:19 INFO - 'populate-webroot', 13:06:19 INFO - 'create-virtualenv', 13:06:19 INFO - 'install', 13:06:19 INFO - 'run-tests'), 13:06:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:19 INFO - 'download_minidump_stackwalk': True, 13:06:19 INFO - 'download_symbols': 'ondemand', 13:06:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:19 INFO - 'installer_path': 'installer.exe', 13:06:19 INFO - 'log_level': 'info', 13:06:19 INFO - 'log_name': 'talos', 13:06:19 INFO - 'log_to_console': True, 13:06:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:19 INFO - 'opt_config_files': (), 13:06:19 INFO - 'pip_index': False, 13:06:19 INFO - 'sps_profile': False, 13:06:19 INFO - 'sps_profile_interval': 0, 13:06:19 INFO - 'suite': 'dromaeojs', 13:06:19 INFO - 'system_bits': '32', 13:06:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:19 INFO - 'title': 'talos-linux64-ix-048', 13:06:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:19 INFO - 'use_talos_json': True, 13:06:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:06:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:19 INFO - 'work_dir': 'build'} 13:06:19 INFO - ##### 13:06:19 INFO - ##### Running clobber step. 13:06:19 INFO - ##### 13:06:19 INFO - Running pre-action listener: _resource_record_pre_action 13:06:19 INFO - Running main action method: clobber 13:06:19 INFO - rmtree: /builds/slave/test/build 13:06:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:06:20 INFO - Running post-action listener: _resource_record_post_action 13:06:20 INFO - ##### 13:06:20 INFO - ##### Finished clobber step (success) 13:06:20 INFO - ##### 13:06:20 INFO - ##### 13:06:20 INFO - ##### Running read-buildbot-config step. 13:06:20 INFO - ##### 13:06:20 INFO - Running pre-action listener: _resource_record_pre_action 13:06:20 INFO - Running main action method: read_buildbot_config 13:06:20 INFO - Using buildbot properties: 13:06:20 INFO - { 13:06:20 INFO - "project": "", 13:06:20 INFO - "product": "firefox", 13:06:20 INFO - "script_repo_revision": "production", 13:06:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:06:20 INFO - "repository": "", 13:06:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:06:20 INFO - "buildid": "20160527115136", 13:06:20 INFO - "pgo_build": "False", 13:06:20 INFO - "basedir": "/builds/slave/test", 13:06:20 INFO - "buildnumber": 597, 13:06:20 INFO - "slavename": "talos-linux64-ix-048", 13:06:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:06:20 INFO - "platform": "ubuntu64_hw", 13:06:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:06:20 INFO - "branch": "mozilla-central", 13:06:20 INFO - "repo_path": "mozilla-central", 13:06:20 INFO - "revision": "a41a34f7d93659363d352eaad705d4da6d8f465c", 13:06:20 INFO - "stage_platform": "linux64", 13:06:20 INFO - "builduid": "77542bbabf124b2cbd6b8f5e5ef0d0b8", 13:06:20 INFO - "slavebuilddir": "test" 13:06:20 INFO - } 13:06:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:06:20 INFO - Running post-action listener: _resource_record_post_action 13:06:20 INFO - ##### 13:06:20 INFO - ##### Finished read-buildbot-config step (success) 13:06:20 INFO - ##### 13:06:20 INFO - ##### 13:06:20 INFO - ##### Running download-and-extract step. 13:06:20 INFO - ##### 13:06:20 INFO - Running pre-action listener: _resource_record_pre_action 13:06:20 INFO - Running main action method: download_and_extract 13:06:20 INFO - mkdir: /builds/slave/test/build/tests 13:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:20 INFO - https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:21 INFO - Downloaded 1361 bytes. 13:06:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:06:21 INFO - Using the following test package requirements: 13:06:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:06:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:06:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'jsshell-linux-x86_64.zip'], 13:06:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:06:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:06:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:06:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:06:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:06:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:21 INFO - https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:22 INFO - Downloaded 22837958 bytes. 13:06:22 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'] 13:06:22 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 13:06:24 INFO - Return code: 0 13:06:24 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 13:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:24 INFO - https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:25 INFO - Downloaded 22837958 bytes. 13:06:25 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'] 13:06:25 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 13:06:26 INFO - Return code: 0 13:06:26 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')]} 13:06:26 INFO - https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:06:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:06:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:06:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:27 INFO - Downloaded 10834034 bytes. 13:06:27 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'] 13:06:27 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 13:06:28 INFO - Return code: 0 13:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:28 INFO - https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOa2xAQdReyAh9kwc1Ppiw/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 13:06:31 INFO - Downloaded 54832800 bytes. 13:06:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:06:31 INFO - mkdir: /builds/slave/test/properties 13:06:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:06:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:06:31 INFO - Contents: 13:06:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:06:32 INFO - Running post-action listener: _resource_record_post_action 13:06:32 INFO - Running post-action listener: set_extra_try_arguments 13:06:32 INFO - ##### 13:06:32 INFO - ##### Finished download-and-extract step (success) 13:06:32 INFO - ##### 13:06:32 INFO - ##### 13:06:32 INFO - ##### Running populate-webroot step. 13:06:32 INFO - ##### 13:06:32 INFO - Running pre-action listener: _resource_record_pre_action 13:06:32 INFO - Running main action method: populate_webroot 13:06:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:06:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:06:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:06:32 INFO - '--tppagecycles', 13:06:32 INFO - '7'], 13:06:32 INFO - 'tests': ['tsvgm']}}, 13:06:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:06:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:06:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:06:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:06:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['damp', 'tps']}, 13:06:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['damp', 'tps']}, 13:06:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['dromaeo_dom']}, 13:06:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:06:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tsvgx', 13:06:32 INFO - 'tsvgr_opacity', 13:06:32 INFO - 'tart', 13:06:32 INFO - 'tscrollx', 13:06:32 INFO - 'cart']}, 13:06:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:06:32 INFO - 'tsvgr_opacity', 13:06:32 INFO - 'tart', 13:06:32 INFO - 'tscrollx', 13:06:32 INFO - 'cart']}, 13:06:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tp5o']}, 13:06:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['tp5o']}, 13:06:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s', 13:06:32 INFO - '--xperf_path', 13:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:32 INFO - 'tests': ['tp5n']}, 13:06:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--xperf_path', 13:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:32 INFO - 'tests': ['tp5n']}}, 13:06:32 INFO - 'talos.zip': {'path': '', 13:06:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:06:32 INFO - Running post-action listener: _resource_record_post_action 13:06:32 INFO - ##### 13:06:32 INFO - ##### Finished populate-webroot step (success) 13:06:32 INFO - ##### 13:06:32 INFO - ##### 13:06:32 INFO - ##### Running create-virtualenv step. 13:06:32 INFO - ##### 13:06:32 INFO - Running pre-action listener: _resource_record_pre_action 13:06:32 INFO - Running main action method: create_virtualenv 13:06:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:06:32 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 13:06:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:06:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:06:32 INFO - Using real prefix '/usr' 13:06:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:06:32 INFO - Installing distribute.............................................................................................................................................................................................done. 13:06:34 INFO - Installing pip.................done. 13:06:34 INFO - Return code: 0 13:06:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:06:34 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')]} 13:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:34 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')]} 13:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:34 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:34 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 13:06:34 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 13:06:34 INFO - Using env: {'DISPLAY': ':0', 13:06:34 INFO - 'HOME': '/home/cltbld', 13:06:34 INFO - 'LANG': 'en_US.UTF-8', 13:06:34 INFO - 'LANGUAGE': 'en_US:en', 13:06:34 INFO - 'LOGNAME': 'cltbld', 13:06:34 INFO - 'MAIL': '/var/mail/cltbld', 13:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:34 INFO - 'MOZ_NO_REMOTE': '1', 13:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:34 INFO - 'NO_EM_RESTART': '1', 13:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:34 INFO - 'PWD': '/builds/slave/test', 13:06:34 INFO - 'SHELL': '/bin/bash', 13:06:34 INFO - 'SHLVL': '1', 13:06:34 INFO - 'TERM': 'linux', 13:06:34 INFO - 'TMOUT': '86400', 13:06:34 INFO - 'USER': 'cltbld', 13:06:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:34 INFO - '_': '/tools/buildbot/bin/python'} 13:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:35 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 13:06:35 INFO - Cleaning up... 13:06:35 INFO - Return code: 0 13:06:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:06:35 INFO - Using env: {'DISPLAY': ':0', 13:06:35 INFO - 'HOME': '/home/cltbld', 13:06:35 INFO - 'LANG': 'en_US.UTF-8', 13:06:35 INFO - 'LANGUAGE': 'en_US:en', 13:06:35 INFO - 'LOGNAME': 'cltbld', 13:06:35 INFO - 'MAIL': '/var/mail/cltbld', 13:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:35 INFO - 'MOZ_NO_REMOTE': '1', 13:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:35 INFO - 'NO_EM_RESTART': '1', 13:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:35 INFO - 'PWD': '/builds/slave/test', 13:06:35 INFO - 'SHELL': '/bin/bash', 13:06:35 INFO - 'SHLVL': '1', 13:06:35 INFO - 'TERM': 'linux', 13:06:35 INFO - 'TMOUT': '86400', 13:06:35 INFO - 'USER': 'cltbld', 13:06:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:35 INFO - '_': '/tools/buildbot/bin/python'} 13:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:35 INFO - Downloading/unpacking psutil>=3.1.1 13:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:37 INFO - Installing collected packages: psutil 13:06:37 INFO - Running setup.py install for psutil 13:06:37 INFO - building 'psutil._psutil_linux' extension 13:06:37 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 13:06:37 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 13:06:37 INFO - building 'psutil._psutil_posix' extension 13:06:37 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 13:06:37 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 13:06:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:37 INFO - Successfully installed psutil 13:06:37 INFO - Cleaning up... 13:06:37 INFO - Return code: 0 13:06:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:37 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:37 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 13:06:37 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 13:06:37 INFO - Using env: {'DISPLAY': ':0', 13:06:37 INFO - 'HOME': '/home/cltbld', 13:06:37 INFO - 'LANG': 'en_US.UTF-8', 13:06:37 INFO - 'LANGUAGE': 'en_US:en', 13:06:37 INFO - 'LOGNAME': 'cltbld', 13:06:37 INFO - 'MAIL': '/var/mail/cltbld', 13:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:37 INFO - 'MOZ_NO_REMOTE': '1', 13:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:37 INFO - 'NO_EM_RESTART': '1', 13:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:37 INFO - 'PWD': '/builds/slave/test', 13:06:37 INFO - 'SHELL': '/bin/bash', 13:06:37 INFO - 'SHLVL': '1', 13:06:37 INFO - 'TERM': 'linux', 13:06:37 INFO - 'TMOUT': '86400', 13:06:37 INFO - 'USER': 'cltbld', 13:06:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:37 INFO - '_': '/tools/buildbot/bin/python'} 13:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:06:40 INFO - Installing collected packages: mozsystemmonitor 13:06:40 INFO - Running setup.py install for mozsystemmonitor 13:06:40 INFO - Successfully installed mozsystemmonitor 13:06:40 INFO - Cleaning up... 13:06:40 INFO - Return code: 0 13:06:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:40 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:40 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 13:06:40 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 13:06:40 INFO - Using env: {'DISPLAY': ':0', 13:06:40 INFO - 'HOME': '/home/cltbld', 13:06:40 INFO - 'LANG': 'en_US.UTF-8', 13:06:40 INFO - 'LANGUAGE': 'en_US:en', 13:06:40 INFO - 'LOGNAME': 'cltbld', 13:06:40 INFO - 'MAIL': '/var/mail/cltbld', 13:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:40 INFO - 'MOZ_NO_REMOTE': '1', 13:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:40 INFO - 'NO_EM_RESTART': '1', 13:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:40 INFO - 'PWD': '/builds/slave/test', 13:06:40 INFO - 'SHELL': '/bin/bash', 13:06:40 INFO - 'SHLVL': '1', 13:06:40 INFO - 'TERM': 'linux', 13:06:40 INFO - 'TMOUT': '86400', 13:06:40 INFO - 'USER': 'cltbld', 13:06:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:40 INFO - '_': '/tools/buildbot/bin/python'} 13:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:40 INFO - Downloading/unpacking blobuploader==1.2.4 13:06:40 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 13:06:40 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 13:06:40 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 13:06:40 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 13:06:40 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 13:06:40 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 13:06:42 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:06:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:42 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 13:06:43 INFO - Downloading docopt-0.6.1.tar.gz 13:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:43 INFO - Running setup.py install for blobuploader 13:06:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:06:43 INFO - Running setup.py install for requests 13:06:43 INFO - Running setup.py install for docopt 13:06:43 INFO - Successfully installed blobuploader requests docopt 13:06:43 INFO - Cleaning up... 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:43 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')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:43 INFO - Running setup.py (path:/tmp/pip-RQ1ZYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:43 INFO - Running setup.py (path:/tmp/pip-y8_uN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:44 INFO - Running setup.py (path:/tmp/pip-qVHa0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:44 INFO - Running setup.py (path:/tmp/pip-0Bz8K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:44 INFO - Running setup.py (path:/tmp/pip-3s3Si7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:44 INFO - Running setup.py (path:/tmp/pip-7ZSGpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:44 INFO - Running setup.py (path:/tmp/pip-UrQXBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:44 INFO - Running setup.py (path:/tmp/pip-9a2LiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:44 INFO - Running setup.py (path:/tmp/pip-9mIspx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:44 INFO - Running setup.py (path:/tmp/pip-crHnDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:44 INFO - Running setup.py (path:/tmp/pip-FAXT1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:44 INFO - Running setup.py (path:/tmp/pip-cVolki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:44 INFO - Running setup.py (path:/tmp/pip-FeqAXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:44 INFO - Running setup.py (path:/tmp/pip-KH8Lpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:44 INFO - Running setup.py (path:/tmp/pip-UFq7WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:44 INFO - Running setup.py (path:/tmp/pip-y0iED8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:45 INFO - Running setup.py (path:/tmp/pip-l58vyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:45 INFO - Running setup.py install for manifestparser 13:06:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozcrash 13:06:45 INFO - Running setup.py install for mozdebug 13:06:45 INFO - Running setup.py install for mozdevice 13:06:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozfile 13:06:45 INFO - Running setup.py install for mozhttpd 13:06:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozinfo 13:06:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozInstall 13:06:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozleak 13:06:46 INFO - Running setup.py install for mozlog 13:06:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Running setup.py install for moznetwork 13:06:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Running setup.py install for mozprocess 13:06:46 INFO - Running setup.py install for mozprofile 13:06:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Running setup.py install for mozrunner 13:06:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Running setup.py install for mozscreenshot 13:06:46 INFO - Running setup.py install for moztest 13:06:46 INFO - Running setup.py install for mozversion 13:06:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:46 INFO - Cleaning up... 13:06:46 INFO - Return code: 0 13:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:46 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 13:06:46 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 13:06:46 INFO - Using env: {'DISPLAY': ':0', 13:06:46 INFO - 'HOME': '/home/cltbld', 13:06:46 INFO - 'LANG': 'en_US.UTF-8', 13:06:46 INFO - 'LANGUAGE': 'en_US:en', 13:06:46 INFO - 'LOGNAME': 'cltbld', 13:06:46 INFO - 'MAIL': '/var/mail/cltbld', 13:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:46 INFO - 'MOZ_NO_REMOTE': '1', 13:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:46 INFO - 'NO_EM_RESTART': '1', 13:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:46 INFO - 'PWD': '/builds/slave/test', 13:06:46 INFO - 'SHELL': '/bin/bash', 13:06:46 INFO - 'SHLVL': '1', 13:06:46 INFO - 'TERM': 'linux', 13:06:46 INFO - 'TMOUT': '86400', 13:06:46 INFO - 'USER': 'cltbld', 13:06:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:46 INFO - '_': '/tools/buildbot/bin/python'} 13:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:47 INFO - Running setup.py (path:/tmp/pip-gzPEQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:47 INFO - Running setup.py (path:/tmp/pip-P5lluy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:47 INFO - Running setup.py (path:/tmp/pip-8JLq0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:47 INFO - Running setup.py (path:/tmp/pip-LIJlAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:47 INFO - Running setup.py (path:/tmp/pip-As36ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:47 INFO - Running setup.py (path:/tmp/pip-qqJ1yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:47 INFO - Running setup.py (path:/tmp/pip-Av9dJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:47 INFO - Running setup.py (path:/tmp/pip-vUgkkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:47 INFO - Running setup.py (path:/tmp/pip-CQUjcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:47 INFO - Running setup.py (path:/tmp/pip-zV3z5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:47 INFO - Running setup.py (path:/tmp/pip-y0gw7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:47 INFO - Running setup.py (path:/tmp/pip-jIvfka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:48 INFO - Running setup.py (path:/tmp/pip-3AqMDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:48 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)) 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:48 INFO - Running setup.py (path:/tmp/pip-x3g7Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:48 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)) 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:48 INFO - Running setup.py (path:/tmp/pip-wPfrmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:48 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)) 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:48 INFO - Running setup.py (path:/tmp/pip-S9ZASU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:48 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)) 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:48 INFO - Running setup.py (path:/tmp/pip-vvQulI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:48 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)) 13:06:48 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)) 13:06:48 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)) 13:06:48 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)) 13:06:48 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)) 13:06:48 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)) 13:06:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:50 INFO - Downloading blessings-1.6.tar.gz 13:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:50 INFO - Installing collected packages: blessings 13:06:50 INFO - Running setup.py install for blessings 13:06:50 INFO - Successfully installed blessings 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:50 INFO - Reading from file tmpfile_stdout 13:06:50 INFO - Current package versions: 13:06:50 INFO - argparse == 1.2.1 13:06:50 INFO - blessings == 1.6 13:06:50 INFO - blobuploader == 1.2.4 13:06:50 INFO - docopt == 0.6.1 13:06:50 INFO - manifestparser == 1.1 13:06:50 INFO - mozInstall == 1.12 13:06:50 INFO - mozcrash == 0.17 13:06:50 INFO - mozdebug == 0.1 13:06:50 INFO - mozdevice == 0.48 13:06:50 INFO - mozfile == 1.2 13:06:50 INFO - mozhttpd == 0.7 13:06:50 INFO - mozinfo == 0.9 13:06:50 INFO - mozleak == 0.1 13:06:50 INFO - mozlog == 3.2 13:06:50 INFO - moznetwork == 0.27 13:06:50 INFO - mozprocess == 0.22 13:06:50 INFO - mozprofile == 0.28 13:06:50 INFO - mozrunner == 6.11 13:06:50 INFO - mozscreenshot == 0.1 13:06:50 INFO - mozsystemmonitor == 0.3 13:06:50 INFO - moztest == 0.7 13:06:50 INFO - mozversion == 1.4 13:06:50 INFO - psutil == 3.1.1 13:06:50 INFO - requests == 1.2.3 13:06:50 INFO - wsgiref == 0.1.2 13:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:50 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')]} 13:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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')]} 13:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:50 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 13:06:50 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 13:06:50 INFO - Using env: {'DISPLAY': ':0', 13:06:50 INFO - 'HOME': '/home/cltbld', 13:06:50 INFO - 'LANG': 'en_US.UTF-8', 13:06:50 INFO - 'LANGUAGE': 'en_US:en', 13:06:50 INFO - 'LOGNAME': 'cltbld', 13:06:50 INFO - 'MAIL': '/var/mail/cltbld', 13:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:50 INFO - 'MOZ_NO_REMOTE': '1', 13:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:50 INFO - 'NO_EM_RESTART': '1', 13:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:50 INFO - 'PWD': '/builds/slave/test', 13:06:50 INFO - 'SHELL': '/bin/bash', 13:06:50 INFO - 'SHLVL': '1', 13:06:50 INFO - 'TERM': 'linux', 13:06:50 INFO - 'TMOUT': '86400', 13:06:50 INFO - 'USER': 'cltbld', 13:06:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:50 INFO - '_': '/tools/buildbot/bin/python'} 13:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 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)) 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06:50 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')]} 13:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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')]} 13:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:50 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 13:06:50 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 13:06:50 INFO - Using env: {'DISPLAY': ':0', 13:06:50 INFO - 'HOME': '/home/cltbld', 13:06:50 INFO - 'LANG': 'en_US.UTF-8', 13:06:50 INFO - 'LANGUAGE': 'en_US:en', 13:06:50 INFO - 'LOGNAME': 'cltbld', 13:06:50 INFO - 'MAIL': '/var/mail/cltbld', 13:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:50 INFO - 'MOZ_NO_REMOTE': '1', 13:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:50 INFO - 'NO_EM_RESTART': '1', 13:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:50 INFO - 'PWD': '/builds/slave/test', 13:06:50 INFO - 'SHELL': '/bin/bash', 13:06:50 INFO - 'SHLVL': '1', 13:06:50 INFO - 'TERM': 'linux', 13:06:50 INFO - 'TMOUT': '86400', 13:06:50 INFO - 'USER': 'cltbld', 13:06:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:50 INFO - '_': '/tools/buildbot/bin/python'} 13:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:51 INFO - Downloading/unpacking jsonschema 13:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:06:52 INFO - Downloading/unpacking functools32 (from jsonschema) 13:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:06:53 INFO - warning: no files found matching '*.txt' 13:06:53 INFO - no previously-included directories found matching 'build' 13:06:53 INFO - no previously-included directories found matching 'dist' 13:06:53 INFO - no previously-included directories found matching '.git*' 13:06:53 INFO - Installing collected packages: jsonschema, functools32 13:06:53 INFO - Running setup.py install for functools32 13:06:53 INFO - warning: no files found matching '*.txt' 13:06:53 INFO - no previously-included directories found matching 'build' 13:06:53 INFO - no previously-included directories found matching 'dist' 13:06:53 INFO - no previously-included directories found matching '.git*' 13:06:53 INFO - Successfully installed jsonschema functools32 13:06:53 INFO - Cleaning up... 13:06:53 INFO - Return code: 0 13:06:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:06:53 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')]} 13:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:53 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')]} 13:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:53 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 0x7f1a29e0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', '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 13:06:53 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 13:06:53 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 13:06:53 INFO - Using env: {'DISPLAY': ':0', 13:06:53 INFO - 'HOME': '/home/cltbld', 13:06:53 INFO - 'LANG': 'en_US.UTF-8', 13:06:53 INFO - 'LANGUAGE': 'en_US:en', 13:06:53 INFO - 'LOGNAME': 'cltbld', 13:06:53 INFO - 'MAIL': '/var/mail/cltbld', 13:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:53 INFO - 'MOZ_NO_REMOTE': '1', 13:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:53 INFO - 'NO_EM_RESTART': '1', 13:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:53 INFO - 'PWD': '/builds/slave/test', 13:06:53 INFO - 'SHELL': '/bin/bash', 13:06:53 INFO - 'SHLVL': '1', 13:06:53 INFO - 'TERM': 'linux', 13:06:53 INFO - 'TMOUT': '86400', 13:06:53 INFO - 'USER': 'cltbld', 13:06:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:53 INFO - '_': '/tools/buildbot/bin/python'} 13:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:53 INFO - Downloading/unpacking flake8 13:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:06:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:06:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:06:56 INFO - no previously-included directories found matching 'docs/_build' 13:06:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:06:56 INFO - Running setup.py install for pep8 13:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:06:56 INFO - no previously-included directories found matching 'docs/_build' 13:06:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:06:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:06:56 INFO - Cleaning up... 13:06:56 INFO - Return code: 0 13:06:56 INFO - Running post-action listener: _resource_record_post_action 13:06:56 INFO - Running post-action listener: _start_resource_monitoring 13:06:56 INFO - Starting resource monitoring. 13:06:56 INFO - ##### 13:06:56 INFO - ##### Finished create-virtualenv step (success) 13:06:56 INFO - ##### 13:06:56 INFO - ##### 13:06:56 INFO - ##### Running install step. 13:06:56 INFO - ##### 13:06:56 INFO - Running pre-action listener: _resource_record_pre_action 13:06:56 INFO - Running main action method: install 13:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:56 INFO - Reading from file tmpfile_stdout 13:06:56 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:56 INFO - Reading from file tmpfile_stdout 13:06:56 INFO - Output received: 13:06:56 INFO - Usage: mozinstall [options] installer 13:06:56 INFO - Options: 13:06:56 INFO - -h, --help show this help message and exit 13:06:56 INFO - -d DEST, --destination=DEST 13:06:56 INFO - Directory to install application into. [default: 13:06:56 INFO - "/builds/slave/test"] 13:06:56 INFO - --app=APP Application being installed. [default: firefox] 13:06:57 INFO - mkdir: /builds/slave/test/build/application 13:06:57 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'] 13:06:57 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 13:07:13 INFO - Reading from file tmpfile_stdout 13:07:13 INFO - Output received: 13:07:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:07:13 INFO - Running post-action listener: _resource_record_post_action 13:07:13 INFO - ##### 13:07:13 INFO - ##### Finished install step (success) 13:07:13 INFO - ##### 13:07:13 INFO - ##### 13:07:13 INFO - ##### Running run-tests step. 13:07:13 INFO - ##### 13:07:13 INFO - Running pre-action listener: _resource_record_pre_action 13:07:13 INFO - Running main action method: run_tests 13:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:13 INFO - Python 2.7.3 13:07:13 INFO - Return code: 0 13:07:13 INFO - grabbing minidump binary from tooltool 13:07: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')]} 13:07:13 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 0x1cbe9c0>, '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 0x1cbf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:13 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 13:07:13 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 13:07:13 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 13:07:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:13 INFO - Return code: 0 13:07:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:07:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:07:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:07:14 INFO - Return code: 0 13:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 13:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 13:07:14 INFO - Using env: {'DISPLAY': ':0', 13:07:14 INFO - 'HOME': '/home/cltbld', 13:07:14 INFO - 'LANG': 'en_US.UTF-8', 13:07:14 INFO - 'LANGUAGE': 'en_US:en', 13:07:14 INFO - 'LOGNAME': 'cltbld', 13:07:14 INFO - 'MAIL': '/var/mail/cltbld', 13:07:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:14 INFO - 'MOZ_NO_REMOTE': '1', 13:07:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:14 INFO - 'NO_EM_RESTART': '1', 13:07:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:14 INFO - 'PWD': '/builds/slave/test', 13:07:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:14 INFO - 'SHELL': '/bin/bash', 13:07:14 INFO - 'SHLVL': '1', 13:07:14 INFO - 'TERM': 'linux', 13:07:14 INFO - 'TMOUT': '86400', 13:07:14 INFO - 'USER': 'cltbld', 13:07:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025', 13:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:14 INFO - '_': '/tools/buildbot/bin/python'} 13:07:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 13:07:14 INFO - mozversion application_buildid: 20160527115136 13:07:14 INFO - mozversion application_changeset: a41a34f7d93659363d352eaad705d4da6d8f465c 13:07:14 INFO - mozversion application_display_name: Nightly 13:07:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:14 INFO - mozversion application_name: Firefox 13:07:14 INFO - mozversion application_remotingname: firefox 13:07:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:07:14 INFO - mozversion application_vendor: Mozilla 13:07:14 INFO - mozversion application_version: 49.0a1 13:07:14 INFO - mozversion platform_buildid: 20160527115136 13:07:14 INFO - mozversion platform_changeset: a41a34f7d93659363d352eaad705d4da6d8f465c 13:07:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:07:14 INFO - mozversion platform_version: 49.0a1 13:07:14 INFO - using testdate: 1464379634 13:07:14 INFO - actual date: 1464379634 13:07:14 INFO - starting webserver on 'localhost:50560' 13:07:14 INFO - SUITE-START | Running 2 tests 13:07:14 INFO - TEST-START | dromaeo_css 13:07:14 INFO - operating with platform_type : linux_ 13:07:14 INFO - Initialising browser for dromaeo_css test... 13:07:14 INFO - TEST-INFO | started process 22475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO47WY/profile http://localhost:50560/getInfo.html) 13:07:18 INFO - PROCESS | 22475 | __metrics Screen width/height:1600/1200 13:07:18 INFO - PROCESS | 22475 | colorDepth:24 13:07:18 INFO - PROCESS | 22475 | Browser inner width/height: 1024/697 13:07:18 INFO - PROCESS | 22475 | __metrics 13:07:20 ERROR - PROCESS | 22475 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:07:20 INFO - TEST-INFO | 22475: exit 0 13:07:20 INFO - Browser initialized. 13:07:20 INFO - Running cycle 1/1 for dromaeo_css test... 13:07:20 INFO - TEST-INFO | started process 22557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO47WY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:32 INFO - PROCESS | 22557 | RSS: Main: 157261824 13:07:32 INFO - PROCESS | 22557 | 13:08:24 INFO - PROCESS | 22557 | 1464379704541 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] 13:10:36 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50560/tests/dromaeo/cssquery-ext.html) 13:10:37 INFO - PROCESS | 22557 | RSS: Main: 270102528 13:10:37 INFO - PROCESS | 22557 | 13:13:40 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-ext.html (next: http://localhost:50560/tests/dromaeo/cssquery-jquery.html) 13:13:40 INFO - PROCESS | 22557 | RSS: Main: 240021504 13:13:40 INFO - PROCESS | 22557 | 13:16:42 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50560/tests/dromaeo/cssquery-mootools.html) 13:16:43 INFO - PROCESS | 22557 | RSS: Main: 234438656 13:16:43 INFO - PROCESS | 22557 | 13:19:45 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50560/tests/dromaeo/cssquery-prototype.html) 13:19:46 INFO - PROCESS | 22557 | RSS: Main: 237023232 13:19:46 INFO - PROCESS | 22557 | 13:22:49 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50560/tests/dromaeo/cssquery-yui.html) 13:22:49 INFO - PROCESS | 22557 | RSS: Main: 214999040 13:22:49 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-yui.html (next: http://localhost:50560/tests/dromaeo/cssquery-dojo.html) 13:25:52 INFO - PROCESS | 22557 | RSS: Main: 288366592 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | __start_tp_report 13:25:52 INFO - PROCESS | 22557 | _x_x_mozilla_page_load 13:25:52 INFO - PROCESS | 22557 | _x_x_mozilla_page_load_details 13:25:52 INFO - PROCESS | 22557 | |i|pagename|runs| 13:25:52 INFO - PROCESS | 22557 | |0;dojo.html;2718.660167479065;2729.34495721027;2734.8359098454093;2750.6286651302066;2777.47228026675;4769.8807529811775;4813.68711033783;4868.805247790084;4903.55867971882;4942.40691117066;4784.40194975628;4801.567858892699;4818.036392721452;4846.757662116897;4854.077725232212;4381.167578160147;4430.734155950637;4437.666337729137;4496.64026877849;4575.084983003396;4508.176251410991;4523.7285762854335;4530.773461326937;4563.7489938053395;4579;4388.736675799462;4411.09572537629;4415.183191109655;4444.422225110748;4470.552944705536;4428.31361139024;4431.7119387240045;4440.800163992628;4482.910341793146;4503.234450143484;4452.042810795694;4452.532484089189;4455.420795296591;4507.684462087655;4509.436320459942;4650.837220697294;4687.859364219079;4765.285207218945;4774.427068751737;4780.306855505967;5231.189165679326;5269.314989051437;5273.551748101416;5285.497877701612;5285.603579731535;5248.81629142982;5282.97358513205;5318.813841515567;5319.069162896478;5319.069162896516;4747.192977193851;4795.664303498722;4874.147024270738;4884.926726099111;4943.65394422387;5375.328083989423;5406.107992181246;5406.675599464044;5413.810516631899;5416.83749487516;5071.746412679351;5190.480951904855;5191.428942816363;5193.480651934777;5197.246399272084;5172.146595811724;5226.843194704165;5236.266922630834;5297.470252974672;5301.655392399482;5159.948400515947;5170.767315470813;5171.991461664939;5174.120399532088;5176.792928282902;5201.167813149954;5201.895962080737;5205.869853253699;5210.452902445264;5238.528532432099;4334.5882141196535;4389.078293558325;4392.099619578043;4450.132224216311;4470.2177119004045;3877.922441551153;3886.2227554489214;3895.435161901565;3918.2359439908946;3982.9203415932097;4493.550644935481;4509.346144808985;4516.16450956574;4553.658475614276;4555.544445555418;4988.925166122511;5076.949230507722;5117.334746482933;5269.077911365495;5288.206768984683;4418.293073108287;4427.291633338715;4444.688871778944;4475.462944446687;4481.529439408815;4660.974585591164;4676.719396836201;4683.15703173432;4685.086408150378;4733.360996265529;4768.117898188846;4840.2255639097575;4872.415310162662;4919.581835544019;4928.802847886044;5238.68567885928;5251.894962100813;5253.106971814877;5254.264402983662;5260.10578201699;4910;4918.901621967612;4922.606191504743;4923.236898280772;4956.529129732669;4997.625178111583;5118.155504341742;5146.073706732824;5184.896302074013;5189.143791274549;5228.895422091613;5248.448912864247;5267.236250743697;5269.71016594091;5314.388845282688;4996.875078123076;5098.056859481007;5103.92344114846;5104.464031276811;5108.693478391308;5039.244113383022;5040.395152581567;5044.949550504448;5097.15896877026;5106.540411362995;4973;4984.526469985346;5015.272785446017;5037;5045.672031317952;4950.925736113889;5033.0688822567945;5072.442031376472;5103;5105.846824595268;4977.278294647328;4980.452150263396;5004.174311238605;5012.147934851011;5050.015247026795 13:25:52 INFO - PROCESS | 22557 | |1;ext.html;543.8144844239556;597.6324560395357;603.2549800995771;608.6804427675467;609.704293417692;27257.863710681442;28056.71943280569;30270.848645756796;30304.09087727369;41227.38158927611;39708.40437393434;43755.34366984498;43798;43810.12379752411;43843.56156438435;7754;7898.131205567383;7910.604469776517;7913.960430197841;7927.563983980879;7762.340201082887;7921.168277330884;7940.602969851513;7942.523448593074;7953.164917683618;7917.643706033214;7967.641456134459;7973.840523189533;7975.042994840627;7977.960110199469;7900.565468899208;7942.722004729836;7948.721794737215;7950;7954.880676789853;7728.459007869451;7800;7803.804904877366;7809.062912450542;7811.609419529001;38971;39364.80317598422;39411.40882886759;39412.21175576472;39459.40810887839;3049.7255247027874;3129.4992801151707;3216.3406501667337;3307.6030876295;3579.355715971124;28712.712872871212;29453.55819662707;29738.508284811865;29754.256143596365;29922.251943701365;3364.512145738854;3417.40195465795;3441.4149594568985;3475.1138459692615;3481.6344283850085;260801;261311;261964.9999999981;262244;262841;53251.467485325426;53589.196162057604;53634;53666;53777.462225378025;34004.48993265103;35126.29747405038;35203;35966.820165899524;36006.099847504025;13463.326833658473;13550.051496395157;13586;13595.116317439335;13602.523911663044;9916.206703463706;9923.156531694742;9991.100800927952;9999.35004224723;10000.699979000641;19256;19268.4219473416;19278.903605482163;19279.132439040277;19305.710414343797;6984.825379365557;7045.859082818315;7117.3238542338395;7159.140903091558;7339.183624515223;705.2242533213424;824.7608193623902;844.345632135088;911.2482202183226;961.5576834655997;26660.333491662477;27538.724612754017;27712.722872771013;28088.43823123567;28100.578491322645;751.6317004667674;919.8482250428605;935.242453612576;1000.559753708366;1002.8896821349646;13798.93100534511;14250.928745356414;14385.352659130363;14548.49080282185;14601.415943362359;387186;388009;389142;389678.8772954331;390700;49910.50089499131;50281;50304;50364;50566.24150637743;1066.0299127793671;1161.4250945781723;1178.116412690482;1184.4314728930162;1191.814144925787;27828.30429239285;30192.69807301899;30273.848630756704;30288;30753.231169220053;45028.32457513074;45600.54399455963;45636.543634563226;45815.54184458113;46054.53945460637;365328;367968;368309;369251;533313;39750.801245993585;40237.39643905402;40476.3928541078;42822.35766463568;42939.785301073294;43651.34522982221;44016.339754904344;44333;44497.77751111224;45112.323315150956;36519.63480365162;37189.25621487609;37532.624673752915;37686.81156594309;38097.80951095227;37118.44322335113;37345.813270933475;38014.80992595019;38195.618043820316;38544.61455385522;36466.27067458583;37236.627633723314;37344.43983340306;37477.81261093677;37546.624533754315;31483.527747083353;33254.83372583122;33459.49810752792;34240.828795855865;34385.484217737256;24613.63079553844;24637.630435543124;24932.75067249377;24955.376115597257;25034.37414064663 13:25:52 INFO - PROCESS | 22557 | |2;jquery.html;374.6852643779226;381.00937562337924;387.370522900287;399.22948708991635;401.2596758979681;15590.610234744137;16795.74806377902;17248.22382992765;17354.132293385326;17354.479365619052;15721.37114515421;16178.676426471464;16800.495985120437;16833;16880.493585192435;4510.503844577094;4680.5085466026085;4701.858944231679;4718.150732868083;4724.196886529281;3468.202313467904;5074.137396642561;5324.627276090675;5375.650582712131;5472.753726082336;5367.490088441592;5427.83716488506;5431.2396264522995;5432.619716619838;5437.483439073281;5100.540951314381;5436.157395603688;5439.836804895859;5483.588730845163;5502.174673798962;3374.088995971074;4897.60819134472;5213.635045546814;5222.451642577513;5281.973590132063;11240.606578769786;11314.321140731583;11491;11495.770084598262;11763.7059073523;1724.1379310344828;1741.8693597980202;1809.6923523001121;1817.9272829086822;1842.207850624231;8797.780055498664;8894.243989260856;9705.320627556073;9978.800423991552;12963.28701921394;1648.9505314840574;1724.4912750738563;1739.7912250529891;1755.2013833705762;1816.0284247927295;64452.355476445104;66714.66642666805;67422.66288668575;67795.66102169506;68765;9431.151196392357;9555.04449555039;9628;9630.759231019141;9929.950350248202;13238.602841914759;13390.397432115384;13403.32983350848;13418.731625367438;13421.865781342061;6569.737210511526;6620.569662971891;6833.3166683331265;6951.826204344932;6992.510524263253;6376;6444.2266927968;6491.837704057436;6545.116409284781;6605.207375115017;4065.837366505307;4104.363823607346;4120.711550191518;4324.416203812508;4487.708298960622;1591.2441590244773;1694.5763559110223;1702.1063941430848;1713.1177443616548;1728.7234042553382;761.3338328962158;837.5602808525573;875.8292133034124;904.2585080234145;905.0135352465712;15927.124008179662;16114.75827862583;16148.111853848151;16537.503874883772;16682.91658541724;827.1934863508031;832.2177153475714;869.9782505437415;876.5310558850985;923.4136323434667;9129.771755706028;9518.286128540387;9535.570899309549;9623;9827.557759900821;371724;372530;375245;380608.484787877;383111;77669;78359;79019.74471479833;79618;79976.60011699905;911.7583840282331;916.3081873185702;916.3814425263054;917.4082716647724;921.6129225725211;15137.167455789597;15229.771553426486;15320.157391343582;15350.385984560493;15531.76702349443;26977.460450791266;33528.329433410705;33953.32093358169;35675;36441.81779091193;46780;49497.50502494929;49546.50453495563;49664.25503617521;49825;7484.850302993801;7552.8867066995135;7643.9617801912855;7647.235276472308;7764.107127680389;10752.569897204025;11574.594889178838;11743.41282935867;11764;11945.104117191071;9002.954985225031;9208.49353285549;9329.48687822149;9385.202257808163;9606.567704453177;9500.287478439006;9557.569909354235;9659.855102173333;10030.899691002996;10425.113865321533;8797.736067917973;9206.861897071416;9508.619655213713;9535.666251681158;9681.70954871355;7437.814054648461;7497;7614;7661.693532258871;7687.5387476751575;8745.693900713444;9043.366964312698;9261.583228754587;9374.625014999596;9501.762455938657 13:25:52 INFO - PROCESS | 22557 | |3;mootools.html;1248.2385744695728;1406.2827957741556;1469.1552357394498;1578.9368823716925;1807.4487281379181;6763.2560418354005;7568.091828980523;7818.491798033124;7831.29518343349;8068.273855353017;7779.33875620573;7816.062072551287;7881.960590197055;7896.526208427498;7902.367810575154;2219.82241420686;2228.320362289501;2232.653938639505;2233.7542870284256;2245.640697488394;2200.251914349121;2227.0312414099917;2245.8989345479495;2248.87631180285;2255.4812393149587;2212.4358288636377;2229.643257078868;2240.6526988316755;2241.9551608967813;2244.9663255051187;2150.709654196679;2168.0677308757226;2173.9891300543554;2174.695542624034;2176.260071575664;2131.8507704460694;2135.508832968426;2139.1122684086085;2146.3882793403804;2149.0758973641327;7559.319661230461;7638.8472230555635;7693.884591731128;7694.769156925301;7695.692172313101;4601.608863246628;4782.593479554242;4798.496157903405;4806.663533552653;4812.109759694467;2882.394697113588;3046.31457921968;3106.6272047354464;3108.9222769430944;3116.2209447638093;926.7683079230193;926.972190834276;932.7341707613298;1030.7474668706216;1043.1133536493996;10616.734581635445;10715.732106697316;10729.034386905138;10742.301750386277;10763.677089687244;4176.310908700091;4212.178625168124;4335.067960388532;4339.848105316299;4362.1493808707;8379.95810020946;8419.789505262417;8422.199891010345;8433.03020152678;8437.156284371637;4671.43942726875;4672.696274742131;4680.53194680536;4681.297805329228;4683.953160468352;3767;3798.810059497014;4291.420658211164;4348.130373925228;4397.978010109993;3439.570053743282;3473.913152171216;3528.3825330567047;3550.183457804719;3565.2512972275595;1024.1857723110145;1030.6959446963165;1032.5043978890176;1039.781645854364;1063.5798859450474;770.6686124966318;865.2904618213005;901.0268909577771;902.472053848506;915.3089417489886;5467.20725494801;5552.500274975271;5569.916451253234;5784.82645520635;5795.357947116942;893.1693525021662;908.100980029779;915.057490784493;915.5879854065697;931.9673811416568;3580.498730177725;3610.5667319921777;3891.1439483313625;3907.9609203908167;3916.784576848244;9164.76275702785;9390.107939745712;9427.836740367184;9507.57215925285;9539.570719317648;9253.352265341497;9341.90658093424;9359.62561497546;9445.433274003582;9448.858267126;6770.93229067703;7070.116235470567;7075;7231.7107315707835;7279.708811647475;5430.782768689366;5684.602077854676;5772.624779389326;5876.764929402776;5945;8730.91269087301;8873.600687969187;9170.266378689823;9199.218066464426;9258.35191536586;9022.14289642483;9276.25789936817;9284.442933424016;9461.858072129062;9469.857952130586;6159.414855588712;6342.048692696132;6349.841253968688;6357.523185761179;6514;7699.076110866732;7815.53106813593;7817.5309481431295;7819.335356494534;7822.178671239665;6974.965125174342;7015.298470153148;7017.543859649107;7032.2264550898335;7103.715851365888;6866.279040700654;6886.2769409213315;6937.687804048729;6944.305569443015;7038.155421349471;6580.934190658224;6582.76960306387;6653.700583473658;6681.5656982296;6725.125733654593;4743.667943244078;4818.349522814376;4821.7589120544535;4866.562009419169;4895.853124406273;4716.905661886674;4744.620430365631;4804.615630749462;4876.707397556158;4888.095702295087 13:25:52 INFO - PROCESS | 22557 | |4;prototype.html;304.6116201842652;309.77696058837637;312.37057329481115;313.64244760972497;313.96389415217254;4745.169595320818;4752;4764.547368000043;4777.952220477794;4800.039992001605;4684.360473834156;4711.20974029869;4728.1962066448705;4728.763561821912;4729.699332683505;3562.643735626436;3680.914130331545;3720.456010755533;3764.5294338207723;3822.197338558906;3750.4374343848367;3772.924541509168;3778.754380965242;3793.6858516305033;3795.905102372435;3603.6036036036016;3753.380692185786;3766.5480142382817;3774.433834924756;3776.2636285924254;3611.1513794258326;3717.237966216919;3720.9627903721157;3721.776693398391;3750.549934007909;3264.722498587623;3281.146901805524;3282.8522716477814;3290.226796702797;3298.505224216363;4559.430071241095;4562.6121779648765;4567.748773817439;4567.931481027754;4605.631549476067;4077.184563087365;4227.387028880795;4253.532111467736;4296.785160741982;4307.418498502725;4931;4964.106460837048;4973.35346404965;4984.725840078794;5002.674826136289;3610.6028336882923;3650.9594765491706;3655.8354874030733;3657.817109144532;3670.6696397324367;5017.34774479319;5209.661372010807;5221.373435187764;5238.240455134022;5242.7378631068295;3745.8688945886765;3785.8296376663116;3791.9431208531896;3793.6585707286476;3796.52543432071;3788.2234142000825;3797.6771974381936;3807.2956503047026;3811.180596171781;3819.159784847385;4302.333138363559;4303.612674859215;4319.611234988866;4323.502797178302;4336.1978034063795;4802.975985120122;5014.623903207201;5033.471485494044;5039.44566097729;5049.293098966147;1294.6828027133413;1307.2875282970804;1312.4775260697736;1317.789153735417;1317.9209247445183;865.891658676882;871.146276648875;876.5310558850985;893.7050773244814;897.2597606974273;4395.164918665443;4396.164728701537;4397.934030989538;4429.9778501107285;4444.177827101997;5063.544281014726;5066.289535098778;5084.618653600921;5088.440271570124;5113.488651134857;4258.914821703549;4374.27824408969;4387.956120438755;4410.7725598572515;4427.557244275611;2691.663542057243;2707.6615423072117;2717.3070866928806;2721.71422000691;2732.7540521353176;4757.476677565465;4758.095961767253;4797.808087676453;4799.136155492045;4799.784009719571;5037.823676171316;5189.273501709764;5212.973935130376;5217;5232.096186616464;4774.594159496482;4791.664583479123;4803.495632958559;4805.663603547788;4816.362436771515;5074.517920797518;5084.669496482717;5086.6439349246675;5101.158308878993;5112.948870511247;4766.165920963748;5011.123053465702;5021.824236151717;5037.924431133462;5039.21892106724;4748.480486244369;4760.857174284777;4794.113089078532;4803.927941080957;4811.975940120277;3726.7763934164036;3745.2509498099944;3767.9623203768706;3776.981115094517;3777.1501412182038;4903.411590609007;5055.418626857959;5069.822556210515;5140.537351638371;5209.6092793041435;4985.651004429655;4988.351514303117;5002.924956125734;5026.346574945233;5038.823641172541;4979.327790748347;5003.374578177728;5036.622253331088;5052.267421223975;5066.290719299374;4825.469198388245;4959.156943319572;4968.180250258667;4974.825881094144;4990.827155618499;4853.635977301646;4967.552920237196;5045.470225626404;5059.291699162047;5068.29043933857;4907.460179380337;4938.481459446706;4938.851834444972;4966.850994470172;4989.203886600748 13:25:52 INFO - PROCESS | 22557 | |5;yui.html;614.0942110387176;647.8736646353962;685.6914388525162;689.8654762321349;696.8884978403455;11782.528698852046;11835.053195744342;11867.287962722232;11893.643190704272;11958.282503049812;10834.945825270863;10837.078848297904;10888.183386246024;12900.419481123348;13400.262985535792;622.1538707358012;642.5887432043496;814.7474282972267;818.9140140285274;820.6307161777224;792.3859009267806;815.6737305077957;816.4978538198994;820.5609998650723;822.4941660878576;839.7102999465175;843.6583183810567;843.8354520868434;844.1684940333766;844.3793811548506;660.3693472733528;827.3505298340834;832.5629044751494;833.4957350802767;851.1020872979004;596.7523477756769;601.3955974245898;601.8344955137328;602.7408214467821;604.437872778316;12490.937545312307;12523.686907827378;12527.43626536808;12535.623931282076;12541.749165016648;12788.360581970865;13114.672133196651;13210.735785284336;13265.668358291023;13340.332983350794;9966.900330996743;9991.450470224136;10126.896127659782;10190.388576685422;10197.439140847251;3173.587433633636;3264.983675081633;3320.286138480238;3344.2141096842224;3446.138465383654;46060.3090953636;47733.284000740015;47758.283625745644;47949.04101917977;48580;10489.737756555995;10498.527566259536;10560.2079844012;10605.84091238632;10817.242793004414;18101;18134.90932545355;18231.635367292845;18262.726059109125;18266.452006439828;6460.773872914426;6705.932940670628;6792.498076558004;6928.203256625452;7117.252688467636;3773.7735735855936;3780.8676696315497;3811.504504414464;3827.27281816454;3853.9229215416094;2914.88340466379;3010.834404107751;3011.593434886306;3012.5481177823062;3015.4873671475902;522.9764660590282;535.5126834580514;537.9327584051994;547.9315085614298;548.5885585810641;474.4638558429022;633.8954072578065;652.1749986267375;660.2143449295419;664.9434798042124;7829.491083079582;7915.604219788987;7963.243491868263;8245.093039765621;8300.501969881827;630.3192552043781;643.1446176585224;644.8258970078147;646.775093677747;653.8659574787157;3622.673959343619;3630.6006339303185;3704.592494825567;3815.561210460777;3854.69162467002;53694.73152634212;56950.715246423504;57836;58022.7098864503;58134.4186558129;50147;50559.241611375124;50801;50851.237231441555;53142;45528;45780;45794.771026145325;45837.31244031276;46217.7689111559;6751.797446076625;6794.150731158606;6874.243833178246;6918.481113916376;6987.545809522365;27497.31256718598;28204.15387538377;28906.132816015554;31612;31944.201394965312;40250.9937251571;40700.59299406968;40943.7952810246;41430.585694142675;41517.58482415258;10769.407682577534;10900.618478353219;11063.225574209728;11157.888421115686;11308.208425410143;12243.75512489763;12412.937935310627;12563.87436125627;12583.496660133493;12643.683907902376;7412.518186317872;10241.74395640115;11003.449827508432;11040.779184416428;11487.081033517466;11111.333320000826;11158.609448669258;11373.090152787923;11562.826557601811;11562.970108003046;10885.346879187275;11187;11254.155938304824;11632.243904146204;11686.649400517997;9205.125513076247;9660.073362584992;9725.756856078655;9770.85343719859;9895;10044.698659040241;10077.395356278646;10138.49307534635;10199.643012494527;10214.744631384276 13:25:52 INFO - PROCESS | 22557 | __end_tp_report 13:25:52 INFO - PROCESS | 22557 | __start_cc_report 13:25:52 INFO - PROCESS | 22557 | _x_x_mozilla_cycle_collect,1092 13:25:52 INFO - PROCESS | 22557 | __end_cc_report 13:25:52 INFO - PROCESS | 22557 | __startTimestamp1464380752849__endTimestamp 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | ------- Summary: start ------- 13:25:52 INFO - PROCESS | 22557 | Number of tests: 6 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#0] dojo.html Cycles:165 Average:4815.77 Median:4942.41 stddev:507.27 (10.3%) stddev-sans-first:481.41 13:25:52 INFO - PROCESS | 22557 | Values: 2718.7 2729.3 2734.8 2750.6 2777.5 4769.9 4813.7 4868.8 4903.6 4942.4 4784.4 4801.6 4818.0 4846.8 4854.1 4381.2 4430.7 4437.7 4496.6 4575.1 4508.2 4523.7 4530.8 4563.7 4579.0 4388.7 4411.1 4415.2 4444.4 4470.6 4428.3 4431.7 4440.8 4482.9 4503.2 4452.0 4452.5 4455.4 4507.7 4509.4 4650.8 4687.9 4765.3 4774.4 4780.3 5231.2 5269.3 5273.6 5285.5 5285.6 5248.8 5283.0 5318.8 5319.1 5319.1 4747.2 4795.7 4874.1 4884.9 4943.7 5375.3 5406.1 5406.7 5413.8 5416.8 5071.7 5190.5 5191.4 5193.5 5197.2 5172.1 5226.8 5236.3 5297.5 5301.7 5159.9 5170.8 5172.0 5174.1 5176.8 5201.2 5201.9 5205.9 5210.5 5238.5 4334.6 4389.1 4392.1 4450.1 4470.2 3877.9 3886.2 3895.4 3918.2 3982.9 4493.6 4509.3 4516.2 4553.7 4555.5 4988.9 5076.9 5117.3 5269.1 5288.2 4418.3 4427.3 4444.7 4475.5 4481.5 4661.0 4676.7 4683.2 4685.1 4733.4 4768.1 4840.2 4872.4 4919.6 4928.8 5238.7 5251.9 5253.1 5254.3 5260.1 4910.0 4918.9 4922.6 4923.2 4956.5 4997.6 5118.2 5146.1 5184.9 5189.1 5228.9 5248.4 5267.2 5269.7 5314.4 4996.9 5098.1 5103.9 5104.5 5108.7 5039.2 5040.4 5044.9 5097.2 5106.5 4973.0 4984.5 5015.3 5037.0 5045.7 4950.9 5033.1 5072.4 5103.0 5105.8 4977.3 4980.5 5004.2 5012.1 5050.0 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#1] ext.html Cycles:180 Average:50201.96 Median:212865.31 stddev:94645.83 (44.5%) stddev-sans-first:94837.90 13:25:52 INFO - PROCESS | 22557 | Values: 543.8 597.6 603.3 608.7 609.7 27257.9 28056.7 30270.8 30304.1 41227.4 39708.4 43755.3 43798.0 43810.1 43843.6 7754.0 7898.1 7910.6 7914.0 7927.6 7762.3 7921.2 7940.6 7942.5 7953.2 7917.6 7967.6 7973.8 7975.0 7978.0 7900.6 7942.7 7948.7 7950.0 7954.9 7728.5 7800.0 7803.8 7809.1 7811.6 38971.0 39364.8 39411.4 39412.2 39459.4 3049.7 3129.5 3216.3 3307.6 3579.4 28712.7 29453.6 29738.5 29754.3 29922.3 3364.5 3417.4 3441.4 3475.1 3481.6 260801.0 261311.0 261965.0 262244.0 262841.0 53251.5 53589.2 53634.0 53666.0 53777.5 34004.5 35126.3 35203.0 35966.8 36006.1 13463.3 13550.1 13586.0 13595.1 13602.5 9916.2 9923.2 9991.1 9999.4 10000.7 19256.0 19268.4 19278.9 19279.1 19305.7 6984.8 7045.9 7117.3 7159.1 7339.2 705.2 824.8 844.3 911.2 961.6 26660.3 27538.7 27712.7 28088.4 28100.6 751.6 919.8 935.2 1000.6 1002.9 13798.9 14250.9 14385.4 14548.5 14601.4 387186.0 388009.0 389142.0 389678.9 390700.0 49910.5 50281.0 50304.0 50364.0 50566.2 1066.0 1161.4 1178.1 1184.4 1191.8 27828.3 30192.7 30273.8 30288.0 30753.2 45028.3 45600.5 45636.5 45815.5 46054.5 365328.0 367968.0 368309.0 369251.0 533313.0 39750.8 40237.4 40476.4 42822.4 42939.8 43651.3 44016.3 44333.0 44497.8 45112.3 36519.6 37189.3 37532.6 37686.8 38097.8 37118.4 37345.8 38014.8 38195.6 38544.6 36466.3 37236.6 37344.4 37477.8 37546.6 31483.5 33254.8 33459.5 34240.8 34385.5 24613.6 24637.6 24932.8 24955.4 25034.4 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#2] jquery.html Cycles:180 Average:23316.23 Median:5303.30 stddev:62326.80 (1175.2%) stddev-sans-first:62477.84 13:25:52 INFO - PROCESS | 22557 | Values: 374.7 381.0 387.4 399.2 401.3 15590.6 16795.7 17248.2 17354.1 17354.5 15721.4 16178.7 16800.5 16833.0 16880.5 4510.5 4680.5 4701.9 4718.2 4724.2 3468.2 5074.1 5324.6 5375.7 5472.8 5367.5 5427.8 5431.2 5432.6 5437.5 5100.5 5436.2 5439.8 5483.6 5502.2 3374.1 4897.6 5213.6 5222.5 5282.0 11240.6 11314.3 11491.0 11495.8 11763.7 1724.1 1741.9 1809.7 1817.9 1842.2 8797.8 8894.2 9705.3 9978.8 12963.3 1649.0 1724.5 1739.8 1755.2 1816.0 64452.4 66714.7 67422.7 67795.7 68765.0 9431.2 9555.0 9628.0 9630.8 9930.0 13238.6 13390.4 13403.3 13418.7 13421.9 6569.7 6620.6 6833.3 6951.8 6992.5 6376.0 6444.2 6491.8 6545.1 6605.2 4065.8 4104.4 4120.7 4324.4 4487.7 1591.2 1694.6 1702.1 1713.1 1728.7 761.3 837.6 875.8 904.3 905.0 15927.1 16114.8 16148.1 16537.5 16682.9 827.2 832.2 870.0 876.5 923.4 9129.8 9518.3 9535.6 9623.0 9827.6 371724.0 372530.0 375245.0 380608.5 383111.0 77669.0 78359.0 79019.7 79618.0 79976.6 911.8 916.3 916.4 917.4 921.6 15137.2 15229.8 15320.2 15350.4 15531.8 26977.5 33528.3 33953.3 35675.0 36441.8 46780.0 49497.5 49546.5 49664.3 49825.0 7484.9 7552.9 7644.0 7647.2 7764.1 10752.6 11574.6 11743.4 11764.0 11945.1 9003.0 9208.5 9329.5 9385.2 9606.6 9500.3 9557.6 9659.9 10030.9 10425.1 8797.7 9206.9 9508.6 9535.7 9681.7 7437.8 7497.0 7614.0 7661.7 7687.5 8745.7 9043.4 9261.6 9374.6 9501.8 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#3] mootools.html Cycles:180 Average:5186.63 Median:5627.26 stddev:2849.21 (50.6%) stddev-sans-first:2841.83 13:25:52 INFO - PROCESS | 22557 | Values: 1248.2 1406.3 1469.2 1578.9 1807.4 6763.3 7568.1 7818.5 7831.3 8068.3 7779.3 7816.1 7882.0 7896.5 7902.4 2219.8 2228.3 2232.7 2233.8 2245.6 2200.3 2227.0 2245.9 2248.9 2255.5 2212.4 2229.6 2240.7 2242.0 2245.0 2150.7 2168.1 2174.0 2174.7 2176.3 2131.9 2135.5 2139.1 2146.4 2149.1 7559.3 7638.8 7693.9 7694.8 7695.7 4601.6 4782.6 4798.5 4806.7 4812.1 2882.4 3046.3 3106.6 3108.9 3116.2 926.8 927.0 932.7 1030.7 1043.1 10616.7 10715.7 10729.0 10742.3 10763.7 4176.3 4212.2 4335.1 4339.8 4362.1 8380.0 8419.8 8422.2 8433.0 8437.2 4671.4 4672.7 4680.5 4681.3 4684.0 3767.0 3798.8 4291.4 4348.1 4398.0 3439.6 3473.9 3528.4 3550.2 3565.3 1024.2 1030.7 1032.5 1039.8 1063.6 770.7 865.3 901.0 902.5 915.3 5467.2 5552.5 5569.9 5784.8 5795.4 893.2 908.1 915.1 915.6 932.0 3580.5 3610.6 3891.1 3908.0 3916.8 9164.8 9390.1 9427.8 9507.6 9539.6 9253.4 9341.9 9359.6 9445.4 9448.9 6770.9 7070.1 7075.0 7231.7 7279.7 5430.8 5684.6 5772.6 5876.8 5945.0 8730.9 8873.6 9170.3 9199.2 9258.4 9022.1 9276.3 9284.4 9461.9 9469.9 6159.4 6342.0 6349.8 6357.5 6514.0 7699.1 7815.5 7817.5 7819.3 7822.2 6975.0 7015.3 7017.5 7032.2 7103.7 6866.3 6886.3 6937.7 6944.3 7038.2 6580.9 6582.8 6653.7 6681.6 6725.1 4743.7 4818.3 4821.8 4866.6 4895.9 4716.9 4744.6 4804.6 4876.7 4888.1 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#4] prototype.html Cycles:180 Average:4157.06 Median:4746.83 stddev:1185.35 (25.0%) stddev-sans-first:1152.87 13:25:52 INFO - PROCESS | 22557 | Values: 304.6 309.8 312.4 313.6 314.0 4745.2 4752.0 4764.5 4778.0 4800.0 4684.4 4711.2 4728.2 4728.8 4729.7 3562.6 3680.9 3720.5 3764.5 3822.2 3750.4 3772.9 3778.8 3793.7 3795.9 3603.6 3753.4 3766.5 3774.4 3776.3 3611.2 3717.2 3721.0 3721.8 3750.5 3264.7 3281.1 3282.9 3290.2 3298.5 4559.4 4562.6 4567.7 4567.9 4605.6 4077.2 4227.4 4253.5 4296.8 4307.4 4931.0 4964.1 4973.4 4984.7 5002.7 3610.6 3651.0 3655.8 3657.8 3670.7 5017.3 5209.7 5221.4 5238.2 5242.7 3745.9 3785.8 3791.9 3793.7 3796.5 3788.2 3797.7 3807.3 3811.2 3819.2 4302.3 4303.6 4319.6 4323.5 4336.2 4803.0 5014.6 5033.5 5039.4 5049.3 1294.7 1307.3 1312.5 1317.8 1317.9 865.9 871.1 876.5 893.7 897.3 4395.2 4396.2 4397.9 4430.0 4444.2 5063.5 5066.3 5084.6 5088.4 5113.5 4258.9 4374.3 4388.0 4410.8 4427.6 2691.7 2707.7 2717.3 2721.7 2732.8 4757.5 4758.1 4797.8 4799.1 4799.8 5037.8 5189.3 5213.0 5217.0 5232.1 4774.6 4791.7 4803.5 4805.7 4816.4 5074.5 5084.7 5086.6 5101.2 5112.9 4766.2 5011.1 5021.8 5037.9 5039.2 4748.5 4760.9 4794.1 4803.9 4812.0 3726.8 3745.3 3768.0 3777.0 3777.2 4903.4 5055.4 5069.8 5140.5 5209.6 4985.7 4988.4 5002.9 5026.3 5038.8 4979.3 5003.4 5036.6 5052.3 5066.3 4825.5 4959.2 4968.2 4974.8 4990.8 4853.6 4967.6 5045.5 5059.3 5068.3 4907.5 4938.5 4938.9 4966.9 4989.2 13:25:52 INFO - PROCESS | 22557 | 13:25:52 INFO - PROCESS | 22557 | [#5] yui.html Cycles:180 Average:13287.02 Median:41474.09 stddev:15529.66 (37.4%) stddev-sans-first:15544.07 13:25:52 INFO - PROCESS | 22557 | Values: 614.1 647.9 685.7 689.9 696.9 11782.5 11835.1 11867.3 11893.6 11958.3 10834.9 10837.1 10888.2 12900.4 13400.3 622.2 642.6 814.7 818.9 820.6 792.4 815.7 816.5 820.6 822.5 839.7 843.7 843.8 844.2 844.4 660.4 827.4 832.6 833.5 851.1 596.8 601.4 601.8 602.7 604.4 12490.9 12523.7 12527.4 12535.6 12541.7 12788.4 13114.7 13210.7 13265.7 13340.3 9966.9 9991.5 10126.9 10190.4 10197.4 3173.6 3265.0 3320.3 3344.2 3446.1 46060.3 47733.3 47758.3 47949.0 48580.0 10489.7 10498.5 10560.2 10605.8 10817.2 18101.0 18134.9 18231.6 18262.7 18266.5 6460.8 6705.9 6792.5 6928.2 7117.3 3773.8 3780.9 3811.5 3827.3 3853.9 2914.9 3010.8 3011.6 3012.5 3015.5 523.0 535.5 537.9 547.9 548.6 474.5 633.9 652.2 660.2 664.9 7829.5 7915.6 7963.2 8245.1 8300.5 630.3 643.1 644.8 646.8 653.9 3622.7 3630.6 3704.6 3815.6 3854.7 53694.7 56950.7 57836.0 58022.7 58134.4 50147.0 50559.2 50801.0 50851.2 53142.0 45528.0 45780.0 45794.8 45837.3 46217.8 6751.8 6794.2 6874.2 6918.5 6987.5 27497.3 28204.2 28906.1 31612.0 31944.2 40251.0 40700.6 40943.8 41430.6 41517.6 10769.4 10900.6 11063.2 11157.9 11308.2 12243.8 12412.9 12563.9 12583.5 12643.7 7412.5 10241.7 11003.4 11040.8 11487.1 11111.3 11158.6 11373.1 11562.8 11563.0 10885.3 11187.0 11254.2 11632.2 11686.6 9205.1 9660.1 9725.8 9770.9 9895.0 10044.7 10077.4 10138.5 10199.6 10214.7 13:25:52 INFO - PROCESS | 22557 | -------- Summary: end -------- 13:25:52 INFO - PROCESS | 22557 | 13:25:53 INFO - TEST-INFO | 22557: exit 0 13:25:53 INFO - TEST-OK | dromaeo_css | took 1119415ms 13:25:53 INFO - TEST-START | kraken 13:25:53 INFO - operating with platform_type : linux_ 13:25:53 INFO - Initialising browser for kraken test... 13:25:53 INFO - TEST-INFO | started process 22740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTK3jO/profile http://localhost:50560/getInfo.html) 13:25:57 INFO - PROCESS | 22740 | __metrics Screen width/height:1600/1200 13:25:57 INFO - PROCESS | 22740 | colorDepth:24 13:25:57 INFO - PROCESS | 22740 | Browser inner width/height: 1024/697 13:25:57 INFO - PROCESS | 22740 | __metrics 13:25:59 ERROR - PROCESS | 22740 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:25:59 INFO - TEST-INFO | 22740: exit 0 13:25:59 INFO - Browser initialized. 13:25:59 INFO - Running cycle 1/1 for kraken test... 13:25:59 INFO - TEST-INFO | started process 22822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTK3jO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:11 INFO - PROCESS | 22822 | RSS: Main: 156454912 13:26:11 INFO - PROCESS | 22822 | 13:26:14 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:15 INFO - PROCESS | 22822 | RSS: Main: 214851584 13:26:15 INFO - PROCESS | 22822 | 13:26:18 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-dft) 13:26:18 INFO - PROCESS | 22822 | RSS: Main: 204636160 13:26:18 INFO - PROCESS | 22822 | 13:26:22 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-fft) 13:26:22 INFO - PROCESS | 22822 | RSS: Main: 270315520 13:26:22 INFO - PROCESS | 22822 | 13:26:25 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-oscillator) 13:26:25 INFO - PROCESS | 22822 | RSS: Main: 180416512 13:26:25 INFO - PROCESS | 22822 | 13:26:27 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:28 INFO - PROCESS | 22822 | RSS: Main: 184791040 13:26:28 INFO - PROCESS | 22822 | 13:26:31 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:32 INFO - PROCESS | 22822 | RSS: Main: 220614656 13:26:32 INFO - PROCESS | 22822 | 13:26:35 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:36 INFO - PROCESS | 22822 | RSS: Main: 221454336 13:26:36 INFO - PROCESS | 22822 | 13:26:39 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50560/tests/kraken/driver.html?testName=json-parse-financial) 13:26:39 INFO - PROCESS | 22822 | RSS: Main: 220962816 13:26:39 INFO - PROCESS | 22822 | 13:26:41 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:42 INFO - PROCESS | 22822 | RSS: Main: 210276352 13:26:42 INFO - PROCESS | 22822 | 13:26:44 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:44 INFO - PROCESS | 22822 | RSS: Main: 211574784 13:26:44 INFO - PROCESS | 22822 | 13:26:46 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:47 INFO - PROCESS | 22822 | RSS: Main: 219729920 13:26:47 INFO - PROCESS | 22822 | 13:26:50 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:26:50 INFO - PROCESS | 22822 | RSS: Main: 224632832 13:26:50 INFO - PROCESS | 22822 | 13:26:53 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:54 INFO - PROCESS | 22822 | RSS: Main: 225132544 13:26:54 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50560/tests/kraken/driver.html?testName=ai-astar) 13:26:56 INFO - PROCESS | 22822 | RSS: Main: 267010048 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | __start_tp_report 13:26:56 INFO - PROCESS | 22822 | _x_x_mozilla_page_load 13:26:56 INFO - PROCESS | 22822 | _x_x_mozilla_page_load_details 13:26:56 INFO - PROCESS | 22822 | |i|pagename|runs| 13:26:56 INFO - PROCESS | 22822 | |0;ai-astar;112;108;114;113;113;113;114;112;113;113 13:26:56 INFO - PROCESS | 22822 | |1;audio-beat-detection;169;128;139;170;129;157;156;133;189;133 13:26:56 INFO - PROCESS | 22822 | |2;audio-dft;161;162;162;161;161;161;163;161;161;160 13:26:56 INFO - PROCESS | 22822 | |3;audio-fft;75;76;75;116;76;77;75;75;140;75 13:26:56 INFO - PROCESS | 22822 | |4;audio-oscillator;85;84;128;85;84;86;122;84;84;122 13:26:56 INFO - PROCESS | 22822 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;117;117 13:26:56 INFO - PROCESS | 22822 | |6;imaging-darkroom;148;148;145;146;146;146;146;146;147;145 13:26:56 INFO - PROCESS | 22822 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;95 13:26:56 INFO - PROCESS | 22822 | |8;json-parse-financial;66;65;65;65;64;65;65;65;65;64 13:26:56 INFO - PROCESS | 22822 | |9;json-stringify-tinderbox;65;65;64;65;66;65;65;64;66;65 13:26:56 INFO - PROCESS | 22822 | |10;stanford-crypto-aes;83;83;84;83;84;84;90;91;139;85 13:26:56 INFO - PROCESS | 22822 | |11;stanford-crypto-ccm;135;134;133;129;128;130;131;129;152;140 13:26:56 INFO - PROCESS | 22822 | |12;stanford-crypto-pbkdf2;168;168;170;169;166;166;166;169;168;168 13:26:56 INFO - PROCESS | 22822 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;72;66;67;65;64 13:26:56 INFO - PROCESS | 22822 | __end_tp_report 13:26:56 INFO - PROCESS | 22822 | __start_cc_report 13:26:56 INFO - PROCESS | 22822 | _x_x_mozilla_cycle_collect,1873 13:26:56 INFO - PROCESS | 22822 | __end_cc_report 13:26:56 INFO - PROCESS | 22822 | __startTimestamp1464380816390__endTimestamp 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | ------- Summary: start ------- 13:26:56 INFO - PROCESS | 22822 | Number of tests: 14 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 13:26:56 INFO - PROCESS | 22822 | Values: 112.0 108.0 114.0 113.0 113.0 113.0 114.0 112.0 113.0 113.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:156.50 stddev:21.06 (13.5%) stddev-sans-first:21.22 13:26:56 INFO - PROCESS | 22822 | Values: 169.0 128.0 139.0 170.0 129.0 157.0 156.0 133.0 189.0 133.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:26:56 INFO - PROCESS | 22822 | Values: 161.0 162.0 162.0 161.0 161.0 161.0 163.0 161.0 161.0 160.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#3] audio-fft Cycles:10 Average:86.00 Median:75.00 stddev:22.86 (30.5%) stddev-sans-first:23.89 13:26:56 INFO - PROCESS | 22822 | Values: 75.0 76.0 75.0 116.0 76.0 77.0 75.0 75.0 140.0 75.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:19.13 (22.8%) stddev-sans-first:19.84 13:26:56 INFO - PROCESS | 22822 | Values: 85.0 84.0 128.0 85.0 84.0 86.0 122.0 84.0 84.0 122.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:26:56 INFO - PROCESS | 22822 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 13:26:56 INFO - PROCESS | 22822 | Values: 148.0 148.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:26:56 INFO - PROCESS | 22822 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 13:26:56 INFO - PROCESS | 22822 | Values: 66.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:26:56 INFO - PROCESS | 22822 | Values: 65.0 65.0 64.0 65.0 66.0 65.0 65.0 64.0 66.0 65.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:84.00 stddev:17.25 (20.5%) stddev-sans-first:18.08 13:26:56 INFO - PROCESS | 22822 | Values: 83.0 83.0 84.0 83.0 84.0 84.0 90.0 91.0 139.0 85.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:133.50 stddev:7.25 (5.4%) stddev-sans-first:7.68 13:26:56 INFO - PROCESS | 22822 | Values: 135.0 134.0 133.0 129.0 128.0 130.0 131.0 129.0 152.0 140.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 13:26:56 INFO - PROCESS | 22822 | Values: 168.0 168.0 170.0 169.0 166.0 166.0 166.0 169.0 168.0 168.0 13:26:56 INFO - PROCESS | 22822 | 13:26:56 INFO - PROCESS | 22822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.11 (3.2%) stddev-sans-first:2.24 13:26:56 INFO - PROCESS | 22822 | Values: 67.0 66.0 67.0 67.0 66.0 72.0 66.0 67.0 65.0 64.0 13:26:56 INFO - PROCESS | 22822 | -------- Summary: end -------- 13:26:56 INFO - PROCESS | 22822 | 13:26:57 INFO - TEST-INFO | 22822: exit 0 13:26:57 INFO - TEST-OK | kraken | took 63761ms 13:26:57 INFO - SUITE-END | took 1183s 13:26:57 INFO - Completed test suite (00:19:43) 13:26:57 INFO - javascript benchmark 13:26:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2718.660167479065, 2729.34495721027, 2734.8359098454093, 2750.6286651302066, 2777.47228026675, 4769.8807529811775, 4813.68711033783, 4868.805247790084, 4903.55867971882, 4942.40691117066, 4784.40194975628, 4801.567858892699, 4818.036392721452, 4846.757662116897, 4854.077725232212, 4381.167578160147, 4430.734155950637, 4437.666337729137, 4496.64026877849, 4575.084983003396, 4508.176251410991, 4523.7285762854335, 4530.773461326937, 4563.7489938053395, 4579.0, 4388.736675799462, 4411.09572537629, 4415.183191109655, 4444.422225110748, 4470.552944705536, 4428.31361139024, 4431.7119387240045, 4440.800163992628, 4482.910341793146, 4503.234450143484, 4452.042810795694, 4452.532484089189, 4455.420795296591, 4507.684462087655, 4509.436320459942, 4650.837220697294, 4687.859364219079, 4765.285207218945, 4774.427068751737, 4780.306855505967, 5231.189165679326, 5269.314989051437, 5273.551748101416, 5285.497877701612, 5285.603579731535, 5248.81629142982, 5282.97358513205, 5318.813841515567, 5319.069162896478, 5319.069162896516, 4747.192977193851, 4795.664303498722, 4874.147024270738, 4884.926726099111, 4943.65394422387, 5375.328083989423, 5406.107992181246, 5406.675599464044, 5413.810516631899, 5416.83749487516, 5071.746412679351, 5190.480951904855, 5191.428942816363, 5193.480651934777, 5197.246399272084, 5172.146595811724, 5226.843194704165, 5236.266922630834, 5297.470252974672, 5301.655392399482, 5159.948400515947, 5170.767315470813, 5171.991461664939, 5174.120399532088, 5176.792928282902, 5201.167813149954, 5201.895962080737, 5205.869853253699, 5210.452902445264, 5238.528532432099, 4334.5882141196535, 4389.078293558325, 4392.099619578043, 4450.132224216311, 4470.2177119004045, 3877.922441551153, 3886.2227554489214, 3895.435161901565, 3918.2359439908946, 3982.9203415932097, 4493.550644935481, 4509.346144808985, 4516.16450956574, 4553.658475614276, 4555.544445555418, 4988.925166122511, 5076.949230507722, 5117.334746482933, 5269.077911365495, 5288.206768984683, 4418.293073108287, 4427.291633338715, 4444.688871778944, 4475.462944446687, 4481.529439408815, 4660.974585591164, 4676.719396836201, 4683.15703173432, 4685.086408150378, 4733.360996265529, 4768.117898188846, 4840.2255639097575, 4872.415310162662, 4919.581835544019, 4928.802847886044, 5238.68567885928, 5251.894962100813, 5253.106971814877, 5254.264402983662, 5260.10578201699, 4910.0, 4918.901621967612, 4922.606191504743, 4923.236898280772, 4956.529129732669, 4997.625178111583, 5118.155504341742, 5146.073706732824, 5184.896302074013, 5189.143791274549, 5228.895422091613, 5248.448912864247, 5267.236250743697, 5269.71016594091, 5314.388845282688, 4996.875078123076, 5098.056859481007, 5103.92344114846, 5104.464031276811, 5108.693478391308, 5039.244113383022, 5040.395152581567, 5044.949550504448, 5097.15896877026, 5106.540411362995, 4973.0, 4984.526469985346, 5015.272785446017, 5037.0, 5045.672031317952, 4950.925736113889, 5033.0688822567945, 5072.442031376472, 5103.0, 5105.846824595268, 4977.278294647328, 4980.452150263396, 5004.174311238605, 5012.147934851011, 5050.015247026795], "value": 4783.560327386409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.8144844239556, 597.6324560395357, 603.2549800995771, 608.6804427675467, 609.704293417692, 27257.863710681442, 28056.71943280569, 30270.848645756796, 30304.09087727369, 41227.38158927611, 39708.40437393434, 43755.34366984498, 43798.0, 43810.12379752411, 43843.56156438435, 7754.0, 7898.131205567383, 7910.604469776517, 7913.960430197841, 7927.563983980879, 7762.340201082887, 7921.168277330884, 7940.602969851513, 7942.523448593074, 7953.164917683618, 7917.643706033214, 7967.641456134459, 7973.840523189533, 7975.042994840627, 7977.960110199469, 7900.565468899208, 7942.722004729836, 7948.721794737215, 7950.0, 7954.880676789853, 7728.459007869451, 7800.0, 7803.804904877366, 7809.062912450542, 7811.609419529001, 38971.0, 39364.80317598422, 39411.40882886759, 39412.21175576472, 39459.40810887839, 3049.7255247027874, 3129.4992801151707, 3216.3406501667337, 3307.6030876295, 3579.355715971124, 28712.712872871212, 29453.55819662707, 29738.508284811865, 29754.256143596365, 29922.251943701365, 3364.512145738854, 3417.40195465795, 3441.4149594568985, 3475.1138459692615, 3481.6344283850085, 260801.0, 261311.0, 261964.9999999981, 262244.0, 262841.0, 53251.467485325426, 53589.196162057604, 53634.0, 53666.0, 53777.462225378025, 34004.48993265103, 35126.29747405038, 35203.0, 35966.820165899524, 36006.099847504025, 13463.326833658473, 13550.051496395157, 13586.0, 13595.116317439335, 13602.523911663044, 9916.206703463706, 9923.156531694742, 9991.100800927952, 9999.35004224723, 10000.699979000641, 19256.0, 19268.4219473416, 19278.903605482163, 19279.132439040277, 19305.710414343797, 6984.825379365557, 7045.859082818315, 7117.3238542338395, 7159.140903091558, 7339.183624515223, 705.2242533213424, 824.7608193623902, 844.345632135088, 911.2482202183226, 961.5576834655997, 26660.333491662477, 27538.724612754017, 27712.722872771013, 28088.43823123567, 28100.578491322645, 751.6317004667674, 919.8482250428605, 935.242453612576, 1000.559753708366, 1002.8896821349646, 13798.93100534511, 14250.928745356414, 14385.352659130363, 14548.49080282185, 14601.415943362359, 387186.0, 388009.0, 389142.0, 389678.8772954331, 390700.0, 49910.50089499131, 50281.0, 50304.0, 50364.0, 50566.24150637743, 1066.0299127793671, 1161.4250945781723, 1178.116412690482, 1184.4314728930162, 1191.814144925787, 27828.30429239285, 30192.69807301899, 30273.848630756704, 30288.0, 30753.231169220053, 45028.32457513074, 45600.54399455963, 45636.543634563226, 45815.54184458113, 46054.53945460637, 365328.0, 367968.0, 368309.0, 369251.0, 533313.0, 39750.801245993585, 40237.39643905402, 40476.3928541078, 42822.35766463568, 42939.785301073294, 43651.34522982221, 44016.339754904344, 44333.0, 44497.77751111224, 45112.323315150956, 36519.63480365162, 37189.25621487609, 37532.624673752915, 37686.81156594309, 38097.80951095227, 37118.44322335113, 37345.813270933475, 38014.80992595019, 38195.618043820316, 38544.61455385522, 36466.27067458583, 37236.627633723314, 37344.43983340306, 37477.81261093677, 37546.624533754315, 31483.527747083353, 33254.83372583122, 33459.49810752792, 34240.828795855865, 34385.484217737256, 24613.63079553844, 24637.630435543124, 24932.75067249377, 24955.376115597257, 25034.37414064663], "value": 17730.282857627004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6852643779226, 381.00937562337924, 387.370522900287, 399.22948708991635, 401.2596758979681, 15590.610234744137, 16795.74806377902, 17248.22382992765, 17354.132293385326, 17354.479365619052, 15721.37114515421, 16178.676426471464, 16800.495985120437, 16833.0, 16880.493585192435, 4510.503844577094, 4680.5085466026085, 4701.858944231679, 4718.150732868083, 4724.196886529281, 3468.202313467904, 5074.137396642561, 5324.627276090675, 5375.650582712131, 5472.753726082336, 5367.490088441592, 5427.83716488506, 5431.2396264522995, 5432.619716619838, 5437.483439073281, 5100.540951314381, 5436.157395603688, 5439.836804895859, 5483.588730845163, 5502.174673798962, 3374.088995971074, 4897.60819134472, 5213.635045546814, 5222.451642577513, 5281.973590132063, 11240.606578769786, 11314.321140731583, 11491.0, 11495.770084598262, 11763.7059073523, 1724.1379310344828, 1741.8693597980202, 1809.6923523001121, 1817.9272829086822, 1842.207850624231, 8797.780055498664, 8894.243989260856, 9705.320627556073, 9978.800423991552, 12963.28701921394, 1648.9505314840574, 1724.4912750738563, 1739.7912250529891, 1755.2013833705762, 1816.0284247927295, 64452.355476445104, 66714.66642666805, 67422.66288668575, 67795.66102169506, 68765.0, 9431.151196392357, 9555.04449555039, 9628.0, 9630.759231019141, 9929.950350248202, 13238.602841914759, 13390.397432115384, 13403.32983350848, 13418.731625367438, 13421.865781342061, 6569.737210511526, 6620.569662971891, 6833.3166683331265, 6951.826204344932, 6992.510524263253, 6376.0, 6444.2266927968, 6491.837704057436, 6545.116409284781, 6605.207375115017, 4065.837366505307, 4104.363823607346, 4120.711550191518, 4324.416203812508, 4487.708298960622, 1591.2441590244773, 1694.5763559110223, 1702.1063941430848, 1713.1177443616548, 1728.7234042553382, 761.3338328962158, 837.5602808525573, 875.8292133034124, 904.2585080234145, 905.0135352465712, 15927.124008179662, 16114.75827862583, 16148.111853848151, 16537.503874883772, 16682.91658541724, 827.1934863508031, 832.2177153475714, 869.9782505437415, 876.5310558850985, 923.4136323434667, 9129.771755706028, 9518.286128540387, 9535.570899309549, 9623.0, 9827.557759900821, 371724.0, 372530.0, 375245.0, 380608.484787877, 383111.0, 77669.0, 78359.0, 79019.74471479833, 79618.0, 79976.60011699905, 911.7583840282331, 916.3081873185702, 916.3814425263054, 917.4082716647724, 921.6129225725211, 15137.167455789597, 15229.771553426486, 15320.157391343582, 15350.385984560493, 15531.76702349443, 26977.460450791266, 33528.329433410705, 33953.32093358169, 35675.0, 36441.81779091193, 46780.0, 49497.50502494929, 49546.50453495563, 49664.25503617521, 49825.0, 7484.850302993801, 7552.8867066995135, 7643.9617801912855, 7647.235276472308, 7764.107127680389, 10752.569897204025, 11574.594889178838, 11743.41282935867, 11764.0, 11945.104117191071, 9002.954985225031, 9208.49353285549, 9329.48687822149, 9385.202257808163, 9606.567704453177, 9500.287478439006, 9557.569909354235, 9659.855102173333, 10030.899691002996, 10425.113865321533, 8797.736067917973, 9206.861897071416, 9508.619655213713, 9535.666251681158, 9681.70954871355, 7437.814054648461, 7497.0, 7614.0, 7661.693532258871, 7687.5387476751575, 8745.693900713444, 9043.366964312698, 9261.583228754587, 9374.625014999596, 9501.762455938657], "value": 7816.257420663969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.2385744695728, 1406.2827957741556, 1469.1552357394498, 1578.9368823716925, 1807.4487281379181, 6763.2560418354005, 7568.091828980523, 7818.491798033124, 7831.29518343349, 8068.273855353017, 7779.33875620573, 7816.062072551287, 7881.960590197055, 7896.526208427498, 7902.367810575154, 2219.82241420686, 2228.320362289501, 2232.653938639505, 2233.7542870284256, 2245.640697488394, 2200.251914349121, 2227.0312414099917, 2245.8989345479495, 2248.87631180285, 2255.4812393149587, 2212.4358288636377, 2229.643257078868, 2240.6526988316755, 2241.9551608967813, 2244.9663255051187, 2150.709654196679, 2168.0677308757226, 2173.9891300543554, 2174.695542624034, 2176.260071575664, 2131.8507704460694, 2135.508832968426, 2139.1122684086085, 2146.3882793403804, 2149.0758973641327, 7559.319661230461, 7638.8472230555635, 7693.884591731128, 7694.769156925301, 7695.692172313101, 4601.608863246628, 4782.593479554242, 4798.496157903405, 4806.663533552653, 4812.109759694467, 2882.394697113588, 3046.31457921968, 3106.6272047354464, 3108.9222769430944, 3116.2209447638093, 926.7683079230193, 926.972190834276, 932.7341707613298, 1030.7474668706216, 1043.1133536493996, 10616.734581635445, 10715.732106697316, 10729.034386905138, 10742.301750386277, 10763.677089687244, 4176.310908700091, 4212.178625168124, 4335.067960388532, 4339.848105316299, 4362.1493808707, 8379.95810020946, 8419.789505262417, 8422.199891010345, 8433.03020152678, 8437.156284371637, 4671.43942726875, 4672.696274742131, 4680.53194680536, 4681.297805329228, 4683.953160468352, 3767.0, 3798.810059497014, 4291.420658211164, 4348.130373925228, 4397.978010109993, 3439.570053743282, 3473.913152171216, 3528.3825330567047, 3550.183457804719, 3565.2512972275595, 1024.1857723110145, 1030.6959446963165, 1032.5043978890176, 1039.781645854364, 1063.5798859450474, 770.6686124966318, 865.2904618213005, 901.0268909577771, 902.472053848506, 915.3089417489886, 5467.20725494801, 5552.500274975271, 5569.916451253234, 5784.82645520635, 5795.357947116942, 893.1693525021662, 908.100980029779, 915.057490784493, 915.5879854065697, 931.9673811416568, 3580.498730177725, 3610.5667319921777, 3891.1439483313625, 3907.9609203908167, 3916.784576848244, 9164.76275702785, 9390.107939745712, 9427.836740367184, 9507.57215925285, 9539.570719317648, 9253.352265341497, 9341.90658093424, 9359.62561497546, 9445.433274003582, 9448.858267126, 6770.93229067703, 7070.116235470567, 7075.0, 7231.7107315707835, 7279.708811647475, 5430.782768689366, 5684.602077854676, 5772.624779389326, 5876.764929402776, 5945.0, 8730.91269087301, 8873.600687969187, 9170.266378689823, 9199.218066464426, 9258.35191536586, 9022.14289642483, 9276.25789936817, 9284.442933424016, 9461.858072129062, 9469.857952130586, 6159.414855588712, 6342.048692696132, 6349.841253968688, 6357.523185761179, 6514.0, 7699.076110866732, 7815.53106813593, 7817.5309481431295, 7819.335356494534, 7822.178671239665, 6974.965125174342, 7015.298470153148, 7017.543859649107, 7032.2264550898335, 7103.715851365888, 6866.279040700654, 6886.2769409213315, 6937.687804048729, 6944.305569443015, 7038.155421349471, 6580.934190658224, 6582.76960306387, 6653.700583473658, 6681.5656982296, 6725.125733654593, 4743.667943244078, 4818.349522814376, 4821.7589120544535, 4866.562009419169, 4895.853124406273, 4716.905661886674, 4744.620430365631, 4804.615630749462, 4876.707397556158, 4888.095702295087], "value": 4194.095964444228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6116201842652, 309.77696058837637, 312.37057329481115, 313.64244760972497, 313.96389415217254, 4745.169595320818, 4752.0, 4764.547368000043, 4777.952220477794, 4800.039992001605, 4684.360473834156, 4711.20974029869, 4728.1962066448705, 4728.763561821912, 4729.699332683505, 3562.643735626436, 3680.914130331545, 3720.456010755533, 3764.5294338207723, 3822.197338558906, 3750.4374343848367, 3772.924541509168, 3778.754380965242, 3793.6858516305033, 3795.905102372435, 3603.6036036036016, 3753.380692185786, 3766.5480142382817, 3774.433834924756, 3776.2636285924254, 3611.1513794258326, 3717.237966216919, 3720.9627903721157, 3721.776693398391, 3750.549934007909, 3264.722498587623, 3281.146901805524, 3282.8522716477814, 3290.226796702797, 3298.505224216363, 4559.430071241095, 4562.6121779648765, 4567.748773817439, 4567.931481027754, 4605.631549476067, 4077.184563087365, 4227.387028880795, 4253.532111467736, 4296.785160741982, 4307.418498502725, 4931.0, 4964.106460837048, 4973.35346404965, 4984.725840078794, 5002.674826136289, 3610.6028336882923, 3650.9594765491706, 3655.8354874030733, 3657.817109144532, 3670.6696397324367, 5017.34774479319, 5209.661372010807, 5221.373435187764, 5238.240455134022, 5242.7378631068295, 3745.8688945886765, 3785.8296376663116, 3791.9431208531896, 3793.6585707286476, 3796.52543432071, 3788.2234142000825, 3797.6771974381936, 3807.2956503047026, 3811.180596171781, 3819.159784847385, 4302.333138363559, 4303.612674859215, 4319.611234988866, 4323.502797178302, 4336.1978034063795, 4802.975985120122, 5014.623903207201, 5033.471485494044, 5039.44566097729, 5049.293098966147, 1294.6828027133413, 1307.2875282970804, 1312.4775260697736, 1317.789153735417, 1317.9209247445183, 865.891658676882, 871.146276648875, 876.5310558850985, 893.7050773244814, 897.2597606974273, 4395.164918665443, 4396.164728701537, 4397.934030989538, 4429.9778501107285, 4444.177827101997, 5063.544281014726, 5066.289535098778, 5084.618653600921, 5088.440271570124, 5113.488651134857, 4258.914821703549, 4374.27824408969, 4387.956120438755, 4410.7725598572515, 4427.557244275611, 2691.663542057243, 2707.6615423072117, 2717.3070866928806, 2721.71422000691, 2732.7540521353176, 4757.476677565465, 4758.095961767253, 4797.808087676453, 4799.136155492045, 4799.784009719571, 5037.823676171316, 5189.273501709764, 5212.973935130376, 5217.0, 5232.096186616464, 4774.594159496482, 4791.664583479123, 4803.495632958559, 4805.663603547788, 4816.362436771515, 5074.517920797518, 5084.669496482717, 5086.6439349246675, 5101.158308878993, 5112.948870511247, 4766.165920963748, 5011.123053465702, 5021.824236151717, 5037.924431133462, 5039.21892106724, 4748.480486244369, 4760.857174284777, 4794.113089078532, 4803.927941080957, 4811.975940120277, 3726.7763934164036, 3745.2509498099944, 3767.9623203768706, 3776.981115094517, 3777.1501412182038, 4903.411590609007, 5055.418626857959, 5069.822556210515, 5140.537351638371, 5209.6092793041435, 4985.651004429655, 4988.351514303117, 5002.924956125734, 5026.346574945233, 5038.823641172541, 4979.327790748347, 5003.374578177728, 5036.622253331088, 5052.267421223975, 5066.290719299374, 4825.469198388245, 4959.156943319572, 4968.180250258667, 4974.825881094144, 4990.827155618499, 4853.635977301646, 4967.552920237196, 5045.470225626404, 5059.291699162047, 5068.29043933857, 4907.460179380337, 4938.481459446706, 4938.851834444972, 4966.850994470172, 4989.203886600748], "value": 3786.39392025544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.0942110387176, 647.8736646353962, 685.6914388525162, 689.8654762321349, 696.8884978403455, 11782.528698852046, 11835.053195744342, 11867.287962722232, 11893.643190704272, 11958.282503049812, 10834.945825270863, 10837.078848297904, 10888.183386246024, 12900.419481123348, 13400.262985535792, 622.1538707358012, 642.5887432043496, 814.7474282972267, 818.9140140285274, 820.6307161777224, 792.3859009267806, 815.6737305077957, 816.4978538198994, 820.5609998650723, 822.4941660878576, 839.7102999465175, 843.6583183810567, 843.8354520868434, 844.1684940333766, 844.3793811548506, 660.3693472733528, 827.3505298340834, 832.5629044751494, 833.4957350802767, 851.1020872979004, 596.7523477756769, 601.3955974245898, 601.8344955137328, 602.7408214467821, 604.437872778316, 12490.937545312307, 12523.686907827378, 12527.43626536808, 12535.623931282076, 12541.749165016648, 12788.360581970865, 13114.672133196651, 13210.735785284336, 13265.668358291023, 13340.332983350794, 9966.900330996743, 9991.450470224136, 10126.896127659782, 10190.388576685422, 10197.439140847251, 3173.587433633636, 3264.983675081633, 3320.286138480238, 3344.2141096842224, 3446.138465383654, 46060.3090953636, 47733.284000740015, 47758.283625745644, 47949.04101917977, 48580.0, 10489.737756555995, 10498.527566259536, 10560.2079844012, 10605.84091238632, 10817.242793004414, 18101.0, 18134.90932545355, 18231.635367292845, 18262.726059109125, 18266.452006439828, 6460.773872914426, 6705.932940670628, 6792.498076558004, 6928.203256625452, 7117.252688467636, 3773.7735735855936, 3780.8676696315497, 3811.504504414464, 3827.27281816454, 3853.9229215416094, 2914.88340466379, 3010.834404107751, 3011.593434886306, 3012.5481177823062, 3015.4873671475902, 522.9764660590282, 535.5126834580514, 537.9327584051994, 547.9315085614298, 548.5885585810641, 474.4638558429022, 633.8954072578065, 652.1749986267375, 660.2143449295419, 664.9434798042124, 7829.491083079582, 7915.604219788987, 7963.243491868263, 8245.093039765621, 8300.501969881827, 630.3192552043781, 643.1446176585224, 644.8258970078147, 646.775093677747, 653.8659574787157, 3622.673959343619, 3630.6006339303185, 3704.592494825567, 3815.561210460777, 3854.69162467002, 53694.73152634212, 56950.715246423504, 57836.0, 58022.7098864503, 58134.4186558129, 50147.0, 50559.241611375124, 50801.0, 50851.237231441555, 53142.0, 45528.0, 45780.0, 45794.771026145325, 45837.31244031276, 46217.7689111559, 6751.797446076625, 6794.150731158606, 6874.243833178246, 6918.481113916376, 6987.545809522365, 27497.31256718598, 28204.15387538377, 28906.132816015554, 31612.0, 31944.201394965312, 40250.9937251571, 40700.59299406968, 40943.7952810246, 41430.585694142675, 41517.58482415258, 10769.407682577534, 10900.618478353219, 11063.225574209728, 11157.888421115686, 11308.208425410143, 12243.75512489763, 12412.937935310627, 12563.87436125627, 12583.496660133493, 12643.683907902376, 7412.518186317872, 10241.74395640115, 11003.449827508432, 11040.779184416428, 11487.081033517466, 11111.333320000826, 11158.609448669258, 11373.090152787923, 11562.826557601811, 11562.970108003046, 10885.346879187275, 11187.0, 11254.155938304824, 11632.243904146204, 11686.649400517997, 9205.125513076247, 9660.073362584992, 9725.756856078655, 9770.85343719859, 9895.0, 10044.698659040241, 10077.395356278646, 10138.49307534635, 10199.643012494527, 10214.744631384276], "value": 6017.757709380312, "unit": "score"}], "name": "dromaeo_css", "value": 6313.965381388584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 114.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 128.0, 139.0, 170.0, 129.0, 157.0, 156.0, 133.0, 189.0, 133.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 116.0, 76.0, 77.0, 75.0, 75.0, 140.0, 75.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 128.0, 85.0, 84.0, 86.0, 122.0, 84.0, 84.0, 122.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 84.0, 84.0, 90.0, 91.0, 139.0, 85.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 133.0, 129.0, 128.0, 130.0, 131.0, 129.0, 152.0, 140.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 170.0, 169.0, 166.0, 166.0, 166.0, 169.0, 168.0, 168.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 72.0, 66.0, 67.0, 65.0, 64.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1553.3, "alertThreshold": 2.0}]} 13:26:57 INFO - Return code: 0 13:26:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:26:57 ERROR - # TBPL SUCCESS # 13:26:57 INFO - Running post-action listener: _resource_record_post_action 13:26:57 INFO - ##### 13:26:57 INFO - ##### Finished run-tests step (success) 13:26:57 INFO - ##### 13:26:57 INFO - Running post-run listener: _resource_record_post_run 13:26:57 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 507293696; Read time: 304; Write time: 469152 13:26:57 INFO - TinderboxPrint: CPU usage
13.1% 13:26:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 304 13:26:57 INFO - TinderboxPrint: I/O write bytes / time
507,293,696 / 469,152 13:26:57 INFO - TinderboxPrint: CPU idle
8,329.5 (86.9%) 13:26:57 INFO - TinderboxPrint: CPU user
1,210.7 (12.6%) 13:26:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:26:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 127168512; Read time: 0; Write time: 143624 13:26:57 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283594752; Read time: 304; Write time: 241792 13:26:58 INFO - Running post-run listener: _upload_blobber_files 13:26:58 INFO - Blob upload gear active. 13:26:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:26:58 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 13:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:26:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:02 INFO - (blobuploader) - INFO - Done attempting. 13:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:03 INFO - (blobuploader) - INFO - Done attempting. 13:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:04 INFO - (blobuploader) - INFO - Done attempting. 13:27:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:04 INFO - Return code: 0 13:27:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46133b43ffe75678445a1f6c3c58c975745c81ac1142ff2d8071a48581bf08883aae3cda48671b8406e6c7ec34b075302e372b032deb9c182b81577f5f1c6ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d025b255ace11683e4c7e1a86bf192af11fc29b1c032b6920328655025ac05e077107a7bc213ab87c9572dd2f65155e86dffdd803b800ebc0c02d6017eedfe12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4339e09447c52da39b93c1139288098a9c2fb6dcc8c615e72e4a88af5c8ef83ea148b2d011a25f1883e437fd155ffc7647d8f19435273ada8c5ca233bbbafc93"} 13:27:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:04 INFO - Contents: 13:27:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46133b43ffe75678445a1f6c3c58c975745c81ac1142ff2d8071a48581bf08883aae3cda48671b8406e6c7ec34b075302e372b032deb9c182b81577f5f1c6ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d025b255ace11683e4c7e1a86bf192af11fc29b1c032b6920328655025ac05e077107a7bc213ab87c9572dd2f65155e86dffdd803b800ebc0c02d6017eedfe12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4339e09447c52da39b93c1139288098a9c2fb6dcc8c615e72e4a88af5c8ef83ea148b2d011a25f1883e437fd155ffc7647d8f19435273ada8c5ca233bbbafc93"} 13:27:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:04 INFO - Copying logs to upload dir... 13:27:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.092419 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 13:27:03.515551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:27:03.519092) ========= 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=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46133b43ffe75678445a1f6c3c58c975745c81ac1142ff2d8071a48581bf08883aae3cda48671b8406e6c7ec34b075302e372b032deb9c182b81577f5f1c6ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d025b255ace11683e4c7e1a86bf192af11fc29b1c032b6920328655025ac05e077107a7bc213ab87c9572dd2f65155e86dffdd803b800ebc0c02d6017eedfe12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4339e09447c52da39b93c1139288098a9c2fb6dcc8c615e72e4a88af5c8ef83ea148b2d011a25f1883e437fd155ffc7647d8f19435273ada8c5ca233bbbafc93"} build_url:https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/WOa2xAQdReyAh9kwc1Ppiw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46133b43ffe75678445a1f6c3c58c975745c81ac1142ff2d8071a48581bf08883aae3cda48671b8406e6c7ec34b075302e372b032deb9c182b81577f5f1c6ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d025b255ace11683e4c7e1a86bf192af11fc29b1c032b6920328655025ac05e077107a7bc213ab87c9572dd2f65155e86dffdd803b800ebc0c02d6017eedfe12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4339e09447c52da39b93c1139288098a9c2fb6dcc8c615e72e4a88af5c8ef83ea148b2d011a25f1883e437fd155ffc7647d8f19435273ada8c5ca233bbbafc93"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:27:03.544203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:27:03.544509) ========= 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=fa44defc139c4ba8574fe040000001db-1464379576.303283-909337025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:27:03.630396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:27:03.630717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:27:03.630998) ========= ========= Total master_lag: 0.16 =========