builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1463584934.72 results: success (0) buildid: 20160518073552 builduid: 307fb8a12dcc4cbf8b881f27794f207f revision: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.718269) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.718703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.718972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.734338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.734593) ========= 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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 08:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-05-18 08:22:15 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.848807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.849099) ========= 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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:14.898385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 08:22:14.898734) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 --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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 08:22:16,017 truncating revision to first 12 chars 2016-05-18 08:22:16,017 Setting DEBUG logging. 2016-05-18 08:22:16,017 attempt 1/10 2016-05-18 08:22:16,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f36fe8daf67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 08:22:16,967 unpacking tar archive at: fx-team-8f36fe8daf67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 08:22:16.160477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:16.160809) ========= script_repo_revision: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:16.161213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:16.161478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:22:16.167358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-18 08:22:16.167622) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:17 INFO - MultiFileLogger online at 20160518 08:22:17 in /builds/slave/test 08:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:17 INFO - {'append_to_log': False, 08:22:17 INFO - 'base_work_dir': '/builds/slave/test', 08:22:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:17 INFO - 'branch': 'Fx-Team-Non-PGO', 08:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:17 INFO - 'config_files': ('talos/linux_config.py',), 08:22:17 INFO - 'default_actions': ('clobber', 08:22:17 INFO - 'read-buildbot-config', 08:22:17 INFO - 'download-and-extract', 08:22:17 INFO - 'populate-webroot', 08:22:17 INFO - 'create-virtualenv', 08:22:17 INFO - 'install', 08:22:17 INFO - 'run-tests'), 08:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:17 INFO - 'download_minidump_stackwalk': True, 08:22:17 INFO - 'download_symbols': 'ondemand', 08:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:17 INFO - 'installer_path': 'installer.exe', 08:22:17 INFO - 'log_level': 'info', 08:22:17 INFO - 'log_name': 'talos', 08:22:17 INFO - 'log_to_console': True, 08:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:17 INFO - 'opt_config_files': (), 08:22:17 INFO - 'pip_index': False, 08:22:17 INFO - 'sps_profile': False, 08:22:17 INFO - 'sps_profile_interval': 0, 08:22:17 INFO - 'suite': 'dromaeojs', 08:22:17 INFO - 'system_bits': '32', 08:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:17 INFO - 'title': 'talos-linux64-ix-065', 08:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:17 INFO - 'use_talos_json': True, 08:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:17 INFO - 'work_dir': 'build'} 08:22:17 INFO - ##### 08:22:17 INFO - ##### Running clobber step. 08:22:17 INFO - ##### 08:22:17 INFO - Running pre-action listener: _resource_record_pre_action 08:22:17 INFO - Running main action method: clobber 08:22:17 INFO - rmtree: /builds/slave/test/build 08:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:18 INFO - Running post-action listener: _resource_record_post_action 08:22:18 INFO - ##### 08:22:18 INFO - ##### Finished clobber step (success) 08:22:18 INFO - ##### 08:22:18 INFO - ##### 08:22:18 INFO - ##### Running read-buildbot-config step. 08:22:18 INFO - ##### 08:22:18 INFO - Running pre-action listener: _resource_record_pre_action 08:22:18 INFO - Running main action method: read_buildbot_config 08:22:18 INFO - Using buildbot properties: 08:22:18 INFO - { 08:22:18 INFO - "project": "", 08:22:18 INFO - "product": "firefox", 08:22:18 INFO - "script_repo_revision": "production", 08:22:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:22:18 INFO - "repository": "", 08:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:22:18 INFO - "buildid": "20160518073552", 08:22:18 INFO - "pgo_build": "False", 08:22:18 INFO - "basedir": "/builds/slave/test", 08:22:18 INFO - "buildnumber": 2981, 08:22:18 INFO - "slavename": "talos-linux64-ix-065", 08:22:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:22:18 INFO - "platform": "ubuntu64_hw", 08:22:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:22:18 INFO - "branch": "fx-team", 08:22:18 INFO - "repo_path": "integration/fx-team", 08:22:18 INFO - "revision": "8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9", 08:22:18 INFO - "stage_platform": "linux64", 08:22:18 INFO - "builduid": "307fb8a12dcc4cbf8b881f27794f207f", 08:22:18 INFO - "slavebuilddir": "test" 08:22:18 INFO - } 08:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:22:18 INFO - Running post-action listener: _resource_record_post_action 08:22:18 INFO - ##### 08:22:18 INFO - ##### Finished read-buildbot-config step (success) 08:22:18 INFO - ##### 08:22:18 INFO - ##### 08:22:18 INFO - ##### Running download-and-extract step. 08:22:18 INFO - ##### 08:22:18 INFO - Running pre-action listener: _resource_record_pre_action 08:22:18 INFO - Running main action method: download_and_extract 08:22:18 INFO - mkdir: /builds/slave/test/build/tests 08:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:18 INFO - https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:26 INFO - Downloaded 1361 bytes. 08:22:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:26 INFO - Using the following test package requirements: 08:22:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'jsshell-linux-x86_64.zip'], 08:22:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22: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')]} 08:22:26 INFO - https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:29 INFO - Downloaded 22489217 bytes. 08:22:29 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'] 08:22:29 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 08:22:30 INFO - Return code: 0 08:22:30 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 08:22:30 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')]} 08:22:30 INFO - https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:34 INFO - Downloaded 22489217 bytes. 08:22:34 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'] 08:22:34 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 08:22:35 INFO - Return code: 0 08:22: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')]} 08:22:35 INFO - https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:36 INFO - Downloaded 10840194 bytes. 08:22:36 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'] 08:22:36 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 08:22:37 INFO - Return code: 0 08:22: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')]} 08:22:37 INFO - https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9yNgXFBT4mf9eabcAci-w/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 08:22:38 INFO - Downloaded 54779418 bytes. 08:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:22:38 INFO - mkdir: /builds/slave/test/properties 08:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:38 INFO - Contents: 08:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:22:39 INFO - Running post-action listener: _resource_record_post_action 08:22:39 INFO - Running post-action listener: set_extra_try_arguments 08:22:39 INFO - ##### 08:22:39 INFO - ##### Finished download-and-extract step (success) 08:22:39 INFO - ##### 08:22:39 INFO - ##### 08:22:39 INFO - ##### Running populate-webroot step. 08:22:39 INFO - ##### 08:22:39 INFO - Running pre-action listener: _resource_record_pre_action 08:22:39 INFO - Running main action method: populate_webroot 08:22:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:39 INFO - '--tppagecycles', 08:22:39 INFO - '7'], 08:22:39 INFO - 'tests': ['tsvgm']}}, 08:22:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['damp', 'tps']}, 08:22:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'tests': ['damp', 'tps']}, 08:22:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['dromaeo_dom']}, 08:22:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['a11yr', 08:22:39 INFO - 'ts_paint', 08:22:39 INFO - 'tpaint', 08:22:39 INFO - 'sessionrestore', 08:22:39 INFO - 'sessionrestore_no_auto_restore', 08:22:39 INFO - 'tabpaint']}, 08:22:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['tsvgx', 08:22:39 INFO - 'tsvgr_opacity', 08:22:39 INFO - 'tart', 08:22:39 INFO - 'tscrollx', 08:22:39 INFO - 'cart']}, 08:22:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:39 INFO - 'tsvgr_opacity', 08:22:39 INFO - 'tart', 08:22:39 INFO - 'tscrollx', 08:22:39 INFO - 'cart']}, 08:22:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'talos_options': ['--disable-e10s'], 08:22:39 INFO - 'tests': ['tp5o']}, 08:22:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'tests': ['tp5o']}, 08:22:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'talos_options': ['--disable-e10s', 08:22:39 INFO - '--xperf_path', 08:22:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:39 INFO - 'tests': ['tp5n']}, 08:22:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:39 INFO - 'talos_options': ['--xperf_path', 08:22:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:39 INFO - 'tests': ['tp5n']}}, 08:22:39 INFO - 'talos.zip': {'path': '', 08:22:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:39 INFO - Running post-action listener: _resource_record_post_action 08:22:39 INFO - ##### 08:22:39 INFO - ##### Finished populate-webroot step (success) 08:22:39 INFO - ##### 08:22:39 INFO - ##### 08:22:39 INFO - ##### Running create-virtualenv step. 08:22:39 INFO - ##### 08:22:39 INFO - Running pre-action listener: _resource_record_pre_action 08:22:39 INFO - Running main action method: create_virtualenv 08:22:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:39 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 08:22:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:39 INFO - Using real prefix '/usr' 08:22:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:22:41 INFO - Installing pip.................done. 08:22:41 INFO - Return code: 0 08:22:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:41 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:41 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 08:22:41 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 08:22:41 INFO - Using env: {'DISPLAY': ':0', 08:22:41 INFO - 'HOME': '/home/cltbld', 08:22:41 INFO - 'LANG': 'en_US.UTF-8', 08:22:41 INFO - 'LANGUAGE': 'en_US:en', 08:22:41 INFO - 'LOGNAME': 'cltbld', 08:22:41 INFO - 'MAIL': '/var/mail/cltbld', 08:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:41 INFO - 'MOZ_NO_REMOTE': '1', 08:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:41 INFO - 'NO_EM_RESTART': '1', 08:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:41 INFO - 'PWD': '/builds/slave/test', 08:22:41 INFO - 'SHELL': '/bin/bash', 08:22:41 INFO - 'SHLVL': '1', 08:22:41 INFO - 'TERM': 'linux', 08:22:41 INFO - 'TMOUT': '86400', 08:22:41 INFO - 'USER': 'cltbld', 08:22:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:41 INFO - '_': '/tools/buildbot/bin/python'} 08:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:42 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 08:22:42 INFO - Cleaning up... 08:22:42 INFO - Return code: 0 08:22:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:22:42 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')]} 08:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:42 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')]} 08:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:42 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:42 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 08:22:42 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 08:22:42 INFO - Using env: {'DISPLAY': ':0', 08:22:42 INFO - 'HOME': '/home/cltbld', 08:22:42 INFO - 'LANG': 'en_US.UTF-8', 08:22:42 INFO - 'LANGUAGE': 'en_US:en', 08:22:42 INFO - 'LOGNAME': 'cltbld', 08:22:42 INFO - 'MAIL': '/var/mail/cltbld', 08:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:42 INFO - 'MOZ_NO_REMOTE': '1', 08:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:42 INFO - 'NO_EM_RESTART': '1', 08:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:42 INFO - 'PWD': '/builds/slave/test', 08:22:42 INFO - 'SHELL': '/bin/bash', 08:22:42 INFO - 'SHLVL': '1', 08:22:42 INFO - 'TERM': 'linux', 08:22:42 INFO - 'TMOUT': '86400', 08:22:42 INFO - 'USER': 'cltbld', 08:22:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:42 INFO - '_': '/tools/buildbot/bin/python'} 08:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:42 INFO - Downloading/unpacking psutil>=3.1.1 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:44 INFO - Installing collected packages: psutil 08:22:44 INFO - Running setup.py install for psutil 08:22:44 INFO - building 'psutil._psutil_linux' extension 08:22:44 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 08:22:44 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 08:22:44 INFO - building 'psutil._psutil_posix' extension 08:22:44 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 08:22:44 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 08:22:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:44 INFO - Successfully installed psutil 08:22:44 INFO - Cleaning up... 08:22:44 INFO - Return code: 0 08:22:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:22:44 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')]} 08:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 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')]} 08:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:44 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 08:22:44 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 08:22:44 INFO - Using env: {'DISPLAY': ':0', 08:22:44 INFO - 'HOME': '/home/cltbld', 08:22:44 INFO - 'LANG': 'en_US.UTF-8', 08:22:44 INFO - 'LANGUAGE': 'en_US:en', 08:22:44 INFO - 'LOGNAME': 'cltbld', 08:22:44 INFO - 'MAIL': '/var/mail/cltbld', 08:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:44 INFO - 'MOZ_NO_REMOTE': '1', 08:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:44 INFO - 'NO_EM_RESTART': '1', 08:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:44 INFO - 'PWD': '/builds/slave/test', 08:22:44 INFO - 'SHELL': '/bin/bash', 08:22:44 INFO - 'SHLVL': '1', 08:22:44 INFO - 'TERM': 'linux', 08:22:44 INFO - 'TMOUT': '86400', 08:22:44 INFO - 'USER': 'cltbld', 08:22:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:44 INFO - '_': '/tools/buildbot/bin/python'} 08:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:22:45 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 08:22:45 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 08:22:45 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 08:22:45 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 08:22:45 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 08:22:45 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 08:22:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:47 INFO - Installing collected packages: mozsystemmonitor 08:22:47 INFO - Running setup.py install for mozsystemmonitor 08:22:47 INFO - Successfully installed mozsystemmonitor 08:22:47 INFO - Cleaning up... 08:22:47 INFO - Return code: 0 08:22:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:47 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:47 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 08:22:47 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 08:22:47 INFO - Using env: {'DISPLAY': ':0', 08:22:47 INFO - 'HOME': '/home/cltbld', 08:22:47 INFO - 'LANG': 'en_US.UTF-8', 08:22:47 INFO - 'LANGUAGE': 'en_US:en', 08:22:47 INFO - 'LOGNAME': 'cltbld', 08:22:47 INFO - 'MAIL': '/var/mail/cltbld', 08:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:47 INFO - 'MOZ_NO_REMOTE': '1', 08:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:47 INFO - 'NO_EM_RESTART': '1', 08:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:47 INFO - 'PWD': '/builds/slave/test', 08:22:47 INFO - 'SHELL': '/bin/bash', 08:22:47 INFO - 'SHLVL': '1', 08:22:47 INFO - 'TERM': 'linux', 08:22:47 INFO - 'TMOUT': '86400', 08:22:47 INFO - 'USER': 'cltbld', 08:22:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:47 INFO - '_': '/tools/buildbot/bin/python'} 08:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:47 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 08:22:47 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 08:22:47 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 08:22:47 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 08:22:47 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 08:22:47 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 08:22:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:49 INFO - Downloading docopt-0.6.1.tar.gz 08:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:50 INFO - Running setup.py install for blobuploader 08:22:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:50 INFO - Running setup.py install for requests 08:22:50 INFO - Running setup.py install for docopt 08:22:50 INFO - Successfully installed blobuploader requests docopt 08:22:50 INFO - Cleaning up... 08:22:50 INFO - Return code: 0 08:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:50 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:50 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 08:22:50 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 08:22:50 INFO - Using env: {'DISPLAY': ':0', 08:22:50 INFO - 'HOME': '/home/cltbld', 08:22:50 INFO - 'LANG': 'en_US.UTF-8', 08:22:50 INFO - 'LANGUAGE': 'en_US:en', 08:22:50 INFO - 'LOGNAME': 'cltbld', 08:22:50 INFO - 'MAIL': '/var/mail/cltbld', 08:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:50 INFO - 'MOZ_NO_REMOTE': '1', 08:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:50 INFO - 'NO_EM_RESTART': '1', 08:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:50 INFO - 'PWD': '/builds/slave/test', 08:22:50 INFO - 'SHELL': '/bin/bash', 08:22:50 INFO - 'SHLVL': '1', 08:22:50 INFO - 'TERM': 'linux', 08:22:50 INFO - 'TMOUT': '86400', 08:22:50 INFO - 'USER': 'cltbld', 08:22:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:50 INFO - '_': '/tools/buildbot/bin/python'} 08:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:50 INFO - Running setup.py (path:/tmp/pip-Lq511B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:50 INFO - Running setup.py (path:/tmp/pip-pJ9NeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:51 INFO - Running setup.py (path:/tmp/pip-_dCDVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:51 INFO - Running setup.py (path:/tmp/pip-KZ9dxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:51 INFO - Running setup.py (path:/tmp/pip-Ykewu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:51 INFO - Running setup.py (path:/tmp/pip-aMEbZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:51 INFO - Running setup.py (path:/tmp/pip-wtFKmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:51 INFO - Running setup.py (path:/tmp/pip-C7rqiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:51 INFO - Running setup.py (path:/tmp/pip-0N7304-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:51 INFO - Running setup.py (path:/tmp/pip-oOqVQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:51 INFO - Running setup.py (path:/tmp/pip-giB5gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:51 INFO - Running setup.py (path:/tmp/pip-FKv8Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:51 INFO - Running setup.py (path:/tmp/pip-2obHaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:51 INFO - Running setup.py (path:/tmp/pip-xG1jkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:51 INFO - Running setup.py (path:/tmp/pip-5rwMTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:51 INFO - Running setup.py (path:/tmp/pip-XxcJ9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:52 INFO - Running setup.py (path:/tmp/pip-ZpyNQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:52 INFO - Running setup.py install for manifestparser 08:22:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Running setup.py install for mozcrash 08:22:52 INFO - Running setup.py install for mozdebug 08:22:52 INFO - Running setup.py install for mozdevice 08:22:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Running setup.py install for mozfile 08:22:52 INFO - Running setup.py install for mozhttpd 08:22:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Running setup.py install for mozinfo 08:22:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Running setup.py install for mozInstall 08:22:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:52 INFO - Running setup.py install for mozleak 08:22:52 INFO - Running setup.py install for mozlog 08:22:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Running setup.py install for moznetwork 08:22:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Running setup.py install for mozprocess 08:22:53 INFO - Running setup.py install for mozprofile 08:22:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Running setup.py install for mozrunner 08:22:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Running setup.py install for mozscreenshot 08:22:53 INFO - Running setup.py install for moztest 08:22:53 INFO - Running setup.py install for mozversion 08:22:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:53 INFO - Cleaning up... 08:22:53 INFO - Return code: 0 08:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:53 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:53 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 08:22:53 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 08:22:53 INFO - Using env: {'DISPLAY': ':0', 08:22:53 INFO - 'HOME': '/home/cltbld', 08:22:53 INFO - 'LANG': 'en_US.UTF-8', 08:22:53 INFO - 'LANGUAGE': 'en_US:en', 08:22:53 INFO - 'LOGNAME': 'cltbld', 08:22:53 INFO - 'MAIL': '/var/mail/cltbld', 08:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:53 INFO - 'MOZ_NO_REMOTE': '1', 08:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:53 INFO - 'NO_EM_RESTART': '1', 08:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:53 INFO - 'PWD': '/builds/slave/test', 08:22:53 INFO - 'SHELL': '/bin/bash', 08:22:53 INFO - 'SHLVL': '1', 08:22:53 INFO - 'TERM': 'linux', 08:22:53 INFO - 'TMOUT': '86400', 08:22:53 INFO - 'USER': 'cltbld', 08:22:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:53 INFO - '_': '/tools/buildbot/bin/python'} 08:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:54 INFO - Running setup.py (path:/tmp/pip-wEtrjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:54 INFO - Running setup.py (path:/tmp/pip-tgjfPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:54 INFO - Running setup.py (path:/tmp/pip-01HbwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:54 INFO - Running setup.py (path:/tmp/pip-xq_uue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:54 INFO - Running setup.py (path:/tmp/pip-8Fa6yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:54 INFO - Running setup.py (path:/tmp/pip-EqVYKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:54 INFO - Running setup.py (path:/tmp/pip-HGSo0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:54 INFO - Running setup.py (path:/tmp/pip-uUIGuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:54 INFO - Running setup.py (path:/tmp/pip-4wRV0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:54 INFO - Running setup.py (path:/tmp/pip-AUMl0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:54 INFO - Running setup.py (path:/tmp/pip-VDrW7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:54 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)) 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:54 INFO - Running setup.py (path:/tmp/pip-jh6teI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:55 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)) 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:55 INFO - Running setup.py (path:/tmp/pip-_xdHMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:55 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)) 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:55 INFO - Running setup.py (path:/tmp/pip-xnAxXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:55 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)) 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:55 INFO - Running setup.py (path:/tmp/pip-onIEZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:55 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)) 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:55 INFO - Running setup.py (path:/tmp/pip-553uUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:55 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)) 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:55 INFO - Running setup.py (path:/tmp/pip-__wm8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:55 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)) 08:22:55 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)) 08:22:55 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)) 08:22:55 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)) 08:22:55 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)) 08:22:55 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)) 08:22:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:57 INFO - Downloading blessings-1.6.tar.gz 08:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:57 INFO - Installing collected packages: blessings 08:22:57 INFO - Running setup.py install for blessings 08:22:57 INFO - Successfully installed blessings 08:22:57 INFO - Cleaning up... 08:22:57 INFO - Return code: 0 08:22:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:57 INFO - Reading from file tmpfile_stdout 08:22:57 INFO - Current package versions: 08:22:57 INFO - argparse == 1.2.1 08:22:57 INFO - blessings == 1.6 08:22:57 INFO - blobuploader == 1.2.4 08:22:57 INFO - docopt == 0.6.1 08:22:57 INFO - manifestparser == 1.1 08:22:57 INFO - mozInstall == 1.12 08:22:57 INFO - mozcrash == 0.17 08:22:57 INFO - mozdebug == 0.1 08:22:57 INFO - mozdevice == 0.48 08:22:57 INFO - mozfile == 1.2 08:22:57 INFO - mozhttpd == 0.7 08:22:57 INFO - mozinfo == 0.9 08:22:57 INFO - mozleak == 0.1 08:22:57 INFO - mozlog == 3.2 08:22:57 INFO - moznetwork == 0.27 08:22:57 INFO - mozprocess == 0.22 08:22:57 INFO - mozprofile == 0.28 08:22:57 INFO - mozrunner == 6.11 08:22:57 INFO - mozscreenshot == 0.1 08:22:57 INFO - mozsystemmonitor == 0.3 08:22:57 INFO - moztest == 0.7 08:22:57 INFO - mozversion == 1.4 08:22:57 INFO - psutil == 3.1.1 08:22:57 INFO - requests == 1.2.3 08:22:57 INFO - wsgiref == 0.1.2 08:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:57 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:57 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 08:22:57 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 08:22:57 INFO - Using env: {'DISPLAY': ':0', 08:22:57 INFO - 'HOME': '/home/cltbld', 08:22:57 INFO - 'LANG': 'en_US.UTF-8', 08:22:57 INFO - 'LANGUAGE': 'en_US:en', 08:22:57 INFO - 'LOGNAME': 'cltbld', 08:22:57 INFO - 'MAIL': '/var/mail/cltbld', 08:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:57 INFO - 'MOZ_NO_REMOTE': '1', 08:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:57 INFO - 'NO_EM_RESTART': '1', 08:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:57 INFO - 'PWD': '/builds/slave/test', 08:22:57 INFO - 'SHELL': '/bin/bash', 08:22:57 INFO - 'SHLVL': '1', 08:22:57 INFO - 'TERM': 'linux', 08:22:57 INFO - 'TMOUT': '86400', 08:22:57 INFO - 'USER': 'cltbld', 08:22:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:57 INFO - '_': '/tools/buildbot/bin/python'} 08:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 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)) 08:22:57 INFO - Cleaning up... 08:22:57 INFO - Return code: 0 08:22:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:57 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:22:57 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 08:22:57 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 08:22:57 INFO - Using env: {'DISPLAY': ':0', 08:22:57 INFO - 'HOME': '/home/cltbld', 08:22:57 INFO - 'LANG': 'en_US.UTF-8', 08:22:57 INFO - 'LANGUAGE': 'en_US:en', 08:22:57 INFO - 'LOGNAME': 'cltbld', 08:22:57 INFO - 'MAIL': '/var/mail/cltbld', 08:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:57 INFO - 'MOZ_NO_REMOTE': '1', 08:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:57 INFO - 'NO_EM_RESTART': '1', 08:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:57 INFO - 'PWD': '/builds/slave/test', 08:22:57 INFO - 'SHELL': '/bin/bash', 08:22:57 INFO - 'SHLVL': '1', 08:22:57 INFO - 'TERM': 'linux', 08:22:57 INFO - 'TMOUT': '86400', 08:22:57 INFO - 'USER': 'cltbld', 08:22:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:57 INFO - '_': '/tools/buildbot/bin/python'} 08:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:58 INFO - Downloading/unpacking jsonschema 08:22:58 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 08:22:58 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 08:22:58 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 08:22:58 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 08:22:58 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 08:22:58 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 08:23:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:00 INFO - Downloading/unpacking functools32 (from jsonschema) 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:00 INFO - warning: no files found matching '*.txt' 08:23:00 INFO - no previously-included directories found matching 'build' 08:23:00 INFO - no previously-included directories found matching 'dist' 08:23:00 INFO - no previously-included directories found matching '.git*' 08:23:00 INFO - Installing collected packages: jsonschema, functools32 08:23:00 INFO - Running setup.py install for functools32 08:23:00 INFO - warning: no files found matching '*.txt' 08:23:00 INFO - no previously-included directories found matching 'build' 08:23:00 INFO - no previously-included directories found matching 'dist' 08:23:00 INFO - no previously-included directories found matching '.git*' 08:23:00 INFO - Successfully installed jsonschema functools32 08:23:00 INFO - Cleaning up... 08:23:00 INFO - Return code: 0 08:23:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:23:00 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')]} 08:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:00 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')]} 08:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:00 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 0x7f65a4740f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, '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': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', '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 08:23:00 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 08:23:00 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 08:23:00 INFO - Using env: {'DISPLAY': ':0', 08:23:00 INFO - 'HOME': '/home/cltbld', 08:23:00 INFO - 'LANG': 'en_US.UTF-8', 08:23:00 INFO - 'LANGUAGE': 'en_US:en', 08:23:00 INFO - 'LOGNAME': 'cltbld', 08:23:00 INFO - 'MAIL': '/var/mail/cltbld', 08:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:00 INFO - 'MOZ_NO_REMOTE': '1', 08:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:00 INFO - 'NO_EM_RESTART': '1', 08:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:00 INFO - 'PWD': '/builds/slave/test', 08:23:00 INFO - 'SHELL': '/bin/bash', 08:23:00 INFO - 'SHLVL': '1', 08:23:00 INFO - 'TERM': 'linux', 08:23:00 INFO - 'TMOUT': '86400', 08:23:00 INFO - 'USER': 'cltbld', 08:23:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:00 INFO - '_': '/tools/buildbot/bin/python'} 08:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:00 INFO - Downloading/unpacking flake8 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:00 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 08:23:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:23:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:23:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:23:03 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 08:23:03 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 08:23:03 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 08:23:03 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 08:23:03 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 08:23:03 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 08:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:03 INFO - no previously-included directories found matching 'docs/_build' 08:23:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:23:03 INFO - Running setup.py install for pep8 08:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:03 INFO - no previously-included directories found matching 'docs/_build' 08:23:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:23:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:23:03 INFO - Cleaning up... 08:23:03 INFO - Return code: 0 08:23:03 INFO - Running post-action listener: _resource_record_post_action 08:23:03 INFO - Running post-action listener: _start_resource_monitoring 08:23:03 INFO - Starting resource monitoring. 08:23:03 INFO - ##### 08:23:03 INFO - ##### Finished create-virtualenv step (success) 08:23:03 INFO - ##### 08:23:03 INFO - ##### 08:23:03 INFO - ##### Running install step. 08:23:03 INFO - ##### 08:23:03 INFO - Running pre-action listener: _resource_record_pre_action 08:23:03 INFO - Running main action method: install 08:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:03 INFO - Reading from file tmpfile_stdout 08:23:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:03 INFO - Reading from file tmpfile_stdout 08:23:03 INFO - Output received: 08:23:03 INFO - Usage: mozinstall [options] installer 08:23:03 INFO - Options: 08:23:03 INFO - -h, --help show this help message and exit 08:23:03 INFO - -d DEST, --destination=DEST 08:23:03 INFO - Directory to install application into. [default: 08:23:03 INFO - "/builds/slave/test"] 08:23:03 INFO - --app=APP Application being installed. [default: firefox] 08:23:03 INFO - mkdir: /builds/slave/test/build/application 08:23:03 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'] 08:23:03 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 08:23:19 INFO - Reading from file tmpfile_stdout 08:23:19 INFO - Output received: 08:23:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:19 INFO - Running post-action listener: _resource_record_post_action 08:23:19 INFO - ##### 08:23:19 INFO - ##### Finished install step (success) 08:23:19 INFO - ##### 08:23:19 INFO - ##### 08:23:19 INFO - ##### Running run-tests step. 08:23:19 INFO - ##### 08:23:19 INFO - Running pre-action listener: _resource_record_pre_action 08:23:19 INFO - Running main action method: run_tests 08:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:19 INFO - Python 2.7.3 08:23:19 INFO - Return code: 0 08:23:19 INFO - grabbing minidump binary from tooltool 08:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:19 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 0x26f29c0>, '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 0x26f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:19 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 08:23:19 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 08:23:19 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 08:23:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:19 INFO - Return code: 0 08:23:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:23:20 INFO - Return code: 0 08:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 08:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 08:23:20 INFO - Using env: {'DISPLAY': ':0', 08:23:20 INFO - 'HOME': '/home/cltbld', 08:23:20 INFO - 'LANG': 'en_US.UTF-8', 08:23:20 INFO - 'LANGUAGE': 'en_US:en', 08:23:20 INFO - 'LOGNAME': 'cltbld', 08:23:20 INFO - 'MAIL': '/var/mail/cltbld', 08:23:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:20 INFO - 'MOZ_NO_REMOTE': '1', 08:23:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:20 INFO - 'NO_EM_RESTART': '1', 08:23:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:20 INFO - 'PWD': '/builds/slave/test', 08:23:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:20 INFO - 'SHELL': '/bin/bash', 08:23:20 INFO - 'SHLVL': '1', 08:23:20 INFO - 'TERM': 'linux', 08:23:20 INFO - 'TMOUT': '86400', 08:23:20 INFO - 'USER': 'cltbld', 08:23:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165', 08:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:20 INFO - '_': '/tools/buildbot/bin/python'} 08:23:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 08:23:20 INFO - mozversion application_buildid: 20160518073552 08:23:20 INFO - mozversion application_changeset: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 08:23:20 INFO - mozversion application_display_name: Nightly 08:23:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:20 INFO - mozversion application_name: Firefox 08:23:20 INFO - mozversion application_remotingname: firefox 08:23:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:23:20 INFO - mozversion application_vendor: Mozilla 08:23:20 INFO - mozversion application_version: 49.0a1 08:23:20 INFO - mozversion platform_buildid: 20160518073552 08:23:20 INFO - mozversion platform_changeset: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 08:23:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:23:20 INFO - mozversion platform_version: 49.0a1 08:23:20 INFO - using testdate: 1463585000 08:23:20 INFO - actual date: 1463585000 08:23:20 INFO - starting webserver on 'localhost:51341' 08:23:20 INFO - SUITE-START | Running 2 tests 08:23:20 INFO - TEST-START | dromaeo_css 08:23:20 INFO - operating with platform_type : linux_ 08:23:20 INFO - Initialising browser for dromaeo_css test... 08:23:20 INFO - TEST-INFO | started process 21441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpglTkzY/profile http://localhost:51341/getInfo.html) 08:23:25 INFO - PROCESS | 21441 | __metrics Screen width/height:1600/1200 08:23:25 INFO - PROCESS | 21441 | colorDepth:24 08:23:25 INFO - PROCESS | 21441 | Browser inner width/height: 1024/697 08:23:25 INFO - PROCESS | 21441 | __metrics 08:23:26 ERROR - PROCESS | 21441 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:23:27 INFO - TEST-INFO | 21441: exit 0 08:23:27 INFO - Browser initialized. 08:23:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:27 INFO - TEST-INFO | started process 21524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpglTkzY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:39 INFO - PROCESS | 21524 | RSS: Main: 154591232 08:23:39 INFO - PROCESS | 21524 | 08:24:29 INFO - PROCESS | 21524 | 1463585069990 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] 08:26:42 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51341/tests/dromaeo/cssquery-ext.html) 08:26:43 INFO - PROCESS | 21524 | RSS: Main: 232169472 08:26:43 INFO - PROCESS | 21524 | 08:29:46 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-ext.html (next: http://localhost:51341/tests/dromaeo/cssquery-jquery.html) 08:29:47 INFO - PROCESS | 21524 | RSS: Main: 239034368 08:29:47 INFO - PROCESS | 21524 | 08:32:49 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51341/tests/dromaeo/cssquery-mootools.html) 08:32:50 INFO - PROCESS | 21524 | RSS: Main: 235278336 08:32:50 INFO - PROCESS | 21524 | 08:35:52 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51341/tests/dromaeo/cssquery-prototype.html) 08:35:52 INFO - PROCESS | 21524 | RSS: Main: 235900928 08:35:52 INFO - PROCESS | 21524 | 08:38:55 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51341/tests/dromaeo/cssquery-yui.html) 08:38:56 INFO - PROCESS | 21524 | RSS: Main: 207474688 08:38:56 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | Cycle 1(1): loaded http://localhost:51341/tests/dromaeo/cssquery-yui.html (next: http://localhost:51341/tests/dromaeo/cssquery-dojo.html) 08:41:59 INFO - PROCESS | 21524 | RSS: Main: 264826880 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | __start_tp_report 08:41:59 INFO - PROCESS | 21524 | _x_x_mozilla_page_load 08:41:59 INFO - PROCESS | 21524 | _x_x_mozilla_page_load_details 08:41:59 INFO - PROCESS | 21524 | |i|pagename|runs| 08:41:59 INFO - PROCESS | 21524 | |0;dojo.html;2686.7984901132418;2698.0287096645216;2723.896821787176;2735.9042433514833;2759.3377589378556;4684.086603112394;4742.217534106872;4755.286706993953;4827.613790896724;4879.536444037815;4758.857234282968;4783.35424717663;4811.158047341719;4821.493743156971;4823.204171311738;4188.560201178878;4331.956680433194;4420.734755914639;4456.754878481682;4574.428196475441;4503.324501324795;4503.684742068057;4531.546845315475;4533.773311334437;4582.518835522272;4365.49796773372;4406.405135306757;4408.801603927799;4428.0479696865;4436.334549817521;4381.693281470299;4395.53846846083;4413.536578659258;4441.222786012435;4464.374987501752;4423.889402764925;4434.822607095713;4435.423394958667;4438.356438316426;4484.573965473275;4590.540945905416;4637.5130611286;4682.321063445781;4688.109259240768;4749.691270067435;5159.974200128975;5163.302954101224;5168.508991645787;5179.067767801795;5181.171012637998;5151.407588127376;5230.032443997872;5242.030224408497;5242.056429842627;5243.082460569385;4701.952980470186;4808.519148085164;4817.084753896748;4828.8792780180775;4920.384951881015;5337.226102215157;5349.625526213205;5381.19282107687;5384.703841288689;5388.272583201296;4881.731504767201;5081.695098294114;5103.540681338697;5142.254373115878;5149.330587023663;5120.257562653394;5156.5616922562;5160.380754309507;5168.2764412982215;5179.8446046618665;5119.206522988943;5134.306868572769;5137.152369859006;5145.434002259748;5193.558547523503;4961.231009193581;4979.3526841510375;5140.460251673595;5144.279800827887;5153.175491921274;4347.1740369330355;4354;4371.344298355272;4411.029573493826;4419.64642828573;3773.1699026214187;3790.033541446913;3792.4500947362476;3831.0230891122587;3836.501254836853;4324.524302326741;4368.060866913565;4378.430803995524;4384.0355121873135;4438.6005259526155;5113;5123.462036486189;5132.153194722829;5139.871503212375;5219.6607220531305;4465.620422264079;4480.887977800581;4491.483479399845;4492.640588752892;4532.229520981441;4578.336141259499;4643.466001409881;4649.674522783373;4685.01614660925;4690.366800481959;4909.656324057281;4926.039422312615;4926.334944782552;4937.950620493749;4969.453360130455;5176.1200595898035;5188.481151884781;5193.350831146106;5202.583793296603;5217.217417387271;4731.763411829464;4901.598216873777;4938.8765280868265;4992.226204938241;4996.425411077773;5114.514121158484;5125.231215317583;5129.666571672829;5138.254953031715;5171.741412929414;5190.039842629126;5202.895942081062;5205.6616319939085;5208.296879921162;5261;4900.338454308765;4949.406071271471;4968.677035992649;4982;5045.697258164522;4980.377452818398;4982.10322142018;4991.9001619966675;4996.200607902718;5039.143345631178;4979.452260251442;4988.775505102351;5049.671771334852;5049.990001999541;5052.115879721107;4958.528939750718;5006.674566153189;5014.247862820606;5045.394552653705;5072.9746351268;4928.211486162197;4946.109700253989;4946.134426475424;4953.603711703127;5004.3994720633755 08:41:59 INFO - PROCESS | 21524 | |1;ext.html;574.1703238819907;598.9520838332928;599.2599140062024;602.9719328544829;615.8491169663432;41430.34278628855;42833.78583107084;42847.143057138914;42877.57122428775;47045.52954470454;44916.3262551062;45294.547054529445;45373.77313113438;45452.77273613636;45462;7597.696092156335;8026.7591972240925;8179.631916563739;10090.293679442442;10315.690529284133;10231.334963227404;10335.224858135633;10341.327813692124;10343.327683700572;10351.792964140712;10448.425336606484;10497.160227181806;10502.107320877734;10502.212334074937;10503.78992420155;7714.305712485875;10119.848202276971;10312.535935882903;10329.638462653771;10732.517036733365;10191.235657325657;10263.794724105475;10264.435456049914;10268.383896966132;10272.537735801907;40536.79731601352;40877;40933.59066409327;40951.7952410239;40997.59002409968;2928.751056160229;3037.9392412151856;3055.236190952262;3096.90709278722;3147.763917706181;30344.54483182754;30606.54090188649;30764.846175768977;30958.22604434907;31718;3492.196794737199;3514.6661067198575;3529.8764543240864;3541.3271478419274;3546.131197856542;275665;275930;277502;277938;278029;56736.71631641898;57840;57843;57910.71044644834;57914.7104264476;35099.82450087784;35904.64095359065;35944.46083308753;37666.81166594204;37806.43290350647;13579.388927498287;13828.170309781446;13858.722825543635;13921.443142274196;13956.441742330397;10166.644167454104;10454.947725261325;10464.424456654957;10698.51856666452;10718.73203169927;19285.51786205328;19736.802631973784;19882;19897.403077907686;19911.900440497706;7169.749058782918;7237.819054523574;7301.123865136217;7324.816879578053;7380.188179300273;873.3842640938124;931.3434029009532;942.7124726958207;1043.108142538119;1051.1905832508926;29184.7081529182;29696.851515742284;29721.702782972327;29731.405371892874;30207.848960755055;983.5672304186136;1009.5911155981839;1020.4336593190702;1023.3603997501561;1068.8129577323937;15393.384264629512;15406.768898466533;15639.374425022872;15703.547040308946;15875.920620397055;391224;392856;393120;393937;396732;53463;54077.72961135169;54085.45914540883;54120.18819717707;54197;1134.7617000430002;1179.7907145176264;1238.6098379010764;1242.2608547913976;1273.2742336868082;29075.127746167647;30142.84928575343;30270;30482.39035219239;30723.846380767955;43960.560394395645;44791.55208447874;44816.55183448124;44845.32732008957;44881.77559112314;284376;289612;289753;289829;289895;23127.3061808146;26546.336341591614;42466;42613;43549.56450435455;41705.79147104245;46591.767041164574;46634.300485492065;46950.53049469461;47496.52503474921;37497.2500549982;39254.80372598119;39657.60342396539;40162.19675606413;40497.14034315901;37916.05209869775;37990.62009379871;38476.80761596286;39152.608473914894;39533;38575.42136868005;38996.93039904907;39333.80333098316;39797.80101099476;39826.20347592974;33441.49837752484;34747.468692710645;35436;35552.46671299881;35648.4652730204;26509.60235596506;26534.60198097069;27049.59425608657;27156.519174336012;27487.31281717973 08:41:59 INFO - PROCESS | 21524 | |2;jquery.html;380.79330281021475;384.5769653381281;391.35621901971274;401.1535659757912;408.58528593477627;16083.51749447517;16754.246058927347;17690.380836670734;17717.291308347667;17743.822561774377;16384.508464746075;16544.090075045868;16618.83381166188;17496.387626433076;17504.21231044603;4987.052460032601;5174.223866420049;5175.585953123741;5183.870403239912;5199.974000129994;3680.576733675635;3755.9436608450897;3821.8280177391944;5328.600354973373;5957.463828255456;5874.0014197586515;5894.911576326359;5898.469137777599;5912.231409916726;5915.260592425947;5363.54409875161;5658.74535645897;5669.348024977118;5751.884962300773;5864.179014937912;3466.5666791651042;5198.896022079537;5483.698396588186;5491.039068163095;5570.554355651539;12864.421101050475;12989.285589292585;13057.21656700601;17136.828631713648;21050.473738156514;1782.1712903499806;1867.2717640120363;1937.0702063009835;1960.0885588201413;2043.6627956387179;9732.854007189897;9848;11161.609343672932;11245.212835101545;13813.240271785047;1703.1228917107699;1745.441458733206;1750.5798608333907;1751.5533538947614;1809.3757653609484;46801;64037.67981160065;64091;65624.6718766403;73745.99999999946;9529.437470205083;9632.855507167258;9833.655822046194;9834.606615735434;9837.311388202757;12637.43131559082;12645.241285522898;12714.61856144317;13004.089713720137;13107.934460327828;6729.764458243938;6738.629375384401;6831.487638427137;6840.760573379908;6916.066331045345;6590.077389165521;6652.501062420338;6683.799486015428;6695.430888374445;6961.303869612998;4029.37544680575;4064.9593504064583;4070.3894415837863;4187.790610469464;4587.334836448763;1857.0993068361834;1870.139735721556;1872.2604571194302;1888.3673969220465;1924.5469670399038;854.3080105114752;866.3026263857655;948.2745699539857;978.951052447389;999.2206079258191;16345.182740862909;17048.829511704724;17148.314067437164;17328.39350622722;17905.10474476271;855.6224478589465;894.5661354243186;903.5121034641352;915.3135148638521;922.3681777982104;9504.857427138599;9872.950635246778;9981.950090249647;10000.599976000878;10011.599536018477;366771;370661;379006;380217;382923;72943.2705672947;73475;74152;74398;74535;917.4495302818389;919.5907821019582;937.681188395935;939.8402271613979;948.5731420860641;15285.159316237714;15301.6174595636;15412.922935385252;15736.92131539335;15944.601384965468;34162.48756268608;34313.48529772006;34545.30909381748;35808;36351;48780.53658390254;49639.503604964935;51772.74113629558;52835;53958.730206348715;10830.458477076272;11568.24806387582;11865.406729663655;12068.637940861789;12097.697557561132;12035.518579256732;12779.233246004898;12853.228806271654;12989.870101299244;13255.536056237985;10931.234813562975;10994.065504432212;11025.336302717207;11043.558257669603;11171.441427928734;4697.812087516461;8418.69510225916;9616.75958101025;11498.94250528742;11713.531458741554;8220.301274391504;9553.856692149484;10942.23404361687;11340.6030788922;11721.648350549498;11516.712082197677;11746.765064698488;11752.294862308288;11810.645680629596;11883.881161188623;11198.944005279922;11215.66353009411;11217.831732524182;11222.270552414067;11307.491162897853 08:41:59 INFO - PROCESS | 21524 | |3;mootools.html;1285.2288626823902;1464.084946908182;1507.246376811594;1623.1478473801253;1788.651213013462;6583.07836902834;7689.769306920787;7891.1714270001685;7897.368210543157;8089.150639182874;7879.369650427966;8009.39929505288;8015.839683206333;8029.237222463857;8044.6782128714785;2285.942851428715;2320.6983092198075;2322.4774425754154;2324.1400681747778;2324.6280595104786;2282.1784157703214;2303.6544518322216;2323.453988312745;2325.3024092772184;2325.9651105233434;2280.737715162761;2290.2442194075998;2303.6544518322216;2315.2938353802083;2316.2819525946925;2234.3855439754034;2260.9660855087186;2263.8528495647893;2265.354374003401;2269.8297627677907;2228.8551244169075;2235.2400183937375;2237.1387015998794;2237.407087121914;2239.8320125990617;7757.612119394064;7811.570363629998;7908.090569584514;7923.0888447828665;8040.477368971056;4613.077384523109;4742.122707299126;4749.762511874427;4750.239961606127;4754.429468463772;2965.5106907360478;3012.3824615953677;3017.351269477051;3031.0906727981737;3075.4771688812957;950.8288508068545;952.6570434643522;955.1403736637013;956.086936975187;964.6382606522554;10779;10823.67528974132;10835.18736094788;10848.566057357775;10848.837267440995;4100.5899410058755;4198.664106871504;4234.470691163605;4255.829766809355;4268.103698223345;8632.611532481053;8666;8677.088905664941;8677.783055423539;8678.218960293603;4525.389072475239;4570.588647021784;4578.038611891474;4579.542045795461;4580.564846339593;3801.087738942689;4133.565975572522;4167.354060120686;4273.380359847804;4279.786010699452;3543.8936831895085;3563.0736008637423;3617.7467577269863;3641.3809652359164;3642.907127861631;1051.2588625019343;1057.9682609521726;1058.7617785998088;1066.3015724700333;1072.2815713471994;727.665273973978;752.2890868129565;902.251131560816;910.9407888487227;911.2300106410073;5204.386640141568;5531.1426728857095;5572.888542229214;5574.358948720868;5652.2652055233375;455.3670398146579;471.24365393543553;473.4507970753909;484.2179879494591;597.4801922327603;3646.5624125105155;3774.698024158061;3869.3808990561374;3875.670568001695;3876.7480113792512;9430.387024843363;9703.07820757027;9736.610535578639;9804;9858;9723.708288751348;9738.659146929824;9766.169875560516;9766.511674416251;9812.215022798158;7265.745698900513;7420.628968551551;7539.1706912238515;7540.849183016309;7561.130469995911;5391.16436952273;5402.540784033401;5423.2407462954425;5456.0451920914475;5526.668399896019;9057;9069.18377346042;9077.546122693971;9159.908400915905;9211.078892110736;8855.291576673979;9192.126747958933;9210.078992100736;9226.077392260988;9230.907690923004;6468.708908099053;6539.574927629689;6550.475961922939;6557.508186886098;6565;7294.781156565312;7328.853422931618;7353.889691654736;7363.337299643058;7383.446241532014;6954;7028.437724981887;7111;7111.466640001917;7204.9639751800905;6856.24581296047;6873.178607669071;6898.793036208922;6976.965115174392;7068.858622827617;6356.4279214870885;6365.077063825812;6411.6794160290865;6426.550141490051;6432.35676432353;4560.954390456053;4578;4718.032803275251;4775.594074503706;4826.107170173529;4891.80432782699;4936.629752768628;4952.529509696573;4970.304157417892;4993.775280112476 08:41:59 INFO - PROCESS | 21524 | |4;prototype.html;304.5127795527157;307.5310152018172;307.93225490392103;316.91126484584316;322.64509040055935;4845.757712114389;4846.975765121169;4849.345338379318;4849.987255289056;4880.316755654207;4727.52724727527;4737.8392293887955;4745.674619436477;4773.164696178173;4777.856664300068;3624.746267761258;3727.8881633551036;3747.5128233329765;3764.3976963685814;3785.1104990327253;3696.890932720187;3732.4401339798974;3838.6161383861668;3848.037990502374;3853.537575490945;3768.2840260350445;3777.263433630443;3790.128270497787;3798.240351929625;3805.219929914375;3593.443016332473;3778.9811050944845;3787.6591106800383;3805.809709514527;3818.293615681108;3278.8688452461874;3291.243014106769;3310.0731795097413;3322.5182348559324;3328.567286252796;4599.172149013176;4619.284010978304;4620.1221767864;4628.583427491542;4659.7204167749705;4074.490688663917;4231.449911511515;4262.381954616563;4262.65898728101;4289.356596510548;4923.286123512071;4931.7040977541465;4984.725840078794;5007.6244281678655;5013.468198559704;3553.289342131584;3559.857605695769;3569.5716514018222;3585.964140358615;3601.6398360164035;5090.9236361454605;5200.427952925175;5201.9479805201845;5225.085610018232;5233.633645644806;3660.213054193361;3661.5972243053243;3685.5024571683016;3686.2074653948994;3689.317476266899;3725.7950812705562;3741.962580374216;3742.4468845429387;3752.399616061417;3756.887293381203;4291;4292.613664770123;4293.785310734514;4299.419578356944;4320.740755554677;4935.8025678972435;5051.595872330205;5055.393352797614;5057.72182529957;5071.771770270347;1282.2306616030307;1292.3409061378763;1292.424870932445;1293.5925183567147;1301.362332457108;793.0008189680929;816.1267443835039;822.7408366364576;825.6821123867354;831.9708810191614;4341.2402829505345;4467.30756732707;4471.8434854779925;4473.530279320689;4485.259932111165;5117.232415137759;5144.7942082316285;5149.871253218699;5153.7165455900285;5164.535191832753;4458.331250312479;4476.4180656514445;4491.483479399845;4495.9325610115875;4505.5269196734525;2574.635443215099;2722.891084356643;2751.7248275172724;2754.352727109128;2775.1119641714863;4925.605951523869;4928.6303527235605;4978.6763860348965;4985.850424487271;4998.325226094431;5057.468965758616;5268.262443257947;5275.182346736262;5301.655392399482;5331.30693009914;4952.306677065142;4979;4982.800687972513;4985.725785081783;4993.300937868701;5198.688078715138;5209.661372010807;5224.50367215114;5228.189630607262;5230.215467679726;4890.975545122252;5107.693538387709;5128.769205385692;5143.434222235476;5144.228365745168;4983.725895075806;4992.80028798844;4994.076095922266;5004.17431123875;5013.172826483736;3661.2860492203763;3671.4676371926457;3673.7979411132646;3674.210044840372;3678.779273243614;5083.46623604531;5206.672298563842;5219.660722053054;5233.345831771028;5242.5281724644965;5081.949180508148;5087.0414890266775;5092.490750924878;5099.3370861787735;5111.463296353978;5089.541941225308;5089.643724939367;5090.4655011223285;5090.465501122477;5103.260027295947;4834.299026641188;4964.826231081895;5011.523905228997;5011.574016208663;5012.69669885825;4886.2165309661;4920.360353154067;5052.924206136984;5056.82301119459;5109.08036553424;4949.208126699711;4953.455119936876;4961.925571116509;4963.602911767122;4989.326440930573 08:41:59 INFO - PROCESS | 21524 | |5;yui.html;742.5544673196082;769.9499532530385;773.8916551682765;781;783.377215113984;12331.136820422575;12444.44000019999;12603.495860165582;12611.369431528432;12615.747685046294;13170.67073323165;13763.311834408265;13795.448182072705;14222.573322800306;14274;682.1643486728742;877.6006916852832;881.4358810361374;885.8184072265202;885.9069797671249;841.167244428018;866.7399780065987;869.0874581689201;870.0125357718971;871.4814685262259;923.9630414783401;924.0713083351222;927.2998885841181;927.6845872403381;928.0533855467419;727.0911360799001;885.6501681835704;918.7243826851951;919.1589695428675;919.420764918104;673.1619134177931;677.0487465111477;677.2651672934871;677.4715721737053;677.7221339250883;13169.144005639602;13226.470941162343;13228.537001205008;13255.73488530224;13255.801162982563;11465.426728663617;11640.359780212086;11849.641766619441;11925.642230733005;12384.690382740413;11386.772264554662;11431.314121152674;11547.769044619145;11552.480138393792;11604.709882252926;4134.255833949888;4194.601512856274;4245.129748401601;4246.681498887565;4391.5169331373845;50823.23765143526;51476.48523514754;51560.74219628915;51727.74136129295;51923.74038129785;9085.68200113006;9183.90816091844;9269.629214831466;9411.152996230372;9417.293702972305;16061.759073613905;16700.331986720394;16983.575410614834;17020.829791702174;17060.40288589918;6286.277078135981;6364.968175159094;6497.155369801895;6536.117624120778;6699.263081061079;3654.506641603403;3703.925921481555;3741.8213262822123;3742.9812850936114;3800.505934228588;2833.0650885207833;2922.678505364408;2925.13708456006;2928.736413722733;2929.062699936;548.3091304955784;552.4089224529714;558.3885645218479;570.9437540549949;575.4015823543551;440.4780335302677;451.38441086894215;465.26488148724934;537.9435159308294;540.5837505121035;7174.964125179341;7269.345758881726;7387.7783666490095;7627.177944160696;7929.5242285463055;546.0062685911682;596.7225240263211;598.4225222660067;604.338249616669;606.6141794823451;3594.4967704521387;3722.4230244312175;3730.3658378075793;3948.933787877257;4050.8784736457956;61334;61633.38366616366;63425.36574634287;63914;64074.679626601566;55346;55426;55586;56263.43736562664;57261.42738572644;49481.752591237535;50117;50314.49685503171;50440.74779626078;51510.48489515057;7883.44815862907;7955.681772729257;7963.362930965624;8090.635921383434;8209.79475513117;32735.83632081824;33005.51475183671;33012.66987330192;33167;33452.163695907795;41099;43532.782336088116;44100.55899441093;44710.10579788321;45247.547524524336;11303.265287756269;11312.830307545559;11363.147763917574;11445.427728613702;11527.88472115268;11719.35543545079;11916.582919597773;12138.33239171854;12232.694182645506;13198.160514422309;7078.575285482888;8134.796630084058;11077.390743508862;11113.666590001989;11221;11147.609833655782;11684.1236907234;12327.50689972391;12387.431162941439;12404.069694773108;10526.368417894952;10722.195835312226;10780.407077610807;11011.284266522971;11136.610218642309;8923.955380223057;9210.171084602418;9434.292428067785;9733;9747.610095596381;9417.717468475958;9549.236061115233;9698.224142068759;9922.751931201488;9973.950130249303 08:41:59 INFO - PROCESS | 21524 | __end_tp_report 08:41:59 INFO - PROCESS | 21524 | __start_cc_report 08:41:59 INFO - PROCESS | 21524 | _x_x_mozilla_cycle_collect,1071 08:41:59 INFO - PROCESS | 21524 | __end_cc_report 08:41:59 INFO - PROCESS | 21524 | __startTimestamp1463586119606__endTimestamp 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | ------- Summary: start ------- 08:41:59 INFO - PROCESS | 21524 | Number of tests: 6 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#0] dojo.html Cycles:165 Average:4769.70 Median:4928.21 stddev:503.81 (10.2%) stddev-sans-first:478.12 08:41:59 INFO - PROCESS | 21524 | Values: 2686.8 2698.0 2723.9 2735.9 2759.3 4684.1 4742.2 4755.3 4827.6 4879.5 4758.9 4783.4 4811.2 4821.5 4823.2 4188.6 4332.0 4420.7 4456.8 4574.4 4503.3 4503.7 4531.5 4533.8 4582.5 4365.5 4406.4 4408.8 4428.0 4436.3 4381.7 4395.5 4413.5 4441.2 4464.4 4423.9 4434.8 4435.4 4438.4 4484.6 4590.5 4637.5 4682.3 4688.1 4749.7 5160.0 5163.3 5168.5 5179.1 5181.2 5151.4 5230.0 5242.0 5242.1 5243.1 4702.0 4808.5 4817.1 4828.9 4920.4 5337.2 5349.6 5381.2 5384.7 5388.3 4881.7 5081.7 5103.5 5142.3 5149.3 5120.3 5156.6 5160.4 5168.3 5179.8 5119.2 5134.3 5137.2 5145.4 5193.6 4961.2 4979.4 5140.5 5144.3 5153.2 4347.2 4354.0 4371.3 4411.0 4419.6 3773.2 3790.0 3792.5 3831.0 3836.5 4324.5 4368.1 4378.4 4384.0 4438.6 5113.0 5123.5 5132.2 5139.9 5219.7 4465.6 4480.9 4491.5 4492.6 4532.2 4578.3 4643.5 4649.7 4685.0 4690.4 4909.7 4926.0 4926.3 4938.0 4969.5 5176.1 5188.5 5193.4 5202.6 5217.2 4731.8 4901.6 4938.9 4992.2 4996.4 5114.5 5125.2 5129.7 5138.3 5171.7 5190.0 5202.9 5205.7 5208.3 5261.0 4900.3 4949.4 4968.7 4982.0 5045.7 4980.4 4982.1 4991.9 4996.2 5039.1 4979.5 4988.8 5049.7 5050.0 5052.1 4958.5 5006.7 5014.2 5045.4 5073.0 4928.2 4946.1 4946.1 4953.6 5004.4 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#1] ext.html Cycles:180 Average:48895.03 Median:19119.83 stddev:84950.90 (444.3%) stddev-sans-first:85111.74 08:41:59 INFO - PROCESS | 21524 | Values: 574.2 599.0 599.3 603.0 615.8 41430.3 42833.8 42847.1 42877.6 47045.5 44916.3 45294.5 45373.8 45452.8 45462.0 7597.7 8026.8 8179.6 10090.3 10315.7 10231.3 10335.2 10341.3 10343.3 10351.8 10448.4 10497.2 10502.1 10502.2 10503.8 7714.3 10119.8 10312.5 10329.6 10732.5 10191.2 10263.8 10264.4 10268.4 10272.5 40536.8 40877.0 40933.6 40951.8 40997.6 2928.8 3037.9 3055.2 3096.9 3147.8 30344.5 30606.5 30764.8 30958.2 31718.0 3492.2 3514.7 3529.9 3541.3 3546.1 275665.0 275930.0 277502.0 277938.0 278029.0 56736.7 57840.0 57843.0 57910.7 57914.7 35099.8 35904.6 35944.5 37666.8 37806.4 13579.4 13828.2 13858.7 13921.4 13956.4 10166.6 10454.9 10464.4 10698.5 10718.7 19285.5 19736.8 19882.0 19897.4 19911.9 7169.7 7237.8 7301.1 7324.8 7380.2 873.4 931.3 942.7 1043.1 1051.2 29184.7 29696.9 29721.7 29731.4 30207.8 983.6 1009.6 1020.4 1023.4 1068.8 15393.4 15406.8 15639.4 15703.5 15875.9 391224.0 392856.0 393120.0 393937.0 396732.0 53463.0 54077.7 54085.5 54120.2 54197.0 1134.8 1179.8 1238.6 1242.3 1273.3 29075.1 30142.8 30270.0 30482.4 30723.8 43960.6 44791.6 44816.6 44845.3 44881.8 284376.0 289612.0 289753.0 289829.0 289895.0 23127.3 26546.3 42466.0 42613.0 43549.6 41705.8 46591.8 46634.3 46950.5 47496.5 37497.3 39254.8 39657.6 40162.2 40497.1 37916.1 37990.6 38476.8 39152.6 39533.0 38575.4 38996.9 39333.8 39797.8 39826.2 33441.5 34747.5 35436.0 35552.5 35648.5 26509.6 26534.6 27049.6 27156.5 27487.3 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#2] jquery.html Cycles:180 Average:23767.15 Median:189693.40 stddev:61946.48 (32.7%) stddev-sans-first:62095.37 08:41:59 INFO - PROCESS | 21524 | Values: 380.8 384.6 391.4 401.2 408.6 16083.5 16754.2 17690.4 17717.3 17743.8 16384.5 16544.1 16618.8 17496.4 17504.2 4987.1 5174.2 5175.6 5183.9 5200.0 3680.6 3755.9 3821.8 5328.6 5957.5 5874.0 5894.9 5898.5 5912.2 5915.3 5363.5 5658.7 5669.3 5751.9 5864.2 3466.6 5198.9 5483.7 5491.0 5570.6 12864.4 12989.3 13057.2 17136.8 21050.5 1782.2 1867.3 1937.1 1960.1 2043.7 9732.9 9848.0 11161.6 11245.2 13813.2 1703.1 1745.4 1750.6 1751.6 1809.4 46801.0 64037.7 64091.0 65624.7 73746.0 9529.4 9632.9 9833.7 9834.6 9837.3 12637.4 12645.2 12714.6 13004.1 13107.9 6729.8 6738.6 6831.5 6840.8 6916.1 6590.1 6652.5 6683.8 6695.4 6961.3 4029.4 4065.0 4070.4 4187.8 4587.3 1857.1 1870.1 1872.3 1888.4 1924.5 854.3 866.3 948.3 979.0 999.2 16345.2 17048.8 17148.3 17328.4 17905.1 855.6 894.6 903.5 915.3 922.4 9504.9 9873.0 9982.0 10000.6 10011.6 366771.0 370661.0 379006.0 380217.0 382923.0 72943.3 73475.0 74152.0 74398.0 74535.0 917.4 919.6 937.7 939.8 948.6 15285.2 15301.6 15412.9 15736.9 15944.6 34162.5 34313.5 34545.3 35808.0 36351.0 48780.5 49639.5 51772.7 52835.0 53958.7 10830.5 11568.2 11865.4 12068.6 12097.7 12035.5 12779.2 12853.2 12989.9 13255.5 10931.2 10994.1 11025.3 11043.6 11171.4 4697.8 8418.7 9616.8 11498.9 11713.5 8220.3 9553.9 10942.2 11340.6 11721.6 11516.7 11746.8 11752.3 11810.6 11883.9 11198.9 11215.7 11217.8 11222.3 11307.5 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#3] mootools.html Cycles:180 Average:5207.12 Median:5396.85 stddev:2901.06 (53.8%) stddev-sans-first:2894.23 08:41:59 INFO - PROCESS | 21524 | Values: 1285.2 1464.1 1507.2 1623.1 1788.7 6583.1 7689.8 7891.2 7897.4 8089.2 7879.4 8009.4 8015.8 8029.2 8044.7 2285.9 2320.7 2322.5 2324.1 2324.6 2282.2 2303.7 2323.5 2325.3 2326.0 2280.7 2290.2 2303.7 2315.3 2316.3 2234.4 2261.0 2263.9 2265.4 2269.8 2228.9 2235.2 2237.1 2237.4 2239.8 7757.6 7811.6 7908.1 7923.1 8040.5 4613.1 4742.1 4749.8 4750.2 4754.4 2965.5 3012.4 3017.4 3031.1 3075.5 950.8 952.7 955.1 956.1 964.6 10779.0 10823.7 10835.2 10848.6 10848.8 4100.6 4198.7 4234.5 4255.8 4268.1 8632.6 8666.0 8677.1 8677.8 8678.2 4525.4 4570.6 4578.0 4579.5 4580.6 3801.1 4133.6 4167.4 4273.4 4279.8 3543.9 3563.1 3617.7 3641.4 3642.9 1051.3 1058.0 1058.8 1066.3 1072.3 727.7 752.3 902.3 910.9 911.2 5204.4 5531.1 5572.9 5574.4 5652.3 455.4 471.2 473.5 484.2 597.5 3646.6 3774.7 3869.4 3875.7 3876.7 9430.4 9703.1 9736.6 9804.0 9858.0 9723.7 9738.7 9766.2 9766.5 9812.2 7265.7 7420.6 7539.2 7540.8 7561.1 5391.2 5402.5 5423.2 5456.0 5526.7 9057.0 9069.2 9077.5 9159.9 9211.1 8855.3 9192.1 9210.1 9226.1 9230.9 6468.7 6539.6 6550.5 6557.5 6565.0 7294.8 7328.9 7353.9 7363.3 7383.4 6954.0 7028.4 7111.0 7111.5 7205.0 6856.2 6873.2 6898.8 6977.0 7068.9 6356.4 6365.1 6411.7 6426.6 6432.4 4561.0 4578.0 4718.0 4775.6 4826.1 4891.8 4936.6 4952.5 4970.3 4993.8 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#4] prototype.html Cycles:180 Average:4194.97 Median:4840.03 stddev:1221.02 (25.2%) stddev-sans-first:1189.02 08:41:59 INFO - PROCESS | 21524 | Values: 304.5 307.5 307.9 316.9 322.6 4845.8 4847.0 4849.3 4850.0 4880.3 4727.5 4737.8 4745.7 4773.2 4777.9 3624.7 3727.9 3747.5 3764.4 3785.1 3696.9 3732.4 3838.6 3848.0 3853.5 3768.3 3777.3 3790.1 3798.2 3805.2 3593.4 3779.0 3787.7 3805.8 3818.3 3278.9 3291.2 3310.1 3322.5 3328.6 4599.2 4619.3 4620.1 4628.6 4659.7 4074.5 4231.4 4262.4 4262.7 4289.4 4923.3 4931.7 4984.7 5007.6 5013.5 3553.3 3559.9 3569.6 3586.0 3601.6 5090.9 5200.4 5201.9 5225.1 5233.6 3660.2 3661.6 3685.5 3686.2 3689.3 3725.8 3742.0 3742.4 3752.4 3756.9 4291.0 4292.6 4293.8 4299.4 4320.7 4935.8 5051.6 5055.4 5057.7 5071.8 1282.2 1292.3 1292.4 1293.6 1301.4 793.0 816.1 822.7 825.7 832.0 4341.2 4467.3 4471.8 4473.5 4485.3 5117.2 5144.8 5149.9 5153.7 5164.5 4458.3 4476.4 4491.5 4495.9 4505.5 2574.6 2722.9 2751.7 2754.4 2775.1 4925.6 4928.6 4978.7 4985.9 4998.3 5057.5 5268.3 5275.2 5301.7 5331.3 4952.3 4979.0 4982.8 4985.7 4993.3 5198.7 5209.7 5224.5 5228.2 5230.2 4891.0 5107.7 5128.8 5143.4 5144.2 4983.7 4992.8 4994.1 5004.2 5013.2 3661.3 3671.5 3673.8 3674.2 3678.8 5083.5 5206.7 5219.7 5233.3 5242.5 5081.9 5087.0 5092.5 5099.3 5111.5 5089.5 5089.6 5090.5 5090.5 5103.3 4834.3 4964.8 5011.5 5011.6 5012.7 4886.2 4920.4 5052.9 5056.8 5109.1 4949.2 4953.5 4961.9 4963.6 4989.3 08:41:59 INFO - PROCESS | 21524 | 08:41:59 INFO - PROCESS | 21524 | [#5] yui.html Cycles:180 Average:14030.30 Median:51149.86 stddev:17052.11 (33.3%) stddev-sans-first:17070.76 08:41:59 INFO - PROCESS | 21524 | Values: 742.6 769.9 773.9 781.0 783.4 12331.1 12444.4 12603.5 12611.4 12615.7 13170.7 13763.3 13795.4 14222.6 14274.0 682.2 877.6 881.4 885.8 885.9 841.2 866.7 869.1 870.0 871.5 924.0 924.1 927.3 927.7 928.1 727.1 885.7 918.7 919.2 919.4 673.2 677.0 677.3 677.5 677.7 13169.1 13226.5 13228.5 13255.7 13255.8 11465.4 11640.4 11849.6 11925.6 12384.7 11386.8 11431.3 11547.8 11552.5 11604.7 4134.3 4194.6 4245.1 4246.7 4391.5 50823.2 51476.5 51560.7 51727.7 51923.7 9085.7 9183.9 9269.6 9411.2 9417.3 16061.8 16700.3 16983.6 17020.8 17060.4 6286.3 6365.0 6497.2 6536.1 6699.3 3654.5 3703.9 3741.8 3743.0 3800.5 2833.1 2922.7 2925.1 2928.7 2929.1 548.3 552.4 558.4 570.9 575.4 440.5 451.4 465.3 537.9 540.6 7175.0 7269.3 7387.8 7627.2 7929.5 546.0 596.7 598.4 604.3 606.6 3594.5 3722.4 3730.4 3948.9 4050.9 61334.0 61633.4 63425.4 63914.0 64074.7 55346.0 55426.0 55586.0 56263.4 57261.4 49481.8 50117.0 50314.5 50440.7 51510.5 7883.4 7955.7 7963.4 8090.6 8209.8 32735.8 33005.5 33012.7 33167.0 33452.2 41099.0 43532.8 44100.6 44710.1 45247.5 11303.3 11312.8 11363.1 11445.4 11527.9 11719.4 11916.6 12138.3 12232.7 13198.2 7078.6 8134.8 11077.4 11113.7 11221.0 11147.6 11684.1 12327.5 12387.4 12404.1 10526.4 10722.2 10780.4 11011.3 11136.6 8924.0 9210.2 9434.3 9733.0 9747.6 9417.7 9549.2 9698.2 9922.8 9974.0 08:41:59 INFO - PROCESS | 21524 | -------- Summary: end -------- 08:41:59 INFO - PROCESS | 21524 | 08:42:00 INFO - TEST-INFO | 21524: exit 0 08:42:00 INFO - TEST-OK | dromaeo_css | took 1119432ms 08:42:00 INFO - TEST-START | kraken 08:42:00 INFO - operating with platform_type : linux_ 08:42:00 INFO - Initialising browser for kraken test... 08:42:00 INFO - TEST-INFO | started process 21702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZRSciK/profile http://localhost:51341/getInfo.html) 08:42:04 INFO - PROCESS | 21702 | __metrics Screen width/height:1600/1200 08:42:04 INFO - PROCESS | 21702 | colorDepth:24 08:42:04 INFO - PROCESS | 21702 | Browser inner width/height: 1024/697 08:42:04 INFO - PROCESS | 21702 | __metrics 08:42:05 ERROR - PROCESS | 21702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:42:06 INFO - TEST-INFO | 21702: exit 0 08:42:06 INFO - Browser initialized. 08:42:06 INFO - Running cycle 1/1 for kraken test... 08:42:06 INFO - TEST-INFO | started process 21784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZRSciK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:18 INFO - PROCESS | 21784 | RSS: Main: 154386432 08:42:18 INFO - PROCESS | 21784 | 08:42:20 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51341/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:21 INFO - PROCESS | 21784 | RSS: Main: 209842176 08:42:21 INFO - PROCESS | 21784 | 08:42:24 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51341/tests/kraken/driver.html?testName=audio-dft) 08:42:25 INFO - PROCESS | 21784 | RSS: Main: 197943296 08:42:25 INFO - PROCESS | 21784 | 08:42:28 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51341/tests/kraken/driver.html?testName=audio-fft) 08:42:29 INFO - PROCESS | 21784 | RSS: Main: 266973184 08:42:29 INFO - PROCESS | 21784 | 08:42:31 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51341/tests/kraken/driver.html?testName=audio-oscillator) 08:42:31 INFO - PROCESS | 21784 | RSS: Main: 176160768 08:42:31 INFO - PROCESS | 21784 | 08:42:34 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:35 INFO - PROCESS | 21784 | RSS: Main: 179863552 08:42:35 INFO - PROCESS | 21784 | 08:42:38 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51341/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:38 INFO - PROCESS | 21784 | RSS: Main: 216178688 08:42:38 INFO - PROCESS | 21784 | 08:42:42 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51341/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:43 INFO - PROCESS | 21784 | RSS: Main: 214601728 08:42:43 INFO - PROCESS | 21784 | 08:42:46 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51341/tests/kraken/driver.html?testName=json-parse-financial) 08:42:46 INFO - PROCESS | 21784 | RSS: Main: 215187456 08:42:46 INFO - PROCESS | 21784 | 08:42:48 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:49 INFO - PROCESS | 21784 | RSS: Main: 208883712 08:42:49 INFO - PROCESS | 21784 | 08:42:51 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:51 INFO - PROCESS | 21784 | RSS: Main: 212385792 08:42:51 INFO - PROCESS | 21784 | 08:42:54 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:54 INFO - PROCESS | 21784 | RSS: Main: 217681920 08:42:54 INFO - PROCESS | 21784 | 08:42:57 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:58 INFO - PROCESS | 21784 | RSS: Main: 218644480 08:42:58 INFO - PROCESS | 21784 | 08:43:01 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:01 INFO - PROCESS | 21784 | RSS: Main: 216686592 08:43:01 INFO - PROCESS | 21784 | 08:43:03 INFO - PROCESS | 21784 | Cycle 1(1): loaded http://localhost:51341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51341/tests/kraken/driver.html?testName=ai-astar) 08:43:04 INFO - PROCESS | 21784 | RSS: Main: 263315456 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | __start_tp_report 08:43:04 INFO - PROCESS | 21784 | _x_x_mozilla_page_load 08:43:04 INFO - PROCESS | 21784 | _x_x_mozilla_page_load_details 08:43:04 INFO - PROCESS | 21784 | |i|pagename|runs| 08:43:04 INFO - PROCESS | 21784 | |0;ai-astar;113;108;114;112;112;113;113;113;113;113 08:43:04 INFO - PROCESS | 21784 | |1;audio-beat-detection;154;131;161;217;128;158;156;129;196;129 08:43:04 INFO - PROCESS | 21784 | |2;audio-dft;162;161;161;160;160;162;161;160;161;160 08:43:04 INFO - PROCESS | 21784 | |3;audio-fft;75;78;75;144;75;74;79;75;124;75 08:43:04 INFO - PROCESS | 21784 | |4;audio-oscillator;92;95;152;92;92;92;128;92;93;123 08:43:04 INFO - PROCESS | 21784 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:43:04 INFO - PROCESS | 21784 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;146 08:43:04 INFO - PROCESS | 21784 | |7;imaging-desaturate;95;94;95;96;95;95;95;94;95;95 08:43:04 INFO - PROCESS | 21784 | |8;json-parse-financial;66;64;65;65;64;63;64;65;65;65 08:43:04 INFO - PROCESS | 21784 | |9;json-stringify-tinderbox;64;65;65;65;65;64;65;64;65;71 08:43:04 INFO - PROCESS | 21784 | |10;stanford-crypto-aes;83;82;82;87;88;84;83;83;160;83 08:43:04 INFO - PROCESS | 21784 | |11;stanford-crypto-ccm;132;138;138;130;128;126;135;127;149;132 08:43:04 INFO - PROCESS | 21784 | |12;stanford-crypto-pbkdf2;175;170;169;173;169;166;167;172;171;174 08:43:04 INFO - PROCESS | 21784 | |13;stanford-crypto-sha256-iterative;67;68;66;69;67;66;73;65;64;66 08:43:04 INFO - PROCESS | 21784 | __end_tp_report 08:43:04 INFO - PROCESS | 21784 | __start_cc_report 08:43:04 INFO - PROCESS | 21784 | _x_x_mozilla_cycle_collect,2133 08:43:04 INFO - PROCESS | 21784 | __end_cc_report 08:43:04 INFO - PROCESS | 21784 | __startTimestamp1463586184000__endTimestamp 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | ------- Summary: start ------- 08:43:04 INFO - PROCESS | 21784 | Number of tests: 14 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 08:43:04 INFO - PROCESS | 21784 | Values: 113.0 108.0 114.0 112.0 112.0 113.0 113.0 113.0 113.0 113.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:157.00 stddev:30.22 (19.3%) stddev-sans-first:32.05 08:43:04 INFO - PROCESS | 21784 | Values: 154.0 131.0 161.0 217.0 128.0 158.0 156.0 129.0 196.0 129.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 08:43:04 INFO - PROCESS | 21784 | Values: 162.0 161.0 161.0 160.0 160.0 162.0 161.0 160.0 161.0 160.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:25.06 (33.4%) stddev-sans-first:26.17 08:43:04 INFO - PROCESS | 21784 | Values: 75.0 78.0 75.0 144.0 75.0 74.0 79.0 75.0 124.0 75.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:92.00 stddev:21.48 (23.3%) stddev-sans-first:22.25 08:43:04 INFO - PROCESS | 21784 | Values: 92.0 95.0 152.0 92.0 92.0 92.0 128.0 92.0 93.0 123.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:43:04 INFO - PROCESS | 21784 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 08:43:04 INFO - PROCESS | 21784 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:43:04 INFO - PROCESS | 21784 | Values: 95.0 94.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 08:43:04 INFO - PROCESS | 21784 | Values: 66.0 64.0 65.0 65.0 64.0 63.0 64.0 65.0 65.0 65.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:2.06 (3.2%) stddev-sans-first:2.13 08:43:04 INFO - PROCESS | 21784 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 71.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:83.00 stddev:24.15 (29.1%) stddev-sans-first:25.42 08:43:04 INFO - PROCESS | 21784 | Values: 83.0 82.0 82.0 87.0 88.0 84.0 83.0 83.0 160.0 83.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:133.50 stddev:6.90 (5.2%) stddev-sans-first:7.30 08:43:04 INFO - PROCESS | 21784 | Values: 132.0 138.0 138.0 130.0 128.0 126.0 135.0 127.0 149.0 132.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.50 stddev:2.95 (1.7%) stddev-sans-first:2.67 08:43:04 INFO - PROCESS | 21784 | Values: 175.0 170.0 169.0 173.0 169.0 166.0 167.0 172.0 171.0 174.0 08:43:04 INFO - PROCESS | 21784 | 08:43:04 INFO - PROCESS | 21784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.51 (3.8%) stddev-sans-first:2.67 08:43:04 INFO - PROCESS | 21784 | Values: 67.0 68.0 66.0 69.0 67.0 66.0 73.0 65.0 64.0 66.0 08:43:04 INFO - PROCESS | 21784 | -------- Summary: end -------- 08:43:04 INFO - PROCESS | 21784 | 08:43:05 INFO - TEST-INFO | 21784: exit 0 08:43:05 INFO - TEST-OK | kraken | took 64722ms 08:43:05 INFO - SUITE-END | took 1184s 08:43:05 INFO - Completed test suite (00:19:44) 08:43:05 INFO - javascript benchmark 08:43:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.7984901132418, 2698.0287096645216, 2723.896821787176, 2735.9042433514833, 2759.3377589378556, 4684.086603112394, 4742.217534106872, 4755.286706993953, 4827.613790896724, 4879.536444037815, 4758.857234282968, 4783.35424717663, 4811.158047341719, 4821.493743156971, 4823.204171311738, 4188.560201178878, 4331.956680433194, 4420.734755914639, 4456.754878481682, 4574.428196475441, 4503.324501324795, 4503.684742068057, 4531.546845315475, 4533.773311334437, 4582.518835522272, 4365.49796773372, 4406.405135306757, 4408.801603927799, 4428.0479696865, 4436.334549817521, 4381.693281470299, 4395.53846846083, 4413.536578659258, 4441.222786012435, 4464.374987501752, 4423.889402764925, 4434.822607095713, 4435.423394958667, 4438.356438316426, 4484.573965473275, 4590.540945905416, 4637.5130611286, 4682.321063445781, 4688.109259240768, 4749.691270067435, 5159.974200128975, 5163.302954101224, 5168.508991645787, 5179.067767801795, 5181.171012637998, 5151.407588127376, 5230.032443997872, 5242.030224408497, 5242.056429842627, 5243.082460569385, 4701.952980470186, 4808.519148085164, 4817.084753896748, 4828.8792780180775, 4920.384951881015, 5337.226102215157, 5349.625526213205, 5381.19282107687, 5384.703841288689, 5388.272583201296, 4881.731504767201, 5081.695098294114, 5103.540681338697, 5142.254373115878, 5149.330587023663, 5120.257562653394, 5156.5616922562, 5160.380754309507, 5168.2764412982215, 5179.8446046618665, 5119.206522988943, 5134.306868572769, 5137.152369859006, 5145.434002259748, 5193.558547523503, 4961.231009193581, 4979.3526841510375, 5140.460251673595, 5144.279800827887, 5153.175491921274, 4347.1740369330355, 4354.0, 4371.344298355272, 4411.029573493826, 4419.64642828573, 3773.1699026214187, 3790.033541446913, 3792.4500947362476, 3831.0230891122587, 3836.501254836853, 4324.524302326741, 4368.060866913565, 4378.430803995524, 4384.0355121873135, 4438.6005259526155, 5113.0, 5123.462036486189, 5132.153194722829, 5139.871503212375, 5219.6607220531305, 4465.620422264079, 4480.887977800581, 4491.483479399845, 4492.640588752892, 4532.229520981441, 4578.336141259499, 4643.466001409881, 4649.674522783373, 4685.01614660925, 4690.366800481959, 4909.656324057281, 4926.039422312615, 4926.334944782552, 4937.950620493749, 4969.453360130455, 5176.1200595898035, 5188.481151884781, 5193.350831146106, 5202.583793296603, 5217.217417387271, 4731.763411829464, 4901.598216873777, 4938.8765280868265, 4992.226204938241, 4996.425411077773, 5114.514121158484, 5125.231215317583, 5129.666571672829, 5138.254953031715, 5171.741412929414, 5190.039842629126, 5202.895942081062, 5205.6616319939085, 5208.296879921162, 5261.0, 4900.338454308765, 4949.406071271471, 4968.677035992649, 4982.0, 5045.697258164522, 4980.377452818398, 4982.10322142018, 4991.9001619966675, 4996.200607902718, 5039.143345631178, 4979.452260251442, 4988.775505102351, 5049.671771334852, 5049.990001999541, 5052.115879721107, 4958.528939750718, 5006.674566153189, 5014.247862820606, 5045.394552653705, 5072.9746351268, 4928.211486162197, 4946.109700253989, 4946.134426475424, 4953.603711703127, 5004.3994720633755], "value": 4737.633583885191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.1703238819907, 598.9520838332928, 599.2599140062024, 602.9719328544829, 615.8491169663432, 41430.34278628855, 42833.78583107084, 42847.143057138914, 42877.57122428775, 47045.52954470454, 44916.3262551062, 45294.547054529445, 45373.77313113438, 45452.77273613636, 45462.0, 7597.696092156335, 8026.7591972240925, 8179.631916563739, 10090.293679442442, 10315.690529284133, 10231.334963227404, 10335.224858135633, 10341.327813692124, 10343.327683700572, 10351.792964140712, 10448.425336606484, 10497.160227181806, 10502.107320877734, 10502.212334074937, 10503.78992420155, 7714.305712485875, 10119.848202276971, 10312.535935882903, 10329.638462653771, 10732.517036733365, 10191.235657325657, 10263.794724105475, 10264.435456049914, 10268.383896966132, 10272.537735801907, 40536.79731601352, 40877.0, 40933.59066409327, 40951.7952410239, 40997.59002409968, 2928.751056160229, 3037.9392412151856, 3055.236190952262, 3096.90709278722, 3147.763917706181, 30344.54483182754, 30606.54090188649, 30764.846175768977, 30958.22604434907, 31718.0, 3492.196794737199, 3514.6661067198575, 3529.8764543240864, 3541.3271478419274, 3546.131197856542, 275665.0, 275930.0, 277502.0, 277938.0, 278029.0, 56736.71631641898, 57840.0, 57843.0, 57910.71044644834, 57914.7104264476, 35099.82450087784, 35904.64095359065, 35944.46083308753, 37666.81166594204, 37806.43290350647, 13579.388927498287, 13828.170309781446, 13858.722825543635, 13921.443142274196, 13956.441742330397, 10166.644167454104, 10454.947725261325, 10464.424456654957, 10698.51856666452, 10718.73203169927, 19285.51786205328, 19736.802631973784, 19882.0, 19897.403077907686, 19911.900440497706, 7169.749058782918, 7237.819054523574, 7301.123865136217, 7324.816879578053, 7380.188179300273, 873.3842640938124, 931.3434029009532, 942.7124726958207, 1043.108142538119, 1051.1905832508926, 29184.7081529182, 29696.851515742284, 29721.702782972327, 29731.405371892874, 30207.848960755055, 983.5672304186136, 1009.5911155981839, 1020.4336593190702, 1023.3603997501561, 1068.8129577323937, 15393.384264629512, 15406.768898466533, 15639.374425022872, 15703.547040308946, 15875.920620397055, 391224.0, 392856.0, 393120.0, 393937.0, 396732.0, 53463.0, 54077.72961135169, 54085.45914540883, 54120.18819717707, 54197.0, 1134.7617000430002, 1179.7907145176264, 1238.6098379010764, 1242.2608547913976, 1273.2742336868082, 29075.127746167647, 30142.84928575343, 30270.0, 30482.39035219239, 30723.846380767955, 43960.560394395645, 44791.55208447874, 44816.55183448124, 44845.32732008957, 44881.77559112314, 284376.0, 289612.0, 289753.0, 289829.0, 289895.0, 23127.3061808146, 26546.336341591614, 42466.0, 42613.0, 43549.56450435455, 41705.79147104245, 46591.767041164574, 46634.300485492065, 46950.53049469461, 47496.52503474921, 37497.2500549982, 39254.80372598119, 39657.60342396539, 40162.19675606413, 40497.14034315901, 37916.05209869775, 37990.62009379871, 38476.80761596286, 39152.608473914894, 39533.0, 38575.42136868005, 38996.93039904907, 39333.80333098316, 39797.80101099476, 39826.20347592974, 33441.49837752484, 34747.468692710645, 35436.0, 35552.46671299881, 35648.4652730204, 26509.60235596506, 26534.60198097069, 27049.59425608657, 27156.519174336012, 27487.31281717973], "value": 18839.343910839718, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.79330281021475, 384.5769653381281, 391.35621901971274, 401.1535659757912, 408.58528593477627, 16083.51749447517, 16754.246058927347, 17690.380836670734, 17717.291308347667, 17743.822561774377, 16384.508464746075, 16544.090075045868, 16618.83381166188, 17496.387626433076, 17504.21231044603, 4987.052460032601, 5174.223866420049, 5175.585953123741, 5183.870403239912, 5199.974000129994, 3680.576733675635, 3755.9436608450897, 3821.8280177391944, 5328.600354973373, 5957.463828255456, 5874.0014197586515, 5894.911576326359, 5898.469137777599, 5912.231409916726, 5915.260592425947, 5363.54409875161, 5658.74535645897, 5669.348024977118, 5751.884962300773, 5864.179014937912, 3466.5666791651042, 5198.896022079537, 5483.698396588186, 5491.039068163095, 5570.554355651539, 12864.421101050475, 12989.285589292585, 13057.21656700601, 17136.828631713648, 21050.473738156514, 1782.1712903499806, 1867.2717640120363, 1937.0702063009835, 1960.0885588201413, 2043.6627956387179, 9732.854007189897, 9848.0, 11161.609343672932, 11245.212835101545, 13813.240271785047, 1703.1228917107699, 1745.441458733206, 1750.5798608333907, 1751.5533538947614, 1809.3757653609484, 46801.0, 64037.67981160065, 64091.0, 65624.6718766403, 73745.99999999946, 9529.437470205083, 9632.855507167258, 9833.655822046194, 9834.606615735434, 9837.311388202757, 12637.43131559082, 12645.241285522898, 12714.61856144317, 13004.089713720137, 13107.934460327828, 6729.764458243938, 6738.629375384401, 6831.487638427137, 6840.760573379908, 6916.066331045345, 6590.077389165521, 6652.501062420338, 6683.799486015428, 6695.430888374445, 6961.303869612998, 4029.37544680575, 4064.9593504064583, 4070.3894415837863, 4187.790610469464, 4587.334836448763, 1857.0993068361834, 1870.139735721556, 1872.2604571194302, 1888.3673969220465, 1924.5469670399038, 854.3080105114752, 866.3026263857655, 948.2745699539857, 978.951052447389, 999.2206079258191, 16345.182740862909, 17048.829511704724, 17148.314067437164, 17328.39350622722, 17905.10474476271, 855.6224478589465, 894.5661354243186, 903.5121034641352, 915.3135148638521, 922.3681777982104, 9504.857427138599, 9872.950635246778, 9981.950090249647, 10000.599976000878, 10011.599536018477, 366771.0, 370661.0, 379006.0, 380217.0, 382923.0, 72943.2705672947, 73475.0, 74152.0, 74398.0, 74535.0, 917.4495302818389, 919.5907821019582, 937.681188395935, 939.8402271613979, 948.5731420860641, 15285.159316237714, 15301.6174595636, 15412.922935385252, 15736.92131539335, 15944.601384965468, 34162.48756268608, 34313.48529772006, 34545.30909381748, 35808.0, 36351.0, 48780.53658390254, 49639.503604964935, 51772.74113629558, 52835.0, 53958.730206348715, 10830.458477076272, 11568.24806387582, 11865.406729663655, 12068.637940861789, 12097.697557561132, 12035.518579256732, 12779.233246004898, 12853.228806271654, 12989.870101299244, 13255.536056237985, 10931.234813562975, 10994.065504432212, 11025.336302717207, 11043.558257669603, 11171.441427928734, 4697.812087516461, 8418.69510225916, 9616.75958101025, 11498.94250528742, 11713.531458741554, 8220.301274391504, 9553.856692149484, 10942.23404361687, 11340.6030788922, 11721.648350549498, 11516.712082197677, 11746.765064698488, 11752.294862308288, 11810.645680629596, 11883.881161188623, 11198.944005279922, 11215.66353009411, 11217.831732524182, 11222.270552414067, 11307.491162897853], "value": 8356.529570212962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.2288626823902, 1464.084946908182, 1507.246376811594, 1623.1478473801253, 1788.651213013462, 6583.07836902834, 7689.769306920787, 7891.1714270001685, 7897.368210543157, 8089.150639182874, 7879.369650427966, 8009.39929505288, 8015.839683206333, 8029.237222463857, 8044.6782128714785, 2285.942851428715, 2320.6983092198075, 2322.4774425754154, 2324.1400681747778, 2324.6280595104786, 2282.1784157703214, 2303.6544518322216, 2323.453988312745, 2325.3024092772184, 2325.9651105233434, 2280.737715162761, 2290.2442194075998, 2303.6544518322216, 2315.2938353802083, 2316.2819525946925, 2234.3855439754034, 2260.9660855087186, 2263.8528495647893, 2265.354374003401, 2269.8297627677907, 2228.8551244169075, 2235.2400183937375, 2237.1387015998794, 2237.407087121914, 2239.8320125990617, 7757.612119394064, 7811.570363629998, 7908.090569584514, 7923.0888447828665, 8040.477368971056, 4613.077384523109, 4742.122707299126, 4749.762511874427, 4750.239961606127, 4754.429468463772, 2965.5106907360478, 3012.3824615953677, 3017.351269477051, 3031.0906727981737, 3075.4771688812957, 950.8288508068545, 952.6570434643522, 955.1403736637013, 956.086936975187, 964.6382606522554, 10779.0, 10823.67528974132, 10835.18736094788, 10848.566057357775, 10848.837267440995, 4100.5899410058755, 4198.664106871504, 4234.470691163605, 4255.829766809355, 4268.103698223345, 8632.611532481053, 8666.0, 8677.088905664941, 8677.783055423539, 8678.218960293603, 4525.389072475239, 4570.588647021784, 4578.038611891474, 4579.542045795461, 4580.564846339593, 3801.087738942689, 4133.565975572522, 4167.354060120686, 4273.380359847804, 4279.786010699452, 3543.8936831895085, 3563.0736008637423, 3617.7467577269863, 3641.3809652359164, 3642.907127861631, 1051.2588625019343, 1057.9682609521726, 1058.7617785998088, 1066.3015724700333, 1072.2815713471994, 727.665273973978, 752.2890868129565, 902.251131560816, 910.9407888487227, 911.2300106410073, 5204.386640141568, 5531.1426728857095, 5572.888542229214, 5574.358948720868, 5652.2652055233375, 455.3670398146579, 471.24365393543553, 473.4507970753909, 484.2179879494591, 597.4801922327603, 3646.5624125105155, 3774.698024158061, 3869.3808990561374, 3875.670568001695, 3876.7480113792512, 9430.387024843363, 9703.07820757027, 9736.610535578639, 9804.0, 9858.0, 9723.708288751348, 9738.659146929824, 9766.169875560516, 9766.511674416251, 9812.215022798158, 7265.745698900513, 7420.628968551551, 7539.1706912238515, 7540.849183016309, 7561.130469995911, 5391.16436952273, 5402.540784033401, 5423.2407462954425, 5456.0451920914475, 5526.668399896019, 9057.0, 9069.18377346042, 9077.546122693971, 9159.908400915905, 9211.078892110736, 8855.291576673979, 9192.126747958933, 9210.078992100736, 9226.077392260988, 9230.907690923004, 6468.708908099053, 6539.574927629689, 6550.475961922939, 6557.508186886098, 6565.0, 7294.781156565312, 7328.853422931618, 7353.889691654736, 7363.337299643058, 7383.446241532014, 6954.0, 7028.437724981887, 7111.0, 7111.466640001917, 7204.9639751800905, 6856.24581296047, 6873.178607669071, 6898.793036208922, 6976.965115174392, 7068.858622827617, 6356.4279214870885, 6365.077063825812, 6411.6794160290865, 6426.550141490051, 6432.35676432353, 4560.954390456053, 4578.0, 4718.032803275251, 4775.594074503706, 4826.107170173529, 4891.80432782699, 4936.629752768628, 4952.529509696573, 4970.304157417892, 4993.775280112476], "value": 4148.949438242189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5127795527157, 307.5310152018172, 307.93225490392103, 316.91126484584316, 322.64509040055935, 4845.757712114389, 4846.975765121169, 4849.345338379318, 4849.987255289056, 4880.316755654207, 4727.52724727527, 4737.8392293887955, 4745.674619436477, 4773.164696178173, 4777.856664300068, 3624.746267761258, 3727.8881633551036, 3747.5128233329765, 3764.3976963685814, 3785.1104990327253, 3696.890932720187, 3732.4401339798974, 3838.6161383861668, 3848.037990502374, 3853.537575490945, 3768.2840260350445, 3777.263433630443, 3790.128270497787, 3798.240351929625, 3805.219929914375, 3593.443016332473, 3778.9811050944845, 3787.6591106800383, 3805.809709514527, 3818.293615681108, 3278.8688452461874, 3291.243014106769, 3310.0731795097413, 3322.5182348559324, 3328.567286252796, 4599.172149013176, 4619.284010978304, 4620.1221767864, 4628.583427491542, 4659.7204167749705, 4074.490688663917, 4231.449911511515, 4262.381954616563, 4262.65898728101, 4289.356596510548, 4923.286123512071, 4931.7040977541465, 4984.725840078794, 5007.6244281678655, 5013.468198559704, 3553.289342131584, 3559.857605695769, 3569.5716514018222, 3585.964140358615, 3601.6398360164035, 5090.9236361454605, 5200.427952925175, 5201.9479805201845, 5225.085610018232, 5233.633645644806, 3660.213054193361, 3661.5972243053243, 3685.5024571683016, 3686.2074653948994, 3689.317476266899, 3725.7950812705562, 3741.962580374216, 3742.4468845429387, 3752.399616061417, 3756.887293381203, 4291.0, 4292.613664770123, 4293.785310734514, 4299.419578356944, 4320.740755554677, 4935.8025678972435, 5051.595872330205, 5055.393352797614, 5057.72182529957, 5071.771770270347, 1282.2306616030307, 1292.3409061378763, 1292.424870932445, 1293.5925183567147, 1301.362332457108, 793.0008189680929, 816.1267443835039, 822.7408366364576, 825.6821123867354, 831.9708810191614, 4341.2402829505345, 4467.30756732707, 4471.8434854779925, 4473.530279320689, 4485.259932111165, 5117.232415137759, 5144.7942082316285, 5149.871253218699, 5153.7165455900285, 5164.535191832753, 4458.331250312479, 4476.4180656514445, 4491.483479399845, 4495.9325610115875, 4505.5269196734525, 2574.635443215099, 2722.891084356643, 2751.7248275172724, 2754.352727109128, 2775.1119641714863, 4925.605951523869, 4928.6303527235605, 4978.6763860348965, 4985.850424487271, 4998.325226094431, 5057.468965758616, 5268.262443257947, 5275.182346736262, 5301.655392399482, 5331.30693009914, 4952.306677065142, 4979.0, 4982.800687972513, 4985.725785081783, 4993.300937868701, 5198.688078715138, 5209.661372010807, 5224.50367215114, 5228.189630607262, 5230.215467679726, 4890.975545122252, 5107.693538387709, 5128.769205385692, 5143.434222235476, 5144.228365745168, 4983.725895075806, 4992.80028798844, 4994.076095922266, 5004.17431123875, 5013.172826483736, 3661.2860492203763, 3671.4676371926457, 3673.7979411132646, 3674.210044840372, 3678.779273243614, 5083.46623604531, 5206.672298563842, 5219.660722053054, 5233.345831771028, 5242.5281724644965, 5081.949180508148, 5087.0414890266775, 5092.490750924878, 5099.3370861787735, 5111.463296353978, 5089.541941225308, 5089.643724939367, 5090.4655011223285, 5090.465501122477, 5103.260027295947, 4834.299026641188, 4964.826231081895, 5011.523905228997, 5011.574016208663, 5012.69669885825, 4886.2165309661, 4920.360353154067, 5052.924206136984, 5056.82301119459, 5109.08036553424, 4949.208126699711, 4953.455119936876, 4961.925571116509, 4963.602911767122, 4989.326440930573], "value": 3807.336412327851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5544673196082, 769.9499532530385, 773.8916551682765, 781.0, 783.377215113984, 12331.136820422575, 12444.44000019999, 12603.495860165582, 12611.369431528432, 12615.747685046294, 13170.67073323165, 13763.311834408265, 13795.448182072705, 14222.573322800306, 14274.0, 682.1643486728742, 877.6006916852832, 881.4358810361374, 885.8184072265202, 885.9069797671249, 841.167244428018, 866.7399780065987, 869.0874581689201, 870.0125357718971, 871.4814685262259, 923.9630414783401, 924.0713083351222, 927.2998885841181, 927.6845872403381, 928.0533855467419, 727.0911360799001, 885.6501681835704, 918.7243826851951, 919.1589695428675, 919.420764918104, 673.1619134177931, 677.0487465111477, 677.2651672934871, 677.4715721737053, 677.7221339250883, 13169.144005639602, 13226.470941162343, 13228.537001205008, 13255.73488530224, 13255.801162982563, 11465.426728663617, 11640.359780212086, 11849.641766619441, 11925.642230733005, 12384.690382740413, 11386.772264554662, 11431.314121152674, 11547.769044619145, 11552.480138393792, 11604.709882252926, 4134.255833949888, 4194.601512856274, 4245.129748401601, 4246.681498887565, 4391.5169331373845, 50823.23765143526, 51476.48523514754, 51560.74219628915, 51727.74136129295, 51923.74038129785, 9085.68200113006, 9183.90816091844, 9269.629214831466, 9411.152996230372, 9417.293702972305, 16061.759073613905, 16700.331986720394, 16983.575410614834, 17020.829791702174, 17060.40288589918, 6286.277078135981, 6364.968175159094, 6497.155369801895, 6536.117624120778, 6699.263081061079, 3654.506641603403, 3703.925921481555, 3741.8213262822123, 3742.9812850936114, 3800.505934228588, 2833.0650885207833, 2922.678505364408, 2925.13708456006, 2928.736413722733, 2929.062699936, 548.3091304955784, 552.4089224529714, 558.3885645218479, 570.9437540549949, 575.4015823543551, 440.4780335302677, 451.38441086894215, 465.26488148724934, 537.9435159308294, 540.5837505121035, 7174.964125179341, 7269.345758881726, 7387.7783666490095, 7627.177944160696, 7929.5242285463055, 546.0062685911682, 596.7225240263211, 598.4225222660067, 604.338249616669, 606.6141794823451, 3594.4967704521387, 3722.4230244312175, 3730.3658378075793, 3948.933787877257, 4050.8784736457956, 61334.0, 61633.38366616366, 63425.36574634287, 63914.0, 64074.679626601566, 55346.0, 55426.0, 55586.0, 56263.43736562664, 57261.42738572644, 49481.752591237535, 50117.0, 50314.49685503171, 50440.74779626078, 51510.48489515057, 7883.44815862907, 7955.681772729257, 7963.362930965624, 8090.635921383434, 8209.79475513117, 32735.83632081824, 33005.51475183671, 33012.66987330192, 33167.0, 33452.163695907795, 41099.0, 43532.782336088116, 44100.55899441093, 44710.10579788321, 45247.547524524336, 11303.265287756269, 11312.830307545559, 11363.147763917574, 11445.427728613702, 11527.88472115268, 11719.35543545079, 11916.582919597773, 12138.33239171854, 12232.694182645506, 13198.160514422309, 7078.575285482888, 8134.796630084058, 11077.390743508862, 11113.666590001989, 11221.0, 11147.609833655782, 11684.1236907234, 12327.50689972391, 12387.431162941439, 12404.069694773108, 10526.368417894952, 10722.195835312226, 10780.407077610807, 11011.284266522971, 11136.610218642309, 8923.955380223057, 9210.171084602418, 9434.292428067785, 9733.0, 9747.610095596381, 9417.717468475958, 9549.236061115233, 9698.224142068759, 9922.751931201488, 9973.950130249303], "value": 6208.146924174194, "unit": "score"}], "name": "dromaeo_css", "value": 6467.024463718733, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 114.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 161.0, 217.0, 128.0, 158.0, 156.0, 129.0, 196.0, 129.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 75.0, 144.0, 75.0, 74.0, 79.0, 75.0, 124.0, 75.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 152.0, 92.0, 92.0, 92.0, 128.0, 92.0, 93.0, 123.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 71.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 87.0, 88.0, 84.0, 83.0, 83.0, 160.0, 83.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 138.0, 130.0, 128.0, 126.0, 135.0, 127.0, 149.0, 132.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 169.0, 173.0, 169.0, 166.0, 167.0, 172.0, 171.0, 174.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 69.0, 67.0, 66.0, 73.0, 65.0, 64.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1572.2999999999997, "alertThreshold": 2.0}]} 08:43:05 INFO - Return code: 0 08:43:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:43:05 ERROR - # TBPL SUCCESS # 08:43:05 INFO - Running post-action listener: _resource_record_post_action 08:43:05 INFO - ##### 08:43:05 INFO - ##### Finished run-tests step (success) 08:43:05 INFO - ##### 08:43:05 INFO - Running post-run listener: _resource_record_post_run 08:43:05 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 531705856; Read time: 0; Write time: 443936 08:43:05 INFO - TinderboxPrint: CPU usage
13.1% 08:43:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:43:05 INFO - TinderboxPrint: I/O write bytes / time
531,705,856 / 443,936 08:43:05 INFO - TinderboxPrint: CPU idle
8,329.8 (86.9%) 08:43:05 INFO - TinderboxPrint: CPU user
1,212.0 (12.6%) 08:43:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234893312; Read time: 0; Write time: 239920 08:43:05 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 295354368; Read time: 0; Write time: 203864 08:43:05 INFO - Running post-run listener: _upload_blobber_files 08:43:05 INFO - Blob upload gear active. 08:43:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:05 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 08:43:05 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:05 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:10 INFO - (blobuploader) - INFO - Done attempting. 08:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:11 INFO - (blobuploader) - INFO - Done attempting. 08:43:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:12 INFO - (blobuploader) - INFO - Done attempting. 08:43:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:12 INFO - Return code: 0 08:43:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f82706f2cecdbe8689b3cdd2bd83da8250eee74cd89743fbd0c91ce6769352a74c685bc24dda7c6ad9e955eec92a46fad497732ee08fe0ec94285a4032d5ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b0ff48381a3dbfbc8dae3c4a8119bd86add160eb432c89744291809bd2d3c6df4330cb5625c1fb3d2d614eb07de53889e8ed0286204291280dca6ff61d9790f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc1b67f7beca4053a37bad635c7e53f95bb7bd4026fdb5c7509f237d668021345243fc1dbe673f9ca408ef464cfd7281b00baf75c73f7acf19014f61cf70124"} 08:43:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:12 INFO - Contents: 08:43:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f82706f2cecdbe8689b3cdd2bd83da8250eee74cd89743fbd0c91ce6769352a74c685bc24dda7c6ad9e955eec92a46fad497732ee08fe0ec94285a4032d5ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b0ff48381a3dbfbc8dae3c4a8119bd86add160eb432c89744291809bd2d3c6df4330cb5625c1fb3d2d614eb07de53889e8ed0286204291280dca6ff61d9790f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc1b67f7beca4053a37bad635c7e53f95bb7bd4026fdb5c7509f237d668021345243fc1dbe673f9ca408ef464cfd7281b00baf75c73f7acf19014f61cf70124"} 08:43:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:12 INFO - Copying logs to upload dir... 08:43:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.020887 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-18 08:43:11.189232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:43:11.193068) ========= 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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f82706f2cecdbe8689b3cdd2bd83da8250eee74cd89743fbd0c91ce6769352a74c685bc24dda7c6ad9e955eec92a46fad497732ee08fe0ec94285a4032d5ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b0ff48381a3dbfbc8dae3c4a8119bd86add160eb432c89744291809bd2d3c6df4330cb5625c1fb3d2d614eb07de53889e8ed0286204291280dca6ff61d9790f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc1b67f7beca4053a37bad635c7e53f95bb7bd4026fdb5c7509f237d668021345243fc1dbe673f9ca408ef464cfd7281b00baf75c73f7acf19014f61cf70124"} build_url:https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/V9yNgXFBT4mf9eabcAci-w/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/Fx-Team-Non-PGO/sha512/f82706f2cecdbe8689b3cdd2bd83da8250eee74cd89743fbd0c91ce6769352a74c685bc24dda7c6ad9e955eec92a46fad497732ee08fe0ec94285a4032d5ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b0ff48381a3dbfbc8dae3c4a8119bd86add160eb432c89744291809bd2d3c6df4330cb5625c1fb3d2d614eb07de53889e8ed0286204291280dca6ff61d9790f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc1b67f7beca4053a37bad635c7e53f95bb7bd4026fdb5c7509f237d668021345243fc1dbe673f9ca408ef464cfd7281b00baf75c73f7acf19014f61cf70124"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:43:11.217330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:43:11.217652) ========= 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=523ca41ca1e0623de333ad52000001bf-1463584935.204545-197573165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:43:11.301628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:43:11.301999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:43:11.302340) ========= ========= Total master_lag: 0.15 =========