builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1464134791.44 results: success (0) buildid: 20160524164037 builduid: b59f325178c3489f97e0619900536160 revision: 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.436887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.437360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.437666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.452547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.452871) ========= 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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 17:06:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-05-24 17:06:31 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.585822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.586144) ========= 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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.635535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:31.635892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb --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 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb --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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 17:06:31,995 truncating revision to first 12 chars 2016-05-24 17:06:31,995 Setting DEBUG logging. 2016-05-24 17:06:31,995 attempt 1/10 2016-05-24 17:06:31,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2062a9e37ad9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 17:06:32,420 unpacking tar archive at: fx-team-2062a9e37ad9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:32.408173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:32.408517) ========= script_repo_revision: 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:32.408930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:32.409233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 17:06:32.418735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 17:06:32.419013) ========= /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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:32 INFO - MultiFileLogger online at 20160524 17:06:32 in /builds/slave/test 17:06:32 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 17:06:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:32 INFO - {'append_to_log': False, 17:06:32 INFO - 'base_work_dir': '/builds/slave/test', 17:06:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:06:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:32 INFO - 'branch': 'Fx-Team-Non-PGO', 17:06:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:32 INFO - 'config_files': ('talos/linux_config.py',), 17:06:32 INFO - 'default_actions': ('clobber', 17:06:32 INFO - 'read-buildbot-config', 17:06:32 INFO - 'download-and-extract', 17:06:32 INFO - 'populate-webroot', 17:06:32 INFO - 'create-virtualenv', 17:06:32 INFO - 'install', 17:06:32 INFO - 'run-tests'), 17:06:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:32 INFO - 'download_minidump_stackwalk': True, 17:06:32 INFO - 'download_symbols': 'ondemand', 17:06:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:32 INFO - 'installer_path': 'installer.exe', 17:06:32 INFO - 'log_level': 'info', 17:06:32 INFO - 'log_name': 'talos', 17:06:32 INFO - 'log_to_console': True, 17:06:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:32 INFO - 'opt_config_files': (), 17:06:32 INFO - 'pip_index': False, 17:06:32 INFO - 'sps_profile': False, 17:06:32 INFO - 'sps_profile_interval': 0, 17:06:32 INFO - 'suite': 'dromaeojs', 17:06:32 INFO - 'system_bits': '32', 17:06:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:32 INFO - 'title': 'talos-linux64-ix-053', 17:06:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:32 INFO - 'use_talos_json': True, 17:06:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:32 INFO - 'work_dir': 'build'} 17:06:32 INFO - ##### 17:06:32 INFO - ##### Running clobber step. 17:06:32 INFO - ##### 17:06:32 INFO - Running pre-action listener: _resource_record_pre_action 17:06:32 INFO - Running main action method: clobber 17:06:32 INFO - rmtree: /builds/slave/test/build 17:06:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:33 INFO - Running post-action listener: _resource_record_post_action 17:06:33 INFO - ##### 17:06:33 INFO - ##### Finished clobber step (success) 17:06:33 INFO - ##### 17:06:33 INFO - ##### 17:06:33 INFO - ##### Running read-buildbot-config step. 17:06:33 INFO - ##### 17:06:33 INFO - Running pre-action listener: _resource_record_pre_action 17:06:33 INFO - Running main action method: read_buildbot_config 17:06:33 INFO - Using buildbot properties: 17:06:33 INFO - { 17:06:33 INFO - "project": "", 17:06:33 INFO - "product": "firefox", 17:06:33 INFO - "script_repo_revision": "production", 17:06:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:33 INFO - "repository": "", 17:06:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:06:33 INFO - "buildid": "20160524164037", 17:06:33 INFO - "pgo_build": "False", 17:06:33 INFO - "basedir": "/builds/slave/test", 17:06:33 INFO - "buildnumber": 1711, 17:06:33 INFO - "slavename": "talos-linux64-ix-053", 17:06:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:06:33 INFO - "platform": "ubuntu64_hw", 17:06:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:06:33 INFO - "branch": "fx-team", 17:06:33 INFO - "repo_path": "integration/fx-team", 17:06:33 INFO - "revision": "2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb", 17:06:33 INFO - "stage_platform": "linux64", 17:06:33 INFO - "builduid": "b59f325178c3489f97e0619900536160", 17:06:33 INFO - "slavebuilddir": "test" 17:06:33 INFO - } 17:06:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:06:33 INFO - Running post-action listener: _resource_record_post_action 17:06:33 INFO - ##### 17:06:33 INFO - ##### Finished read-buildbot-config step (success) 17:06:33 INFO - ##### 17:06:33 INFO - ##### 17:06:33 INFO - ##### Running download-and-extract step. 17:06:33 INFO - ##### 17:06:33 INFO - Running pre-action listener: _resource_record_pre_action 17:06:33 INFO - Running main action method: download_and_extract 17:06:33 INFO - mkdir: /builds/slave/test/build/tests 17:06:33 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')]} 17:06:33 INFO - https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:34 INFO - Downloaded 1361 bytes. 17:06:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:34 INFO - Using the following test package requirements: 17:06:34 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:34 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:34 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:34 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'jsshell-linux-x86_64.zip'], 17:06:34 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:34 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:34 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:34 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:34 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:34 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:34 INFO - https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:36 INFO - Downloaded 22844861 bytes. 17:06:36 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'] 17:06:36 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 17:06:37 INFO - Return code: 0 17:06:37 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 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:38 INFO - Downloaded 22844861 bytes. 17:06:38 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'] 17:06:38 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 17:06:39 INFO - Return code: 0 17:06:39 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')]} 17:06:39 INFO - https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:40 INFO - Downloaded 10840359 bytes. 17:06:40 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'] 17:06:40 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 17:06:40 INFO - Return code: 0 17:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:40 INFO - https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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 17:06:42 INFO - Downloaded 54823426 bytes. 17:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:42 INFO - mkdir: /builds/slave/test/properties 17:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:42 INFO - Contents: 17:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:43 INFO - Running post-action listener: _resource_record_post_action 17:06:43 INFO - Running post-action listener: set_extra_try_arguments 17:06:43 INFO - ##### 17:06:43 INFO - ##### Finished download-and-extract step (success) 17:06:43 INFO - ##### 17:06:43 INFO - ##### 17:06:43 INFO - ##### Running populate-webroot step. 17:06:43 INFO - ##### 17:06:43 INFO - Running pre-action listener: _resource_record_pre_action 17:06:43 INFO - Running main action method: populate_webroot 17:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:43 INFO - '--tppagecycles', 17:06:43 INFO - '7'], 17:06:43 INFO - 'tests': ['tsvgm']}}, 17:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['damp', 'tps']}, 17:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'tests': ['damp', 'tps']}, 17:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['dromaeo_dom']}, 17:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['a11yr', 17:06:43 INFO - 'ts_paint', 17:06:43 INFO - 'tpaint', 17:06:43 INFO - 'sessionrestore', 17:06:43 INFO - 'sessionrestore_no_auto_restore', 17:06:43 INFO - 'tabpaint']}, 17:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['tsvgx', 17:06:43 INFO - 'tsvgr_opacity', 17:06:43 INFO - 'tart', 17:06:43 INFO - 'tscrollx', 17:06:43 INFO - 'cart']}, 17:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:43 INFO - 'tsvgr_opacity', 17:06:43 INFO - 'tart', 17:06:43 INFO - 'tscrollx', 17:06:43 INFO - 'cart']}, 17:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'talos_options': ['--disable-e10s'], 17:06:43 INFO - 'tests': ['tp5o']}, 17:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'tests': ['tp5o']}, 17:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'talos_options': ['--disable-e10s', 17:06:43 INFO - '--xperf_path', 17:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:43 INFO - 'tests': ['tp5n']}, 17:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:43 INFO - 'talos_options': ['--xperf_path', 17:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:43 INFO - 'tests': ['tp5n']}}, 17:06:43 INFO - 'talos.zip': {'path': '', 17:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:43 INFO - Running post-action listener: _resource_record_post_action 17:06:43 INFO - ##### 17:06:43 INFO - ##### Finished populate-webroot step (success) 17:06:43 INFO - ##### 17:06:43 INFO - ##### 17:06:43 INFO - ##### Running create-virtualenv step. 17:06:43 INFO - ##### 17:06:43 INFO - Running pre-action listener: _resource_record_pre_action 17:06:43 INFO - Running main action method: create_virtualenv 17:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:43 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 17:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:43 INFO - Using real prefix '/usr' 17:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:45 INFO - Installing pip.................done. 17:06:45 INFO - Return code: 0 17:06:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:45 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')]} 17:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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')]} 17:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:45 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 17:06:45 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 17:06:45 INFO - Using env: {'DISPLAY': ':0', 17:06:45 INFO - 'HOME': '/home/cltbld', 17:06:45 INFO - 'LANG': 'en_US.UTF-8', 17:06:45 INFO - 'LANGUAGE': 'en_US:en', 17:06:45 INFO - 'LOGNAME': 'cltbld', 17:06:45 INFO - 'MAIL': '/var/mail/cltbld', 17:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:45 INFO - 'MOZ_NO_REMOTE': '1', 17:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:45 INFO - 'NO_EM_RESTART': '1', 17:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:45 INFO - 'PWD': '/builds/slave/test', 17:06:45 INFO - 'SHELL': '/bin/bash', 17:06:45 INFO - 'SHLVL': '1', 17:06:45 INFO - 'TERM': 'linux', 17:06:45 INFO - 'TMOUT': '86400', 17:06:45 INFO - 'USER': 'cltbld', 17:06:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:45 INFO - '_': '/tools/buildbot/bin/python'} 17:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:45 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 17:06:45 INFO - Cleaning up... 17:06:45 INFO - Return code: 0 17:06:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:06:45 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')]} 17:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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')]} 17:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:45 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 17:06:45 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 17:06:45 INFO - Using env: {'DISPLAY': ':0', 17:06:45 INFO - 'HOME': '/home/cltbld', 17:06:45 INFO - 'LANG': 'en_US.UTF-8', 17:06:45 INFO - 'LANGUAGE': 'en_US:en', 17:06:45 INFO - 'LOGNAME': 'cltbld', 17:06:45 INFO - 'MAIL': '/var/mail/cltbld', 17:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:45 INFO - 'MOZ_NO_REMOTE': '1', 17:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:45 INFO - 'NO_EM_RESTART': '1', 17:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:45 INFO - 'PWD': '/builds/slave/test', 17:06:45 INFO - 'SHELL': '/bin/bash', 17:06:45 INFO - 'SHLVL': '1', 17:06:45 INFO - 'TERM': 'linux', 17:06:45 INFO - 'TMOUT': '86400', 17:06:45 INFO - 'USER': 'cltbld', 17:06:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:45 INFO - '_': '/tools/buildbot/bin/python'} 17:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:46 INFO - Downloading/unpacking psutil>=3.1.1 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:48 INFO - Installing collected packages: psutil 17:06:48 INFO - Running setup.py install for psutil 17:06:48 INFO - building 'psutil._psutil_linux' extension 17:06:48 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 17:06:48 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 17:06:48 INFO - building 'psutil._psutil_posix' extension 17:06:48 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 17:06:48 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 17:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:48 INFO - Successfully installed psutil 17:06:48 INFO - Cleaning up... 17:06:48 INFO - Return code: 0 17:06:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:06:48 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')]} 17:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:48 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')]} 17:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:48 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:48 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 17:06:48 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 17:06:48 INFO - Using env: {'DISPLAY': ':0', 17:06:48 INFO - 'HOME': '/home/cltbld', 17:06:48 INFO - 'LANG': 'en_US.UTF-8', 17:06:48 INFO - 'LANGUAGE': 'en_US:en', 17:06:48 INFO - 'LOGNAME': 'cltbld', 17:06:48 INFO - 'MAIL': '/var/mail/cltbld', 17:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:48 INFO - 'MOZ_NO_REMOTE': '1', 17:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:48 INFO - 'NO_EM_RESTART': '1', 17:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:48 INFO - 'PWD': '/builds/slave/test', 17:06:48 INFO - 'SHELL': '/bin/bash', 17:06:48 INFO - 'SHLVL': '1', 17:06:48 INFO - 'TERM': 'linux', 17:06:48 INFO - 'TMOUT': '86400', 17:06:48 INFO - 'USER': 'cltbld', 17:06:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:48 INFO - '_': '/tools/buildbot/bin/python'} 17:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:06:50 INFO - Installing collected packages: mozsystemmonitor 17:06:50 INFO - Running setup.py install for mozsystemmonitor 17:06:51 INFO - Successfully installed mozsystemmonitor 17:06:51 INFO - Cleaning up... 17:06:51 INFO - Return code: 0 17:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:51 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 17:06:51 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 17:06:51 INFO - Using env: {'DISPLAY': ':0', 17:06:51 INFO - 'HOME': '/home/cltbld', 17:06:51 INFO - 'LANG': 'en_US.UTF-8', 17:06:51 INFO - 'LANGUAGE': 'en_US:en', 17:06:51 INFO - 'LOGNAME': 'cltbld', 17:06:51 INFO - 'MAIL': '/var/mail/cltbld', 17:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:51 INFO - 'MOZ_NO_REMOTE': '1', 17:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:51 INFO - 'NO_EM_RESTART': '1', 17:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:51 INFO - 'PWD': '/builds/slave/test', 17:06:51 INFO - 'SHELL': '/bin/bash', 17:06:51 INFO - 'SHLVL': '1', 17:06:51 INFO - 'TERM': 'linux', 17:06:51 INFO - 'TMOUT': '86400', 17:06:51 INFO - 'USER': 'cltbld', 17:06:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:51 INFO - '_': '/tools/buildbot/bin/python'} 17:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Downloading docopt-0.6.1.tar.gz 17:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:53 INFO - Running setup.py install for blobuploader 17:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:54 INFO - Running setup.py install for requests 17:06:54 INFO - Running setup.py install for docopt 17:06:54 INFO - Successfully installed blobuploader requests docopt 17:06:54 INFO - Cleaning up... 17:06:54 INFO - Return code: 0 17:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:54 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')]} 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 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')]} 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:54 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 17:06:54 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 17:06:54 INFO - Using env: {'DISPLAY': ':0', 17:06:54 INFO - 'HOME': '/home/cltbld', 17:06:54 INFO - 'LANG': 'en_US.UTF-8', 17:06:54 INFO - 'LANGUAGE': 'en_US:en', 17:06:54 INFO - 'LOGNAME': 'cltbld', 17:06:54 INFO - 'MAIL': '/var/mail/cltbld', 17:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:54 INFO - 'MOZ_NO_REMOTE': '1', 17:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:54 INFO - 'NO_EM_RESTART': '1', 17:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:54 INFO - 'PWD': '/builds/slave/test', 17:06:54 INFO - 'SHELL': '/bin/bash', 17:06:54 INFO - 'SHLVL': '1', 17:06:54 INFO - 'TERM': 'linux', 17:06:54 INFO - 'TMOUT': '86400', 17:06:54 INFO - 'USER': 'cltbld', 17:06:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:54 INFO - '_': '/tools/buildbot/bin/python'} 17:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:54 INFO - Running setup.py (path:/tmp/pip-zmIWKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:54 INFO - Running setup.py (path:/tmp/pip-NuSNAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:54 INFO - Running setup.py (path:/tmp/pip-uTNJkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:54 INFO - Running setup.py (path:/tmp/pip-kzfmU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:55 INFO - Running setup.py (path:/tmp/pip-Ka7NFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:55 INFO - Running setup.py (path:/tmp/pip-RMNeMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:55 INFO - Running setup.py (path:/tmp/pip-i4h4dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:55 INFO - Running setup.py (path:/tmp/pip-ycFw0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:55 INFO - Running setup.py (path:/tmp/pip-goox75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:55 INFO - Running setup.py (path:/tmp/pip-HVgMhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:55 INFO - Running setup.py (path:/tmp/pip-MpmRfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:55 INFO - Running setup.py (path:/tmp/pip-T6JtEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:55 INFO - Running setup.py (path:/tmp/pip-td50Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:55 INFO - Running setup.py (path:/tmp/pip-sfaXLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:55 INFO - Running setup.py (path:/tmp/pip-A3SvGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:55 INFO - Running setup.py (path:/tmp/pip-HD8Vq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:55 INFO - Running setup.py (path:/tmp/pip-XskgqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:55 INFO - Running setup.py install for manifestparser 17:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Running setup.py install for mozcrash 17:06:56 INFO - Running setup.py install for mozdebug 17:06:56 INFO - Running setup.py install for mozdevice 17:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Running setup.py install for mozfile 17:06:56 INFO - Running setup.py install for mozhttpd 17:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Running setup.py install for mozinfo 17:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Running setup.py install for mozInstall 17:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:56 INFO - Running setup.py install for mozleak 17:06:56 INFO - Running setup.py install for mozlog 17:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Running setup.py install for moznetwork 17:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Running setup.py install for mozprocess 17:06:57 INFO - Running setup.py install for mozprofile 17:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Running setup.py install for mozrunner 17:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Running setup.py install for mozscreenshot 17:06:57 INFO - Running setup.py install for moztest 17:06:57 INFO - Running setup.py install for mozversion 17:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:57 INFO - Cleaning up... 17:06:57 INFO - Return code: 0 17:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:57 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:06:57 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 17:06:57 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 17:06:57 INFO - Using env: {'DISPLAY': ':0', 17:06:57 INFO - 'HOME': '/home/cltbld', 17:06:57 INFO - 'LANG': 'en_US.UTF-8', 17:06:57 INFO - 'LANGUAGE': 'en_US:en', 17:06:57 INFO - 'LOGNAME': 'cltbld', 17:06:57 INFO - 'MAIL': '/var/mail/cltbld', 17:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:57 INFO - 'MOZ_NO_REMOTE': '1', 17:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:57 INFO - 'NO_EM_RESTART': '1', 17:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:57 INFO - 'PWD': '/builds/slave/test', 17:06:57 INFO - 'SHELL': '/bin/bash', 17:06:57 INFO - 'SHLVL': '1', 17:06:57 INFO - 'TERM': 'linux', 17:06:57 INFO - 'TMOUT': '86400', 17:06:57 INFO - 'USER': 'cltbld', 17:06:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:57 INFO - '_': '/tools/buildbot/bin/python'} 17:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:57 INFO - Running setup.py (path:/tmp/pip-8he11w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:58 INFO - Running setup.py (path:/tmp/pip-nMBhR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:58 INFO - Running setup.py (path:/tmp/pip-z6xWqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:58 INFO - Running setup.py (path:/tmp/pip-2b13Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:58 INFO - Running setup.py (path:/tmp/pip-81WETB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:58 INFO - Running setup.py (path:/tmp/pip-N26Ecd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:58 INFO - Running setup.py (path:/tmp/pip-QhQT6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:58 INFO - Running setup.py (path:/tmp/pip-DVh8vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:58 INFO - Running setup.py (path:/tmp/pip-qv4Ji6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:58 INFO - Running setup.py (path:/tmp/pip-VpNx4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:58 INFO - Running setup.py (path:/tmp/pip-_ykQV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:58 INFO - Running setup.py (path:/tmp/pip-aIbs8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:58 INFO - Running setup.py (path:/tmp/pip-QF_mra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:58 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)) 17:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:58 INFO - Running setup.py (path:/tmp/pip-mvVWz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:59 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)) 17:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:59 INFO - Running setup.py (path:/tmp/pip-kjN5l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:59 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)) 17:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:59 INFO - Running setup.py (path:/tmp/pip-9YGjO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:59 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)) 17:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:59 INFO - Running setup.py (path:/tmp/pip-5n_fqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:59 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)) 17:06:59 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)) 17:06:59 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)) 17:06:59 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)) 17:06:59 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)) 17:06:59 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)) 17:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:59 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 17:06:59 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 17:06:59 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 17:06:59 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 17:06:59 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 17:06:59 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 17:07:01 INFO - Downloading blessings-1.6.tar.gz 17:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:07:01 INFO - Installing collected packages: blessings 17:07:01 INFO - Running setup.py install for blessings 17:07:01 INFO - Successfully installed blessings 17:07:01 INFO - Cleaning up... 17:07:01 INFO - Return code: 0 17:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:01 INFO - Reading from file tmpfile_stdout 17:07:01 INFO - Current package versions: 17:07:01 INFO - argparse == 1.2.1 17:07:01 INFO - blessings == 1.6 17:07:01 INFO - blobuploader == 1.2.4 17:07:01 INFO - docopt == 0.6.1 17:07:01 INFO - manifestparser == 1.1 17:07:01 INFO - mozInstall == 1.12 17:07:01 INFO - mozcrash == 0.17 17:07:01 INFO - mozdebug == 0.1 17:07:01 INFO - mozdevice == 0.48 17:07:01 INFO - mozfile == 1.2 17:07:01 INFO - mozhttpd == 0.7 17:07:01 INFO - mozinfo == 0.9 17:07:01 INFO - mozleak == 0.1 17:07:01 INFO - mozlog == 3.2 17:07:01 INFO - moznetwork == 0.27 17:07:01 INFO - mozprocess == 0.22 17:07:01 INFO - mozprofile == 0.28 17:07:01 INFO - mozrunner == 6.11 17:07:01 INFO - mozscreenshot == 0.1 17:07:01 INFO - mozsystemmonitor == 0.3 17:07:01 INFO - moztest == 0.7 17:07:01 INFO - mozversion == 1.4 17:07:01 INFO - psutil == 3.1.1 17:07:01 INFO - requests == 1.2.3 17:07:01 INFO - wsgiref == 0.1.2 17:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:07:01 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 17:07:01 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 17:07:01 INFO - Using env: {'DISPLAY': ':0', 17:07:01 INFO - 'HOME': '/home/cltbld', 17:07:01 INFO - 'LANG': 'en_US.UTF-8', 17:07:01 INFO - 'LANGUAGE': 'en_US:en', 17:07:01 INFO - 'LOGNAME': 'cltbld', 17:07:01 INFO - 'MAIL': '/var/mail/cltbld', 17:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:01 INFO - 'MOZ_NO_REMOTE': '1', 17:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:01 INFO - 'NO_EM_RESTART': '1', 17:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:01 INFO - 'PWD': '/builds/slave/test', 17:07:01 INFO - 'SHELL': '/bin/bash', 17:07:01 INFO - 'SHLVL': '1', 17:07:01 INFO - 'TERM': 'linux', 17:07:01 INFO - 'TMOUT': '86400', 17:07:01 INFO - 'USER': 'cltbld', 17:07:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:01 INFO - '_': '/tools/buildbot/bin/python'} 17:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 INFO - Cleaning up... 17:07:01 INFO - Return code: 0 17:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:07:01 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 17:07:01 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 17:07:01 INFO - Using env: {'DISPLAY': ':0', 17:07:01 INFO - 'HOME': '/home/cltbld', 17:07:01 INFO - 'LANG': 'en_US.UTF-8', 17:07:01 INFO - 'LANGUAGE': 'en_US:en', 17:07:01 INFO - 'LOGNAME': 'cltbld', 17:07:01 INFO - 'MAIL': '/var/mail/cltbld', 17:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:01 INFO - 'MOZ_NO_REMOTE': '1', 17:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:01 INFO - 'NO_EM_RESTART': '1', 17:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:01 INFO - 'PWD': '/builds/slave/test', 17:07:01 INFO - 'SHELL': '/bin/bash', 17:07:01 INFO - 'SHLVL': '1', 17:07:01 INFO - 'TERM': 'linux', 17:07:01 INFO - 'TMOUT': '86400', 17:07:01 INFO - 'USER': 'cltbld', 17:07:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:01 INFO - '_': '/tools/buildbot/bin/python'} 17:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:01 INFO - Downloading/unpacking jsonschema 17:07:01 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 17:07:01 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 17:07:01 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 17:07:01 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 17:07:01 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 17:07:01 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 17:07:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:04 INFO - warning: no files found matching '*.txt' 17:07:04 INFO - no previously-included directories found matching 'build' 17:07:04 INFO - no previously-included directories found matching 'dist' 17:07:04 INFO - no previously-included directories found matching '.git*' 17:07:04 INFO - Installing collected packages: jsonschema, functools32 17:07:04 INFO - Running setup.py install for functools32 17:07:04 INFO - warning: no files found matching '*.txt' 17:07:04 INFO - no previously-included directories found matching 'build' 17:07:04 INFO - no previously-included directories found matching 'dist' 17:07:04 INFO - no previously-included directories found matching '.git*' 17:07:04 INFO - Successfully installed jsonschema functools32 17:07:04 INFO - Cleaning up... 17:07:04 INFO - Return code: 0 17:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:04 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 0x7fccbd2cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, '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': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', '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 17:07:04 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 17:07:04 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 17:07:04 INFO - Using env: {'DISPLAY': ':0', 17:07:04 INFO - 'HOME': '/home/cltbld', 17:07:04 INFO - 'LANG': 'en_US.UTF-8', 17:07:04 INFO - 'LANGUAGE': 'en_US:en', 17:07:04 INFO - 'LOGNAME': 'cltbld', 17:07:04 INFO - 'MAIL': '/var/mail/cltbld', 17:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:04 INFO - 'MOZ_NO_REMOTE': '1', 17:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:04 INFO - 'NO_EM_RESTART': '1', 17:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:04 INFO - 'PWD': '/builds/slave/test', 17:07:04 INFO - 'SHELL': '/bin/bash', 17:07:04 INFO - 'SHLVL': '1', 17:07:04 INFO - 'TERM': 'linux', 17:07:04 INFO - 'TMOUT': '86400', 17:07:04 INFO - 'USER': 'cltbld', 17:07:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:04 INFO - '_': '/tools/buildbot/bin/python'} 17:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:04 INFO - Downloading/unpacking flake8 17:07:04 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 17:07:04 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 17:07:04 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 17:07:04 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 17:07:04 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 17:07:04 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 17:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:06 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 17:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:07 INFO - no previously-included directories found matching 'docs/_build' 17:07:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:07 INFO - Running setup.py install for pep8 17:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:07 INFO - no previously-included directories found matching 'docs/_build' 17:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:07 INFO - Cleaning up... 17:07:07 INFO - Return code: 0 17:07:07 INFO - Running post-action listener: _resource_record_post_action 17:07:07 INFO - Running post-action listener: _start_resource_monitoring 17:07:07 INFO - Starting resource monitoring. 17:07:07 INFO - ##### 17:07:07 INFO - ##### Finished create-virtualenv step (success) 17:07:07 INFO - ##### 17:07:07 INFO - ##### 17:07:07 INFO - ##### Running install step. 17:07:07 INFO - ##### 17:07:07 INFO - Running pre-action listener: _resource_record_pre_action 17:07:07 INFO - Running main action method: install 17:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:07 INFO - Reading from file tmpfile_stdout 17:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:07 INFO - Reading from file tmpfile_stdout 17:07:07 INFO - Output received: 17:07:07 INFO - Usage: mozinstall [options] installer 17:07:07 INFO - Options: 17:07:07 INFO - -h, --help show this help message and exit 17:07:07 INFO - -d DEST, --destination=DEST 17:07:07 INFO - Directory to install application into. [default: 17:07:07 INFO - "/builds/slave/test"] 17:07:07 INFO - --app=APP Application being installed. [default: firefox] 17:07:07 INFO - mkdir: /builds/slave/test/build/application 17:07:07 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'] 17:07:07 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 17:07:23 INFO - Reading from file tmpfile_stdout 17:07:23 INFO - Output received: 17:07:23 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:23 INFO - Running post-action listener: _resource_record_post_action 17:07:23 INFO - ##### 17:07:23 INFO - ##### Finished install step (success) 17:07:23 INFO - ##### 17:07:23 INFO - ##### 17:07:23 INFO - ##### Running run-tests step. 17:07:23 INFO - ##### 17:07:23 INFO - Running pre-action listener: _resource_record_pre_action 17:07:23 INFO - Running main action method: run_tests 17:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:23 INFO - Python 2.7.3 17:07:23 INFO - Return code: 0 17:07:23 INFO - grabbing minidump binary from tooltool 17:07:23 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')]} 17:07:23 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 0x2cc29c0>, '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 0x2cc38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:23 INFO - Return code: 0 17:07:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:24 INFO - Return code: 0 17:07:24 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/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 17:07:24 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/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 17:07:24 INFO - Using env: {'DISPLAY': ':0', 17:07:24 INFO - 'HOME': '/home/cltbld', 17:07:24 INFO - 'LANG': 'en_US.UTF-8', 17:07:24 INFO - 'LANGUAGE': 'en_US:en', 17:07:24 INFO - 'LOGNAME': 'cltbld', 17:07:24 INFO - 'MAIL': '/var/mail/cltbld', 17:07:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:24 INFO - 'MOZ_NO_REMOTE': '1', 17:07:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:24 INFO - 'NO_EM_RESTART': '1', 17:07:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:24 INFO - 'PWD': '/builds/slave/test', 17:07:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:24 INFO - 'SHELL': '/bin/bash', 17:07:24 INFO - 'SHLVL': '1', 17:07:24 INFO - 'TERM': 'linux', 17:07:24 INFO - 'TMOUT': '86400', 17:07:24 INFO - 'USER': 'cltbld', 17:07:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639', 17:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:24 INFO - '_': '/tools/buildbot/bin/python'} 17:07:24 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/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 17:07:24 INFO - mozversion application_buildid: 20160524164037 17:07:24 INFO - mozversion application_changeset: 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb 17:07:24 INFO - mozversion application_display_name: Nightly 17:07:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:24 INFO - mozversion application_name: Firefox 17:07:24 INFO - mozversion application_remotingname: firefox 17:07:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:07:24 INFO - mozversion application_vendor: Mozilla 17:07:24 INFO - mozversion application_version: 49.0a1 17:07:24 INFO - mozversion platform_buildid: 20160524164037 17:07:24 INFO - mozversion platform_changeset: 2062a9e37ad9b4ccb4eac3d3e34ab67dd407b4eb 17:07:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:07:24 INFO - mozversion platform_version: 49.0a1 17:07:24 INFO - using testdate: 1464134844 17:07:24 INFO - actual date: 1464134844 17:07:24 INFO - starting webserver on 'localhost:44871' 17:07:24 INFO - SUITE-START | Running 2 tests 17:07:24 INFO - TEST-START | dromaeo_css 17:07:24 INFO - operating with platform_type : linux_ 17:07:24 INFO - Initialising browser for dromaeo_css test... 17:07:24 INFO - TEST-INFO | started process 9588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp132qHr/profile http://localhost:44871/getInfo.html) 17:07:29 INFO - PROCESS | 9588 | __metrics Screen width/height:1600/1200 17:07:29 INFO - PROCESS | 9588 | colorDepth:24 17:07:29 INFO - PROCESS | 9588 | Browser inner width/height: 1024/697 17:07:29 INFO - PROCESS | 9588 | __metrics 17:07:30 ERROR - PROCESS | 9588 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:07:31 INFO - TEST-INFO | 9588: exit 0 17:07:31 INFO - Browser initialized. 17:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:31 INFO - TEST-INFO | started process 9670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp132qHr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:43 INFO - PROCESS | 9670 | RSS: Main: 154464256 17:07:43 INFO - PROCESS | 9670 | 17:08:34 INFO - PROCESS | 9670 | 1464134914072 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] 17:10:46 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44871/tests/dromaeo/cssquery-ext.html) 17:10:47 INFO - PROCESS | 9670 | RSS: Main: 232222720 17:10:47 INFO - PROCESS | 9670 | 17:13:50 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-ext.html (next: http://localhost:44871/tests/dromaeo/cssquery-jquery.html) 17:13:50 INFO - PROCESS | 9670 | RSS: Main: 234831872 17:13:50 INFO - PROCESS | 9670 | 17:16:53 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44871/tests/dromaeo/cssquery-mootools.html) 17:16:53 INFO - PROCESS | 9670 | RSS: Main: 237031424 17:16:53 INFO - PROCESS | 9670 | 17:19:55 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44871/tests/dromaeo/cssquery-prototype.html) 17:19:56 INFO - PROCESS | 9670 | RSS: Main: 243642368 17:19:56 INFO - PROCESS | 9670 | 17:22:59 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44871/tests/dromaeo/cssquery-yui.html) 17:22:59 INFO - PROCESS | 9670 | RSS: Main: 208154624 17:22:59 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-yui.html (next: http://localhost:44871/tests/dromaeo/cssquery-dojo.html) 17:26:02 INFO - PROCESS | 9670 | RSS: Main: 271917056 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | __start_tp_report 17:26:02 INFO - PROCESS | 9670 | _x_x_mozilla_page_load 17:26:02 INFO - PROCESS | 9670 | _x_x_mozilla_page_load_details 17:26:02 INFO - PROCESS | 9670 | |i|pagename|runs| 17:26:02 INFO - PROCESS | 9670 | |0;dojo.html;2683.38282195095;2701.5542435498137;2735.206790030891;2739.055026016025;2767.972320276797;4659.790309436075;4731.053789242148;4733.526647335265;4821.083994041134;4859.392575928009;4728.030753695492;4729.810807567702;4748.453927798304;4789.353437285965;4793.328933949241;4309.913801723964;4340.08858139791;4379.781010949456;4401.449818772653;4525.366448697185;4459.665525085616;4472.597466228039;4485.080558485519;4524.932126018096;4545.681802273843;4224.049588842486;4296.291111966521;4349.652027837766;4358.65130789536;4383.167198232358;4330.7401555906745;4334.219840428722;4340.6093451589195;4447.777611119431;4470.508244093147;4392.582704643054;4407.449068866392;4413.157177205476;4416.1167766446515;4458.687891847572;4548.431446069241;4636.374089497942;4675.251959686468;4738.739369334685;4773.689710168828;5108.412532558729;5138.588912886998;5144.0740666679985;5156.896862062776;5160.948390516084;5166.664166829144;5175.0943584872875;5183.300254465675;5187.299714538527;5197.922031169498;4667.906641867144;4733.171694953369;4759.190937540627;4766.213574760126;4843.927341089887;5178.093833579109;5198;5216.895662086737;5263.6315457918345;5266.894662106736;5066.240063990431;5066.898662026812;5067.366579177603;5069.036882992294;5072.568831649277;4991.101601711727;5043.672161309503;5046.84859454217;5057.115004874132;5072.5688316493515;4997.225430058346;5018.121828679967;5024.472430394829;5032.547070763576;5075.441701412841;4867.5132486751045;5022.121128802445;5024.296598476143;5025.773840177201;5029.1450453423;4270.935935960963;4305.203537345601;4317.978410107929;4347.456567929009;4348.065165989265;3774.4338349247832;3787.1289603391374;3790.677792387623;3794.5256842894637;3816.9427458588143;4335.089631177425;4383.342498625232;4416.315471101984;4418.536053714378;4455.576720211575;5073.644844860824;5073.822416215415;5099.286099946011;5121.846344609593;5122.487751224848;4433.977830110829;4443.666724995638;4444.977655139336;4446.6220371268155;4473.194824931544;4522.050369422458;4607.9308810367875;4636.420447444069;4639.164950308977;4682.063587282557;4828.855134345975;4832.251001094765;4857.077155340474;4860.3681521401995;4903.264510323337;5124.390280433478;5136.5377116059735;5139.768710407966;5143.4085080216255;5192.091384007859;4672.415948006499;4826.396700412449;4840.1529732296;4846.636502262274;4900.387451568554;5072.239164125411;5084.745762711924;5088.821891233789;5095.668781529189;5131.615128865425;5139.997700448526;5153.793848246029;5154.226865970135;5162.561182299396;5196.194589838581;4881;4950.45544990058;4953.23224900141;4961.5286547777905;5009.699418034929;4950.554450099508;4976.576990955665;4977.153883839684;4980.800767969241;5032.018756342478;4902.1911384621135;4910.06708725341;4914.680545764514;4950.935548857013;4964.3298154748645;4870.829520966749;4983.103041452428;5032.018756342478;5035.949640503548;5058.266551350107;4919.926201106915;4945.653804233669;4948.257761335828;4948.406191257072;4997.85006449807 17:26:02 INFO - PROCESS | 9670 | |1;ext.html;569.5159114752461;584.6024703201824;587.6738410182347;599.9400059994;614.846288427893;27314.86342568287;27978.580321295198;30892.84553577229;30970.380592388137;30983.225419364528;41276.79361603195;42390.57609423905;42497.15005699884;46534.30198547024;46621.53378466214;7467.925320746805;7667.309942105209;7672;7674;7678.347340476066;7552.395808335347;7635.350995165418;7642.503237289586;7652.31129198372;7659.731909383173;7691.346235569955;7738.226177382245;7738.883916741253;7739.806504837367;7740.187280335568;7645.350145237661;7684;7685.846283074363;7689.538627682357;7690.461667683265;7609.543427394374;7666.808329791744;7682.961585192094;7688.38492920565;7695.769126926201;36997;37720.245595087945;37813;37847.432288515694;37866.62133378686;3211.8394080295893;3228.741700663965;3265.330607225513;3445.6554344565593;3539.6460353964653;27536.862315688293;28149.85925070382;28157.43685126286;28185.57721634177;29251.414971700447;3430.142464383904;3455.8617655293756;3462.722982161421;3488.7034602058857;3544.7164226861787;220649.8967505168;220955;221172;221472;221722;49229.261561076615;49245;49460.258096127865;49668.25497617466;49767.25349119766;51834.74082629638;54365.45634543683;55804.44195558074;55904;60953;13935.721285574231;13951.65120871966;13952.372143253579;13991.370388332549;14030;10239.334443261165;10481.161507079416;10542.367457952547;10556;10563.471826408802;15290.617734556503;15762.684746305009;15805.52583422499;16044.919775401047;16360.754588681179;6068.969655151696;6121.163650904711;6132.540059495466;6161.568690191643;6174.722137503823;787.9251471110235;849.1041950741903;900.0729248873671;906.5603182456504;1027;28054.43891122166;28383.57424638632;28451.430971380458;28494.71505284962;28844.855775720986;980.67637679567;1003.19744204636;1038.2628333882876;1044.6970378590277;1063.1282348474176;14731.558053258419;15172.241387930559;15200.923995379952;15436.382544698086;15461.5361539154;115919;116627;116758;116970;117080;51895;52421.73789131106;52574;52580.319377643966;52768;1090.536521978156;1179.7699448607439;1224.895883849865;1229.5327775445453;1233.771752225823;28577.42845143127;29262.414751704422;29520.852395737882;29563.556546651387;30024.748143889734;42357.5764242366;42832.35751463793;42868;42880;42999.355009674255;301567;307776;308140;308723;309130;32615.510767338033;35789.46315805213;36339.81830090833;37370.813145934095;39531;42076.158476830904;42760.57239427566;42805.57194428016;43579;43595.948283619844;36487.817560913085;36713.08941830829;36930.63069369272;37063.44404833876;37243.44134837925;36770.448443272835;36968.63031369759;36997.81501092585;37093.443598345504;37141.44287835739;35542.289154216254;36232.81883590565;36383;36537.634623654485;36633.63366366302;32130.196745080626;32687.824283971375;33047.50428743619;33162.170945725586;33329.166770830925;24656.260312189945;25579;27290.72709272882;27400.90396384202;27457.86271068632 17:26:02 INFO - PROCESS | 9670 | |2;jquery.html;357.69417148338164;365.7001258967646;369.8834867016889;378.2246394890474;384.5251114873129;15953.44162954297;17257.48227553174;17270.395536156237;17641.911790441063;17755.46733597991;16202.918985405056;16471.752923706154;17279.740803887922;17372.56568585786;17383.82616173838;4807.6153907687385;5022.899542009158;5024.673396229252;5044.848654540369;5044.873878153039;3679.22736225393;3849.1531862990096;4920.409550853902;5520.227168196456;5831.9416805831825;5807.825765227029;5853.707314634273;5882.176495290662;5892.057270836667;5897.174395584621;5709.885802283952;5720.456556627114;5759.222504961839;5803.767849286023;5907.6160049597065;3296.653851345622;4775.594074503671;5053.797848086072;5095.490450954912;5154.07226699194;19729;20433.79566204334;20530.281440149673;20806.895965520074;20818.687719684218;1916.5112896211376;1982.2071171531359;1992.471994921347;2090.1221486975505;2221.5112675211426;12909.741805163843;13026.739465210738;13027.478900843955;13227.032798171973;13255.46978120874;1716.399260258912;1807.9096045197687;1810.9547261318442;1815.3918437323512;1867.2344338821017;67087;67839;67909;68049;68315.3168468314;9002.819943601091;9035.232005279493;9048.954755226181;9495.57269922855;9509.144177023963;12005.399730013465;12068.215565988183;12080.335581542924;12117.87882121185;12121.515139394502;6820.139610871845;6982.581045137308;7044.823879403056;7112.751053713198;7116.786496405012;6830;6834.897476537856;6868.553544019623;6963.651817409109;7018.75434359795;5973.313068997034;6031.638101713911;6105.755769769248;6160.476359509402;6218.875622487525;1505.3150816378522;1642.2199455258656;1654.2225154177518;1755.6400937807718;1767.8585713142918;888.1651247827022;904.6426661468684;920.2775820980498;947.6920000999703;955.6464108279841;16910.57723556921;16994.74507882358;17442.825571744375;17451.301947922195;17783.46649600514;836.0228060636672;910.8679241509944;930.2883294279882;931.753085432361;950.7147855643418;9325.393849399767;9660.806783864284;9669.226461883032;9672.322937394314;9764.316497845224;399180;409686;413635;419598;420944;49012.75493622581;58257;79657;80426.59786701146;82719.58640206761;939.6805086270564;976.1214906584131;977.4819345746765;980.8234517786724;994.5524513968887;15622.375104995674;15833.208339583205;15920.681586368439;16075.839241607435;16092.517224483285;35287.64712352843;35337.82331088328;36280;36341;36524.26951460903;48853.51146488632;49688.503114968385;49907.50092499029;50602.746986266306;50708.492915070376;7669.578173200527;7751.37988960893;7801.4929029612895;7874;7963.800904977422;8403.789905252417;10315.638952636622;11180.440977950908;11209.495572699085;11442.37066961325;9497.952510237405;9498.862755879873;9809.773778277715;9824.45965471906;9937.65218217359;9503.524823758922;9655.710328690151;9882.357646752938;9922.454265015493;9990.550425230736;9792.363496372713;9827.606895724091;9855.901440985785;10024.097831195228;10107.64623238183;7586.279303466162;7647.808804779925;7690.154083050748;7728.149903510722;7742.845143097219;7986.600669966595;9459.054094590761;9470.526473676151;9626;10182.745431364276 17:26:02 INFO - PROCESS | 9670 | |3;mootools.html;1196.1985469735278;1432.878205352545;1455.8253009638843;1609.4366971559948;1794.4796009157344;6999.860002799941;7845.372370210383;7983.680652773889;7990.400719945998;8298.377621678368;7989;8151.021877374708;8153.429259951806;8175.591220438984;8202.548859812709;2191.1783081344533;2215.268961242794;2218.5784700906856;2220.578090162864;2221.1892659179366;2172.511184983374;2216.7229096362953;2217.855839370444;2219.4451387153213;2220.0897631970897;2174.9891250543806;2200.713907192063;2205.503761653631;2206.4263291544153;2213.656883183109;2125.7449106107288;2134.4130364149905;2134.8505604607685;2136.3484137338105;2137.187868609934;2086.1029757204396;2119.9258025969016;2120.7243058402464;2121.734783152106;2124.808767210943;7762.340201082915;8104;8169.67321307147;8190.467619604707;8195.83608327836;4659.301104834268;4854.150523658381;4856.927146092811;4857.17428037231;4862.3922009748785;2983.7911346205774;2995.026616349695;2999.7750168737434;3035.3777475617444;3035.4080954213937;914.6021480655936;919.1773362840287;939.2439086535336;956.9665061722807;959.1415682963708;11026.614068507644;11114.666560003212;11127.054200392977;11145.387003714792;11159.051480624157;4025.275450418953;4095.610916962884;4171.207470580641;4178.331466965332;4178.477690288714;8650.956745216234;8728.170823771732;8728.519931403835;8738.25724813398;8741.912580874237;4610.76946152691;4699.530046995274;4705.317728929286;4709.552592503706;4713.033828065239;3704.5184126063978;4095.89760255996;4235.788210589458;4328.28583283761;4345.152695224401;3493.4934434507363;3525.347810655037;3565.6612621800887;3581.4448760442174;3630.5643322801434;968.1770495079127;972.7908499672462;976.9169620582188;981.3130808434124;1011.1304278320638;651.1762620285343;687.8306878306898;872.1322284327135;872.1845074855031;906.7325139083986;5291.3385826771655;5340.839774806762;5389.676619402849;5437.401885792559;5487.972560137254;918.8529835226332;919.935604507678;943.7404713703786;964.5852283518154;984.640606178754;3670.7797532148156;3832.3485007548784;3844.1735026969336;3873.4383514390256;3913.72603917723;9690.176335011462;9810.852837207447;9927.950360248296;9998.20014398861;10002.649907253211;9667.709849103887;9777.853332200022;9848.310618256653;9855.704328870146;9866.112049915542;7544.735934242385;7557.886631700529;7672.846543069219;7673.155952845294;7709.190534993857;5386.245925570345;5471.917921231265;5486.478784515464;5573.414791447002;5586.273784408001;8978.506182160045;9272.768180795534;9300.302477314364;9489.715308540755;9536.904630953879;9201.079892010745;9294.117058879396;9400.482973436254;9477.763055923657;9602.519874006412;5668.659880407189;6047.909281360695;6730.091437655854;6865.141857267841;7005.824854378681;7735.883961740691;7774;7810.531368117931;7833.216678332121;7859.764207073797;6760.5242531575;6828.112345395067;6930.48021398387;7014.754483593049;7015.964920175366;6893.379595836399;6930.44556435494;6963.582185068912;7039;7043.718251269892;6285.748570057147;6346;6346;6374.968125159345;6401.615903045832;4632.953670463252;4702.224133018014;4744.952550474451;4755.429348478205;4769.499202583817;4841.661083724105;4853.587445067209;4899.118158731462;4933.827316043921;4999.975000124976 17:26:02 INFO - PROCESS | 9670 | |4;prototype.html;290.5423957267304;299.5760998187564;300.54317437494996;301.2228450597456;304.02256744566216;4750.524947505252;4772.284157376395;4785.5214478552125;4795.064962332347;4802.471728109914;4674.906501869969;4684.297355396684;4733.905321893569;4735.502772208912;4760.928586071212;3545.1314427965185;3688.6126956669564;3689.8893033209047;3726.049857286388;3764.6800021998024;3696.223793003459;3719.1445967427508;3719.553653561563;3727.2172843702856;3730.123420996077;3563.4476656118345;3715.5541335039834;3725.8323375448035;3731.7574357666663;3735.140917588956;3574.9275217434797;3673.742838001341;3675.2358867743364;3678.6321367863;3679.9264014719824;3285.2936618626873;3287.7534184936226;3290.2596915693775;3292.209869631295;3324.517944897976;4538.977305113486;4553.476350219701;4554.362389265505;4568.177728008957;4574.245249533823;3984;4181.958180418218;4194.224068547329;4235.343521754102;4276.31578947367;4936.629752768521;4954.752262386903;4955.306257124005;4966.652334336598;4972.254161875748;3501.2297294595405;3501.57981042274;3512.8067956262394;3514.1390359361862;3521.8767343142868;5030.597552195815;5162;5171.586273098181;5202.037623039712;5211.843644690665;3595.5865075516126;3601.4957905893198;3605.152789094561;3616.385214513539;3618.4753210784816;3661.5423072115987;3679.5032670589662;3681.9447708284397;3695.316366472211;3695.7619197569115;4188.8324467020975;4191.287481128215;4202.810873510699;4208.600182982612;4209.957900421018;4871.269309603588;4973.32860063894;4981.352424184905;5003.5997120230295;5005.3242812220615;1261.4701825233424;1265.9810102848464;1270.720441502868;1277.2783377391745;1279.2772083772825;794.1938931984041;801.587182600961;802.5987006496752;827.462149602751;841.2302742990217;4345.391645169679;4376.562343765661;4388.71473354231;4391.209582275221;4419.734815911055;4997.350344455271;4998.175301075355;5017.147084995559;5019.0965626187635;5037.798488060436;4266.360045993064;4359.04101097758;4375.321825117112;4385.320275357325;4408.338749187647;2622.868856557203;2652.9734702652727;2654;2658.282263788766;2661.8953134449375;4733.692309999908;4740.3837501124635;4767.499412561631;4775.283707443842;4794;4866.343043689128;5099.413567439718;5108.208227724708;5132.640715149978;5139.537441630197;4757.928631070606;4771.7593425709565;4785.976070119627;4803.519648035169;4806;5018.4730603286125;5028.421731500925;5030.798768049383;5034.924476132787;5041.596672266137;4763.83286094909;4909.877253068559;4919.434265059564;4922.523243027006;4940.357753492023;4920.21276595743;4931.9753401232765;4935.679180853376;4937.481564435682;4942.382202224722;3622.3841946869625;3664.3221004114325;3675.5038069860225;3680.2823449427106;3688.2992231475932;5070.569001634903;5158.767855446439;5166.914947860992;5184.481551844785;5213.504717051874;4897.142999975062;4965.776540055778;4975.527324904128;4987.576056035133;5020.447750747342;4953.182724850503;4956.430010548833;4961.5286547777905;4981.975090124526;5007.924881126859;4699.906001880012;4878.243872199815;4912.877178070434;4913.224028423929;4924.50754924519;4798.912473074224;4862.197737373293;4972.637996951419;4997.425296090996;5000.249962505508;4852.660313778143;4873.220284754422;4874.2444921037295;4889.9022019560125;4901.166801643801 17:26:02 INFO - PROCESS | 9670 | |5;yui.html;647.7020570537552;681.6625770243727;738.162185918982;760.418280015788;777.234424092269;12503.06227032974;12620.558280460185;12624.305663188521;12713.555025574107;12743.617691469259;12371.566995155172;12555;12612.62162135135;12632.368381580907;12639.620811375651;648.2868844271311;786.4769927997875;802.0856223904739;808.4421748993205;813.6948644258404;813.8128230506987;822.9218224268685;823.0822632764455;823.3660081737058;824.2334628795218;855.1448551448551;858.3991206155684;858.9742307730747;859.3683642522741;859.5186695450536;678.7658257901016;832.2551316571635;847.0597636623343;853.1766844994579;858.4505916213566;626.4706323156971;626.7179769103876;626.8558231606711;627.1408170805979;627.2034516164491;12378.62864114069;12399.566015189515;12411.503539858395;12437.689057773629;12443.813342799865;11970.401479926057;12323.198992065487;12361.505539778398;12494.81257781134;12698.111132220749;10829.458527073615;10866.67399978002;10933.945330273376;11095.944520277428;11190.496427660693;4101.241270364992;4110.630043296118;4142.813573389205;4146.91706165875;4209.010882442623;46109;46269.305960410624;46379.76810115928;46388.76805615984;46787.532124678655;9900.257480688833;10023;10033.09702126812;10063.798724025479;10194.43930583825;17924.283028678707;17954.102294885204;17977.280908763765;17997.37009204698;18018.90990545065;6826.351496607815;6915.757948471779;6932.930670693228;7001.194862590765;7118.039064726196;3700.389435743126;3793.2982398256413;3794.9430758538642;3800.0879788850475;3802.5817160112365;2715.117586784303;2792.972070279271;2798.748112669829;2800.6779220389917;2804.831710097401;510.6323447118069;521.3457111325338;529.5551736541324;534.770048878978;543.1852221667499;419.56169193459914;438.8968592380788;548.9560835133179;556.274062348639;562.2999365789618;8321.334293256525;8706.738797836075;8742.737717868475;8750.64997400097;8895;573.87948530809;612.3784358875745;630.0043294136443;632.8734253149388;648.9849018796568;3912.8239229234755;3984.7609143451486;3988.8404463821703;4052.371882358239;4077.85727499542;49893;52244;52701;52875.73562132165;52979.470205298225;47817.76091119592;47944.520554794704;49273;49460.258096128586;50814.49185508172;43529.30029372626;44714.3292850601;44779;45000;45470;7618.733344332922;7662.501937374052;7763.262490063435;7815.882761758692;7854.567998759894;31162;31253;31259;31351.05946821599;31482.055538333887;37018.444723328634;40023.1995360097;40062.399064014644;40715.38926916039;40857.59142408538;9023.413478124163;10442.112420444044;10461.738456538647;10595.523201456108;10772.138228941509;10156.796864062826;10282.691519254435;10299.330543514647;10327.277090603586;10571.524281407508;9203.40177888435;9591.856122158313;9681.9031809681;9715.514224288898;9797.167240784329;9132.269418446642;9572;9729.173020293354;10017.499125043865;10946.159739704299;11125.499352529318;11361.659150225507;11484.483198255932;11961.461734221806;12169.69575760613;9555.761105972406;9764;9976.850347244943;10126.72099464027;10150.021346518508;8893.955530222567;9019.188273055457;9551.235901128031;9742.561584728846;9794.559244833858 17:26:02 INFO - PROCESS | 9670 | __end_tp_report 17:26:02 INFO - PROCESS | 9670 | __start_cc_report 17:26:02 INFO - PROCESS | 9670 | _x_x_mozilla_cycle_collect,1038 17:26:02 INFO - PROCESS | 9670 | __end_cc_report 17:26:02 INFO - PROCESS | 9670 | __startTimestamp1464135962592__endTimestamp 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | ------- Summary: start ------- 17:26:02 INFO - PROCESS | 9670 | Number of tests: 6 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#0] dojo.html Cycles:165 Average:4725.26 Median:4860.37 stddev:487.55 (10.0%) stddev-sans-first:461.99 17:26:02 INFO - PROCESS | 9670 | Values: 2683.4 2701.6 2735.2 2739.1 2768.0 4659.8 4731.1 4733.5 4821.1 4859.4 4728.0 4729.8 4748.5 4789.4 4793.3 4309.9 4340.1 4379.8 4401.4 4525.4 4459.7 4472.6 4485.1 4524.9 4545.7 4224.0 4296.3 4349.7 4358.7 4383.2 4330.7 4334.2 4340.6 4447.8 4470.5 4392.6 4407.4 4413.2 4416.1 4458.7 4548.4 4636.4 4675.3 4738.7 4773.7 5108.4 5138.6 5144.1 5156.9 5160.9 5166.7 5175.1 5183.3 5187.3 5197.9 4667.9 4733.2 4759.2 4766.2 4843.9 5178.1 5198.0 5216.9 5263.6 5266.9 5066.2 5066.9 5067.4 5069.0 5072.6 4991.1 5043.7 5046.8 5057.1 5072.6 4997.2 5018.1 5024.5 5032.5 5075.4 4867.5 5022.1 5024.3 5025.8 5029.1 4270.9 4305.2 4318.0 4347.5 4348.1 3774.4 3787.1 3790.7 3794.5 3816.9 4335.1 4383.3 4416.3 4418.5 4455.6 5073.6 5073.8 5099.3 5121.8 5122.5 4434.0 4443.7 4445.0 4446.6 4473.2 4522.1 4607.9 4636.4 4639.2 4682.1 4828.9 4832.3 4857.1 4860.4 4903.3 5124.4 5136.5 5139.8 5143.4 5192.1 4672.4 4826.4 4840.2 4846.6 4900.4 5072.2 5084.7 5088.8 5095.7 5131.6 5140.0 5153.8 5154.2 5162.6 5196.2 4881.0 4950.5 4953.2 4961.5 5009.7 4950.6 4976.6 4977.2 4980.8 5032.0 4902.2 4910.1 4914.7 4950.9 4964.3 4870.8 4983.1 5032.0 5035.9 5058.3 4919.9 4945.7 4948.3 4948.4 4997.9 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#1] ext.html Cycles:180 Average:38942.36 Median:36435.41 stddev:60082.77 (164.9%) stddev-sans-first:60182.24 17:26:02 INFO - PROCESS | 9670 | Values: 569.5 584.6 587.7 599.9 614.8 27314.9 27978.6 30892.8 30970.4 30983.2 41276.8 42390.6 42497.2 46534.3 46621.5 7467.9 7667.3 7672.0 7674.0 7678.3 7552.4 7635.4 7642.5 7652.3 7659.7 7691.3 7738.2 7738.9 7739.8 7740.2 7645.4 7684.0 7685.8 7689.5 7690.5 7609.5 7666.8 7683.0 7688.4 7695.8 36997.0 37720.2 37813.0 37847.4 37866.6 3211.8 3228.7 3265.3 3445.7 3539.6 27536.9 28149.9 28157.4 28185.6 29251.4 3430.1 3455.9 3462.7 3488.7 3544.7 220649.9 220955.0 221172.0 221472.0 221722.0 49229.3 49245.0 49460.3 49668.3 49767.3 51834.7 54365.5 55804.4 55904.0 60953.0 13935.7 13951.7 13952.4 13991.4 14030.0 10239.3 10481.2 10542.4 10556.0 10563.5 15290.6 15762.7 15805.5 16044.9 16360.8 6069.0 6121.2 6132.5 6161.6 6174.7 787.9 849.1 900.1 906.6 1027.0 28054.4 28383.6 28451.4 28494.7 28844.9 980.7 1003.2 1038.3 1044.7 1063.1 14731.6 15172.2 15200.9 15436.4 15461.5 115919.0 116627.0 116758.0 116970.0 117080.0 51895.0 52421.7 52574.0 52580.3 52768.0 1090.5 1179.8 1224.9 1229.5 1233.8 28577.4 29262.4 29520.9 29563.6 30024.7 42357.6 42832.4 42868.0 42880.0 42999.4 301567.0 307776.0 308140.0 308723.0 309130.0 32615.5 35789.5 36339.8 37370.8 39531.0 42076.2 42760.6 42805.6 43579.0 43595.9 36487.8 36713.1 36930.6 37063.4 37243.4 36770.4 36968.6 36997.8 37093.4 37141.4 35542.3 36232.8 36383.0 36537.6 36633.6 32130.2 32687.8 33047.5 33162.2 33329.2 24656.3 25579.0 27290.7 27400.9 27457.9 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#2] jquery.html Cycles:180 Average:24659.19 Median:5337.15 stddev:67856.60 (1271.4%) stddev-sans-first:68022.42 17:26:02 INFO - PROCESS | 9670 | Values: 357.7 365.7 369.9 378.2 384.5 15953.4 17257.5 17270.4 17641.9 17755.5 16202.9 16471.8 17279.7 17372.6 17383.8 4807.6 5022.9 5024.7 5044.8 5044.9 3679.2 3849.2 4920.4 5520.2 5831.9 5807.8 5853.7 5882.2 5892.1 5897.2 5709.9 5720.5 5759.2 5803.8 5907.6 3296.7 4775.6 5053.8 5095.5 5154.1 19729.0 20433.8 20530.3 20806.9 20818.7 1916.5 1982.2 1992.5 2090.1 2221.5 12909.7 13026.7 13027.5 13227.0 13255.5 1716.4 1807.9 1811.0 1815.4 1867.2 67087.0 67839.0 67909.0 68049.0 68315.3 9002.8 9035.2 9049.0 9495.6 9509.1 12005.4 12068.2 12080.3 12117.9 12121.5 6820.1 6982.6 7044.8 7112.8 7116.8 6830.0 6834.9 6868.6 6963.7 7018.8 5973.3 6031.6 6105.8 6160.5 6218.9 1505.3 1642.2 1654.2 1755.6 1767.9 888.2 904.6 920.3 947.7 955.6 16910.6 16994.7 17442.8 17451.3 17783.5 836.0 910.9 930.3 931.8 950.7 9325.4 9660.8 9669.2 9672.3 9764.3 399180.0 409686.0 413635.0 419598.0 420944.0 49012.8 58257.0 79657.0 80426.6 82719.6 939.7 976.1 977.5 980.8 994.6 15622.4 15833.2 15920.7 16075.8 16092.5 35287.6 35337.8 36280.0 36341.0 36524.3 48853.5 49688.5 49907.5 50602.7 50708.5 7669.6 7751.4 7801.5 7874.0 7963.8 8403.8 10315.6 11180.4 11209.5 11442.4 9498.0 9498.9 9809.8 9824.5 9937.7 9503.5 9655.7 9882.4 9922.5 9990.6 9792.4 9827.6 9855.9 10024.1 10107.6 7586.3 7647.8 7690.2 7728.1 7742.8 7986.6 9459.1 9470.5 9626.0 10182.7 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#3] mootools.html Cycles:180 Average:5253.63 Median:5579.84 stddev:2973.71 (53.3%) stddev-sans-first:2966.41 17:26:02 INFO - PROCESS | 9670 | Values: 1196.2 1432.9 1455.8 1609.4 1794.5 6999.9 7845.4 7983.7 7990.4 8298.4 7989.0 8151.0 8153.4 8175.6 8202.5 2191.2 2215.3 2218.6 2220.6 2221.2 2172.5 2216.7 2217.9 2219.4 2220.1 2175.0 2200.7 2205.5 2206.4 2213.7 2125.7 2134.4 2134.9 2136.3 2137.2 2086.1 2119.9 2120.7 2121.7 2124.8 7762.3 8104.0 8169.7 8190.5 8195.8 4659.3 4854.2 4856.9 4857.2 4862.4 2983.8 2995.0 2999.8 3035.4 3035.4 914.6 919.2 939.2 957.0 959.1 11026.6 11114.7 11127.1 11145.4 11159.1 4025.3 4095.6 4171.2 4178.3 4178.5 8651.0 8728.2 8728.5 8738.3 8741.9 4610.8 4699.5 4705.3 4709.6 4713.0 3704.5 4095.9 4235.8 4328.3 4345.2 3493.5 3525.3 3565.7 3581.4 3630.6 968.2 972.8 976.9 981.3 1011.1 651.2 687.8 872.1 872.2 906.7 5291.3 5340.8 5389.7 5437.4 5488.0 918.9 919.9 943.7 964.6 984.6 3670.8 3832.3 3844.2 3873.4 3913.7 9690.2 9810.9 9928.0 9998.2 10002.6 9667.7 9777.9 9848.3 9855.7 9866.1 7544.7 7557.9 7672.8 7673.2 7709.2 5386.2 5471.9 5486.5 5573.4 5586.3 8978.5 9272.8 9300.3 9489.7 9536.9 9201.1 9294.1 9400.5 9477.8 9602.5 5668.7 6047.9 6730.1 6865.1 7005.8 7735.9 7774.0 7810.5 7833.2 7859.8 6760.5 6828.1 6930.5 7014.8 7016.0 6893.4 6930.4 6963.6 7039.0 7043.7 6285.7 6346.0 6346.0 6375.0 6401.6 4633.0 4702.2 4745.0 4755.4 4769.5 4841.7 4853.6 4899.1 4933.8 5000.0 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#4] prototype.html Cycles:180 Average:4112.76 Median:4737.94 stddev:1192.37 (25.2%) stddev-sans-first:1160.69 17:26:02 INFO - PROCESS | 9670 | Values: 290.5 299.6 300.5 301.2 304.0 4750.5 4772.3 4785.5 4795.1 4802.5 4674.9 4684.3 4733.9 4735.5 4760.9 3545.1 3688.6 3689.9 3726.0 3764.7 3696.2 3719.1 3719.6 3727.2 3730.1 3563.4 3715.6 3725.8 3731.8 3735.1 3574.9 3673.7 3675.2 3678.6 3679.9 3285.3 3287.8 3290.3 3292.2 3324.5 4539.0 4553.5 4554.4 4568.2 4574.2 3984.0 4182.0 4194.2 4235.3 4276.3 4936.6 4954.8 4955.3 4966.7 4972.3 3501.2 3501.6 3512.8 3514.1 3521.9 5030.6 5162.0 5171.6 5202.0 5211.8 3595.6 3601.5 3605.2 3616.4 3618.5 3661.5 3679.5 3681.9 3695.3 3695.8 4188.8 4191.3 4202.8 4208.6 4210.0 4871.3 4973.3 4981.4 5003.6 5005.3 1261.5 1266.0 1270.7 1277.3 1279.3 794.2 801.6 802.6 827.5 841.2 4345.4 4376.6 4388.7 4391.2 4419.7 4997.4 4998.2 5017.1 5019.1 5037.8 4266.4 4359.0 4375.3 4385.3 4408.3 2622.9 2653.0 2654.0 2658.3 2661.9 4733.7 4740.4 4767.5 4775.3 4794.0 4866.3 5099.4 5108.2 5132.6 5139.5 4757.9 4771.8 4786.0 4803.5 4806.0 5018.5 5028.4 5030.8 5034.9 5041.6 4763.8 4909.9 4919.4 4922.5 4940.4 4920.2 4932.0 4935.7 4937.5 4942.4 3622.4 3664.3 3675.5 3680.3 3688.3 5070.6 5158.8 5166.9 5184.5 5213.5 4897.1 4965.8 4975.5 4987.6 5020.4 4953.2 4956.4 4961.5 4982.0 5007.9 4699.9 4878.2 4912.9 4913.2 4924.5 4798.9 4862.2 4972.6 4997.4 5000.2 4852.7 4873.2 4874.2 4889.9 4901.2 17:26:02 INFO - PROCESS | 9670 | 17:26:02 INFO - PROCESS | 9670 | [#5] yui.html Cycles:180 Average:12990.76 Median:46324.54 stddev:14855.89 (32.1%) stddev-sans-first:14868.65 17:26:02 INFO - PROCESS | 9670 | Values: 647.7 681.7 738.2 760.4 777.2 12503.1 12620.6 12624.3 12713.6 12743.6 12371.6 12555.0 12612.6 12632.4 12639.6 648.3 786.5 802.1 808.4 813.7 813.8 822.9 823.1 823.4 824.2 855.1 858.4 859.0 859.4 859.5 678.8 832.3 847.1 853.2 858.5 626.5 626.7 626.9 627.1 627.2 12378.6 12399.6 12411.5 12437.7 12443.8 11970.4 12323.2 12361.5 12494.8 12698.1 10829.5 10866.7 10933.9 11095.9 11190.5 4101.2 4110.6 4142.8 4146.9 4209.0 46109.0 46269.3 46379.8 46388.8 46787.5 9900.3 10023.0 10033.1 10063.8 10194.4 17924.3 17954.1 17977.3 17997.4 18018.9 6826.4 6915.8 6932.9 7001.2 7118.0 3700.4 3793.3 3794.9 3800.1 3802.6 2715.1 2793.0 2798.7 2800.7 2804.8 510.6 521.3 529.6 534.8 543.2 419.6 438.9 549.0 556.3 562.3 8321.3 8706.7 8742.7 8750.6 8895.0 573.9 612.4 630.0 632.9 649.0 3912.8 3984.8 3988.8 4052.4 4077.9 49893.0 52244.0 52701.0 52875.7 52979.5 47817.8 47944.5 49273.0 49460.3 50814.5 43529.3 44714.3 44779.0 45000.0 45470.0 7618.7 7662.5 7763.3 7815.9 7854.6 31162.0 31253.0 31259.0 31351.1 31482.1 37018.4 40023.2 40062.4 40715.4 40857.6 9023.4 10442.1 10461.7 10595.5 10772.1 10156.8 10282.7 10299.3 10327.3 10571.5 9203.4 9591.9 9681.9 9715.5 9797.2 9132.3 9572.0 9729.2 10017.5 10946.2 11125.5 11361.7 11484.5 11961.5 12169.7 9555.8 9764.0 9976.9 10126.7 10150.0 8894.0 9019.2 9551.2 9742.6 9794.6 17:26:02 INFO - PROCESS | 9670 | -------- Summary: end -------- 17:26:02 INFO - PROCESS | 9670 | 17:26:03 INFO - TEST-INFO | 9670: exit 0 17:26:03 INFO - TEST-OK | dromaeo_css | took 1118491ms 17:26:03 INFO - TEST-START | kraken 17:26:03 INFO - operating with platform_type : linux_ 17:26:03 INFO - Initialising browser for kraken test... 17:26:03 INFO - TEST-INFO | started process 9847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqx1h1j/profile http://localhost:44871/getInfo.html) 17:26:07 INFO - PROCESS | 9847 | __metrics Screen width/height:1600/1200 17:26:07 INFO - PROCESS | 9847 | colorDepth:24 17:26:07 INFO - PROCESS | 9847 | Browser inner width/height: 1024/697 17:26:07 INFO - PROCESS | 9847 | __metrics 17:26:08 ERROR - PROCESS | 9847 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:26:09 INFO - TEST-INFO | 9847: exit 0 17:26:09 INFO - Browser initialized. 17:26:09 INFO - Running cycle 1/1 for kraken test... 17:26:09 INFO - TEST-INFO | started process 9928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqx1h1j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:21 INFO - PROCESS | 9928 | RSS: Main: 154349568 17:26:21 INFO - PROCESS | 9928 | 17:26:24 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:25 INFO - PROCESS | 9928 | RSS: Main: 210518016 17:26:25 INFO - PROCESS | 9928 | 17:26:28 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-dft) 17:26:28 INFO - PROCESS | 9928 | RSS: Main: 198983680 17:26:28 INFO - PROCESS | 9928 | 17:26:32 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-fft) 17:26:32 INFO - PROCESS | 9928 | RSS: Main: 267513856 17:26:32 INFO - PROCESS | 9928 | 17:26:34 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-oscillator) 17:26:35 INFO - PROCESS | 9928 | RSS: Main: 175882240 17:26:35 INFO - PROCESS | 9928 | 17:26:37 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:38 INFO - PROCESS | 9928 | RSS: Main: 180572160 17:26:38 INFO - PROCESS | 9928 | 17:26:41 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:42 INFO - PROCESS | 9928 | RSS: Main: 216707072 17:26:42 INFO - PROCESS | 9928 | 17:26:45 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:46 INFO - PROCESS | 9928 | RSS: Main: 214388736 17:26:46 INFO - PROCESS | 9928 | 17:26:49 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44871/tests/kraken/driver.html?testName=json-parse-financial) 17:26:49 INFO - PROCESS | 9928 | RSS: Main: 216010752 17:26:49 INFO - PROCESS | 9928 | 17:26:51 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:52 INFO - PROCESS | 9928 | RSS: Main: 204288000 17:26:52 INFO - PROCESS | 9928 | 17:26:53 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:54 INFO - PROCESS | 9928 | RSS: Main: 209117184 17:26:54 INFO - PROCESS | 9928 | 17:26:56 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:57 INFO - PROCESS | 9928 | RSS: Main: 220225536 17:26:57 INFO - PROCESS | 9928 | 17:27:00 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:27:00 INFO - PROCESS | 9928 | RSS: Main: 224202752 17:27:00 INFO - PROCESS | 9928 | 17:27:03 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:27:04 INFO - PROCESS | 9928 | RSS: Main: 220446720 17:27:04 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44871/tests/kraken/driver.html?testName=ai-astar) 17:27:06 INFO - PROCESS | 9928 | RSS: Main: 265633792 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | __start_tp_report 17:27:06 INFO - PROCESS | 9928 | _x_x_mozilla_page_load 17:27:06 INFO - PROCESS | 9928 | _x_x_mozilla_page_load_details 17:27:06 INFO - PROCESS | 9928 | |i|pagename|runs| 17:27:06 INFO - PROCESS | 9928 | |0;ai-astar;112;106;112;113;111;112;112;111;111;112 17:27:06 INFO - PROCESS | 9928 | |1;audio-beat-detection;155;131;137;164;133;163;164;133;188;136 17:27:06 INFO - PROCESS | 9928 | |2;audio-dft;161;160;161;161;162;162;162;161;161;162 17:27:06 INFO - PROCESS | 9928 | |3;audio-fft;84;75;76;109;75;75;75;78;114;74 17:27:06 INFO - PROCESS | 9928 | |4;audio-oscillator;85;85;128;84;84;85;117;84;84;118 17:27:06 INFO - PROCESS | 9928 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;116 17:27:06 INFO - PROCESS | 9928 | |6;imaging-darkroom;146;146;145;147;146;146;145;146;147;146 17:27:06 INFO - PROCESS | 9928 | |7;imaging-desaturate;95;95;94;95;95;95;96;94;95;94 17:27:06 INFO - PROCESS | 9928 | |8;json-parse-financial;65;63;64;64;64;64;64;79;62;62 17:27:06 INFO - PROCESS | 9928 | |9;json-stringify-tinderbox;64;65;65;65;66;65;66;66;67;65 17:27:06 INFO - PROCESS | 9928 | |10;stanford-crypto-aes;81;82;87;85;82;87;84;83;89;83 17:27:06 INFO - PROCESS | 9928 | |11;stanford-crypto-ccm;131;130;135;130;138;137;144;130;174;130 17:27:06 INFO - PROCESS | 9928 | |12;stanford-crypto-pbkdf2;170;178;170;175;170;174;168;172;170;169 17:27:06 INFO - PROCESS | 9928 | |13;stanford-crypto-sha256-iterative;65;66;67;65;66;64;66;66;66;67 17:27:06 INFO - PROCESS | 9928 | __end_tp_report 17:27:06 INFO - PROCESS | 9928 | __start_cc_report 17:27:06 INFO - PROCESS | 9928 | _x_x_mozilla_cycle_collect,1879 17:27:06 INFO - PROCESS | 9928 | __end_cc_report 17:27:06 INFO - PROCESS | 9928 | __startTimestamp1464136026336__endTimestamp 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | ------- Summary: start ------- 17:27:06 INFO - PROCESS | 9928 | Number of tests: 14 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.93 (1.7%) stddev-sans-first:2.03 17:27:06 INFO - PROCESS | 9928 | Values: 112.0 106.0 112.0 113.0 111.0 112.0 112.0 111.0 111.0 112.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.00 stddev:19.24 (12.1%) stddev-sans-first:20.34 17:27:06 INFO - PROCESS | 9928 | Values: 155.0 131.0 137.0 164.0 133.0 163.0 164.0 133.0 188.0 136.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 17:27:06 INFO - PROCESS | 9928 | Values: 161.0 160.0 161.0 161.0 162.0 162.0 162.0 161.0 161.0 162.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:15.08 (20.1%) stddev-sans-first:15.99 17:27:06 INFO - PROCESS | 9928 | Values: 84.0 75.0 76.0 109.0 75.0 75.0 75.0 78.0 114.0 74.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:17.90 (21.3%) stddev-sans-first:18.59 17:27:06 INFO - PROCESS | 9928 | Values: 85.0 85.0 128.0 84.0 84.0 85.0 117.0 84.0 84.0 118.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:27:06 INFO - PROCESS | 9928 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:27:06 INFO - PROCESS | 9928 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 145.0 146.0 147.0 146.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:27:06 INFO - PROCESS | 9928 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 94.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.00 stddev:4.98 (7.8%) stddev-sans-first:5.28 17:27:06 INFO - PROCESS | 9928 | Values: 65.0 63.0 64.0 64.0 64.0 64.0 64.0 79.0 62.0 62.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 17:27:06 INFO - PROCESS | 9928 | Values: 64.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 67.0 65.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:2.63 (3.1%) stddev-sans-first:2.50 17:27:06 INFO - PROCESS | 9928 | Values: 81.0 82.0 87.0 85.0 82.0 87.0 84.0 83.0 89.0 83.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.00 stddev:13.53 (9.9%) stddev-sans-first:14.12 17:27:06 INFO - PROCESS | 9928 | Values: 131.0 130.0 135.0 130.0 138.0 137.0 144.0 130.0 174.0 130.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.00 stddev:3.13 (1.8%) stddev-sans-first:3.27 17:27:06 INFO - PROCESS | 9928 | Values: 170.0 178.0 170.0 175.0 170.0 174.0 168.0 172.0 170.0 169.0 17:27:06 INFO - PROCESS | 9928 | 17:27:06 INFO - PROCESS | 9928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 17:27:06 INFO - PROCESS | 9928 | Values: 65.0 66.0 67.0 65.0 66.0 64.0 66.0 66.0 66.0 67.0 17:27:06 INFO - PROCESS | 9928 | -------- Summary: end -------- 17:27:06 INFO - PROCESS | 9928 | 17:27:07 INFO - TEST-INFO | 9928: exit 0 17:27:07 INFO - TEST-OK | kraken | took 64250ms 17:27:07 INFO - SUITE-END | took 1182s 17:27:07 INFO - Completed test suite (00:19:43) 17:27:07 INFO - javascript benchmark 17:27:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.38282195095, 2701.5542435498137, 2735.206790030891, 2739.055026016025, 2767.972320276797, 4659.790309436075, 4731.053789242148, 4733.526647335265, 4821.083994041134, 4859.392575928009, 4728.030753695492, 4729.810807567702, 4748.453927798304, 4789.353437285965, 4793.328933949241, 4309.913801723964, 4340.08858139791, 4379.781010949456, 4401.449818772653, 4525.366448697185, 4459.665525085616, 4472.597466228039, 4485.080558485519, 4524.932126018096, 4545.681802273843, 4224.049588842486, 4296.291111966521, 4349.652027837766, 4358.65130789536, 4383.167198232358, 4330.7401555906745, 4334.219840428722, 4340.6093451589195, 4447.777611119431, 4470.508244093147, 4392.582704643054, 4407.449068866392, 4413.157177205476, 4416.1167766446515, 4458.687891847572, 4548.431446069241, 4636.374089497942, 4675.251959686468, 4738.739369334685, 4773.689710168828, 5108.412532558729, 5138.588912886998, 5144.0740666679985, 5156.896862062776, 5160.948390516084, 5166.664166829144, 5175.0943584872875, 5183.300254465675, 5187.299714538527, 5197.922031169498, 4667.906641867144, 4733.171694953369, 4759.190937540627, 4766.213574760126, 4843.927341089887, 5178.093833579109, 5198.0, 5216.895662086737, 5263.6315457918345, 5266.894662106736, 5066.240063990431, 5066.898662026812, 5067.366579177603, 5069.036882992294, 5072.568831649277, 4991.101601711727, 5043.672161309503, 5046.84859454217, 5057.115004874132, 5072.5688316493515, 4997.225430058346, 5018.121828679967, 5024.472430394829, 5032.547070763576, 5075.441701412841, 4867.5132486751045, 5022.121128802445, 5024.296598476143, 5025.773840177201, 5029.1450453423, 4270.935935960963, 4305.203537345601, 4317.978410107929, 4347.456567929009, 4348.065165989265, 3774.4338349247832, 3787.1289603391374, 3790.677792387623, 3794.5256842894637, 3816.9427458588143, 4335.089631177425, 4383.342498625232, 4416.315471101984, 4418.536053714378, 4455.576720211575, 5073.644844860824, 5073.822416215415, 5099.286099946011, 5121.846344609593, 5122.487751224848, 4433.977830110829, 4443.666724995638, 4444.977655139336, 4446.6220371268155, 4473.194824931544, 4522.050369422458, 4607.9308810367875, 4636.420447444069, 4639.164950308977, 4682.063587282557, 4828.855134345975, 4832.251001094765, 4857.077155340474, 4860.3681521401995, 4903.264510323337, 5124.390280433478, 5136.5377116059735, 5139.768710407966, 5143.4085080216255, 5192.091384007859, 4672.415948006499, 4826.396700412449, 4840.1529732296, 4846.636502262274, 4900.387451568554, 5072.239164125411, 5084.745762711924, 5088.821891233789, 5095.668781529189, 5131.615128865425, 5139.997700448526, 5153.793848246029, 5154.226865970135, 5162.561182299396, 5196.194589838581, 4881.0, 4950.45544990058, 4953.23224900141, 4961.5286547777905, 5009.699418034929, 4950.554450099508, 4976.576990955665, 4977.153883839684, 4980.800767969241, 5032.018756342478, 4902.1911384621135, 4910.06708725341, 4914.680545764514, 4950.935548857013, 4964.3298154748645, 4870.829520966749, 4983.103041452428, 5032.018756342478, 5035.949640503548, 5058.266551350107, 4919.926201106915, 4945.653804233669, 4948.257761335828, 4948.406191257072, 4997.85006449807], "value": 4694.920694907288, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5159114752461, 584.6024703201824, 587.6738410182347, 599.9400059994, 614.846288427893, 27314.86342568287, 27978.580321295198, 30892.84553577229, 30970.380592388137, 30983.225419364528, 41276.79361603195, 42390.57609423905, 42497.15005699884, 46534.30198547024, 46621.53378466214, 7467.925320746805, 7667.309942105209, 7672.0, 7674.0, 7678.347340476066, 7552.395808335347, 7635.350995165418, 7642.503237289586, 7652.31129198372, 7659.731909383173, 7691.346235569955, 7738.226177382245, 7738.883916741253, 7739.806504837367, 7740.187280335568, 7645.350145237661, 7684.0, 7685.846283074363, 7689.538627682357, 7690.461667683265, 7609.543427394374, 7666.808329791744, 7682.961585192094, 7688.38492920565, 7695.769126926201, 36997.0, 37720.245595087945, 37813.0, 37847.432288515694, 37866.62133378686, 3211.8394080295893, 3228.741700663965, 3265.330607225513, 3445.6554344565593, 3539.6460353964653, 27536.862315688293, 28149.85925070382, 28157.43685126286, 28185.57721634177, 29251.414971700447, 3430.142464383904, 3455.8617655293756, 3462.722982161421, 3488.7034602058857, 3544.7164226861787, 220649.8967505168, 220955.0, 221172.0, 221472.0, 221722.0, 49229.261561076615, 49245.0, 49460.258096127865, 49668.25497617466, 49767.25349119766, 51834.74082629638, 54365.45634543683, 55804.44195558074, 55904.0, 60953.0, 13935.721285574231, 13951.65120871966, 13952.372143253579, 13991.370388332549, 14030.0, 10239.334443261165, 10481.161507079416, 10542.367457952547, 10556.0, 10563.471826408802, 15290.617734556503, 15762.684746305009, 15805.52583422499, 16044.919775401047, 16360.754588681179, 6068.969655151696, 6121.163650904711, 6132.540059495466, 6161.568690191643, 6174.722137503823, 787.9251471110235, 849.1041950741903, 900.0729248873671, 906.5603182456504, 1027.0, 28054.43891122166, 28383.57424638632, 28451.430971380458, 28494.71505284962, 28844.855775720986, 980.67637679567, 1003.19744204636, 1038.2628333882876, 1044.6970378590277, 1063.1282348474176, 14731.558053258419, 15172.241387930559, 15200.923995379952, 15436.382544698086, 15461.5361539154, 115919.0, 116627.0, 116758.0, 116970.0, 117080.0, 51895.0, 52421.73789131106, 52574.0, 52580.319377643966, 52768.0, 1090.536521978156, 1179.7699448607439, 1224.895883849865, 1229.5327775445453, 1233.771752225823, 28577.42845143127, 29262.414751704422, 29520.852395737882, 29563.556546651387, 30024.748143889734, 42357.5764242366, 42832.35751463793, 42868.0, 42880.0, 42999.355009674255, 301567.0, 307776.0, 308140.0, 308723.0, 309130.0, 32615.510767338033, 35789.46315805213, 36339.81830090833, 37370.813145934095, 39531.0, 42076.158476830904, 42760.57239427566, 42805.57194428016, 43579.0, 43595.948283619844, 36487.817560913085, 36713.08941830829, 36930.63069369272, 37063.44404833876, 37243.44134837925, 36770.448443272835, 36968.63031369759, 36997.81501092585, 37093.443598345504, 37141.44287835739, 35542.289154216254, 36232.81883590565, 36383.0, 36537.634623654485, 36633.63366366302, 32130.196745080626, 32687.824283971375, 33047.50428743619, 33162.170945725586, 33329.166770830925, 24656.260312189945, 25579.0, 27290.72709272882, 27400.90396384202, 27457.86271068632], "value": 16913.893057277408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.69417148338164, 365.7001258967646, 369.8834867016889, 378.2246394890474, 384.5251114873129, 15953.44162954297, 17257.48227553174, 17270.395536156237, 17641.911790441063, 17755.46733597991, 16202.918985405056, 16471.752923706154, 17279.740803887922, 17372.56568585786, 17383.82616173838, 4807.6153907687385, 5022.899542009158, 5024.673396229252, 5044.848654540369, 5044.873878153039, 3679.22736225393, 3849.1531862990096, 4920.409550853902, 5520.227168196456, 5831.9416805831825, 5807.825765227029, 5853.707314634273, 5882.176495290662, 5892.057270836667, 5897.174395584621, 5709.885802283952, 5720.456556627114, 5759.222504961839, 5803.767849286023, 5907.6160049597065, 3296.653851345622, 4775.594074503671, 5053.797848086072, 5095.490450954912, 5154.07226699194, 19729.0, 20433.79566204334, 20530.281440149673, 20806.895965520074, 20818.687719684218, 1916.5112896211376, 1982.2071171531359, 1992.471994921347, 2090.1221486975505, 2221.5112675211426, 12909.741805163843, 13026.739465210738, 13027.478900843955, 13227.032798171973, 13255.46978120874, 1716.399260258912, 1807.9096045197687, 1810.9547261318442, 1815.3918437323512, 1867.2344338821017, 67087.0, 67839.0, 67909.0, 68049.0, 68315.3168468314, 9002.819943601091, 9035.232005279493, 9048.954755226181, 9495.57269922855, 9509.144177023963, 12005.399730013465, 12068.215565988183, 12080.335581542924, 12117.87882121185, 12121.515139394502, 6820.139610871845, 6982.581045137308, 7044.823879403056, 7112.751053713198, 7116.786496405012, 6830.0, 6834.897476537856, 6868.553544019623, 6963.651817409109, 7018.75434359795, 5973.313068997034, 6031.638101713911, 6105.755769769248, 6160.476359509402, 6218.875622487525, 1505.3150816378522, 1642.2199455258656, 1654.2225154177518, 1755.6400937807718, 1767.8585713142918, 888.1651247827022, 904.6426661468684, 920.2775820980498, 947.6920000999703, 955.6464108279841, 16910.57723556921, 16994.74507882358, 17442.825571744375, 17451.301947922195, 17783.46649600514, 836.0228060636672, 910.8679241509944, 930.2883294279882, 931.753085432361, 950.7147855643418, 9325.393849399767, 9660.806783864284, 9669.226461883032, 9672.322937394314, 9764.316497845224, 399180.0, 409686.0, 413635.0, 419598.0, 420944.0, 49012.75493622581, 58257.0, 79657.0, 80426.59786701146, 82719.58640206761, 939.6805086270564, 976.1214906584131, 977.4819345746765, 980.8234517786724, 994.5524513968887, 15622.375104995674, 15833.208339583205, 15920.681586368439, 16075.839241607435, 16092.517224483285, 35287.64712352843, 35337.82331088328, 36280.0, 36341.0, 36524.26951460903, 48853.51146488632, 49688.503114968385, 49907.50092499029, 50602.746986266306, 50708.492915070376, 7669.578173200527, 7751.37988960893, 7801.4929029612895, 7874.0, 7963.800904977422, 8403.789905252417, 10315.638952636622, 11180.440977950908, 11209.495572699085, 11442.37066961325, 9497.952510237405, 9498.862755879873, 9809.773778277715, 9824.45965471906, 9937.65218217359, 9503.524823758922, 9655.710328690151, 9882.357646752938, 9922.454265015493, 9990.550425230736, 9792.363496372713, 9827.606895724091, 9855.901440985785, 10024.097831195228, 10107.64623238183, 7586.279303466162, 7647.808804779925, 7690.154083050748, 7728.149903510722, 7742.845143097219, 7986.600669966595, 9459.054094590761, 9470.526473676151, 9626.0, 10182.745431364276], "value": 8239.585275756159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.1985469735278, 1432.878205352545, 1455.8253009638843, 1609.4366971559948, 1794.4796009157344, 6999.860002799941, 7845.372370210383, 7983.680652773889, 7990.400719945998, 8298.377621678368, 7989.0, 8151.021877374708, 8153.429259951806, 8175.591220438984, 8202.548859812709, 2191.1783081344533, 2215.268961242794, 2218.5784700906856, 2220.578090162864, 2221.1892659179366, 2172.511184983374, 2216.7229096362953, 2217.855839370444, 2219.4451387153213, 2220.0897631970897, 2174.9891250543806, 2200.713907192063, 2205.503761653631, 2206.4263291544153, 2213.656883183109, 2125.7449106107288, 2134.4130364149905, 2134.8505604607685, 2136.3484137338105, 2137.187868609934, 2086.1029757204396, 2119.9258025969016, 2120.7243058402464, 2121.734783152106, 2124.808767210943, 7762.340201082915, 8104.0, 8169.67321307147, 8190.467619604707, 8195.83608327836, 4659.301104834268, 4854.150523658381, 4856.927146092811, 4857.17428037231, 4862.3922009748785, 2983.7911346205774, 2995.026616349695, 2999.7750168737434, 3035.3777475617444, 3035.4080954213937, 914.6021480655936, 919.1773362840287, 939.2439086535336, 956.9665061722807, 959.1415682963708, 11026.614068507644, 11114.666560003212, 11127.054200392977, 11145.387003714792, 11159.051480624157, 4025.275450418953, 4095.610916962884, 4171.207470580641, 4178.331466965332, 4178.477690288714, 8650.956745216234, 8728.170823771732, 8728.519931403835, 8738.25724813398, 8741.912580874237, 4610.76946152691, 4699.530046995274, 4705.317728929286, 4709.552592503706, 4713.033828065239, 3704.5184126063978, 4095.89760255996, 4235.788210589458, 4328.28583283761, 4345.152695224401, 3493.4934434507363, 3525.347810655037, 3565.6612621800887, 3581.4448760442174, 3630.5643322801434, 968.1770495079127, 972.7908499672462, 976.9169620582188, 981.3130808434124, 1011.1304278320638, 651.1762620285343, 687.8306878306898, 872.1322284327135, 872.1845074855031, 906.7325139083986, 5291.3385826771655, 5340.839774806762, 5389.676619402849, 5437.401885792559, 5487.972560137254, 918.8529835226332, 919.935604507678, 943.7404713703786, 964.5852283518154, 984.640606178754, 3670.7797532148156, 3832.3485007548784, 3844.1735026969336, 3873.4383514390256, 3913.72603917723, 9690.176335011462, 9810.852837207447, 9927.950360248296, 9998.20014398861, 10002.649907253211, 9667.709849103887, 9777.853332200022, 9848.310618256653, 9855.704328870146, 9866.112049915542, 7544.735934242385, 7557.886631700529, 7672.846543069219, 7673.155952845294, 7709.190534993857, 5386.245925570345, 5471.917921231265, 5486.478784515464, 5573.414791447002, 5586.273784408001, 8978.506182160045, 9272.768180795534, 9300.302477314364, 9489.715308540755, 9536.904630953879, 9201.079892010745, 9294.117058879396, 9400.482973436254, 9477.763055923657, 9602.519874006412, 5668.659880407189, 6047.909281360695, 6730.091437655854, 6865.141857267841, 7005.824854378681, 7735.883961740691, 7774.0, 7810.531368117931, 7833.216678332121, 7859.764207073797, 6760.5242531575, 6828.112345395067, 6930.48021398387, 7014.754483593049, 7015.964920175366, 6893.379595836399, 6930.44556435494, 6963.582185068912, 7039.0, 7043.718251269892, 6285.748570057147, 6346.0, 6346.0, 6374.968125159345, 6401.615903045832, 4632.953670463252, 4702.224133018014, 4744.952550474451, 4755.429348478205, 4769.499202583817, 4841.661083724105, 4853.587445067209, 4899.118158731462, 4933.827316043921, 4999.975000124976], "value": 4200.54963364054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.5423957267304, 299.5760998187564, 300.54317437494996, 301.2228450597456, 304.02256744566216, 4750.524947505252, 4772.284157376395, 4785.5214478552125, 4795.064962332347, 4802.471728109914, 4674.906501869969, 4684.297355396684, 4733.905321893569, 4735.502772208912, 4760.928586071212, 3545.1314427965185, 3688.6126956669564, 3689.8893033209047, 3726.049857286388, 3764.6800021998024, 3696.223793003459, 3719.1445967427508, 3719.553653561563, 3727.2172843702856, 3730.123420996077, 3563.4476656118345, 3715.5541335039834, 3725.8323375448035, 3731.7574357666663, 3735.140917588956, 3574.9275217434797, 3673.742838001341, 3675.2358867743364, 3678.6321367863, 3679.9264014719824, 3285.2936618626873, 3287.7534184936226, 3290.2596915693775, 3292.209869631295, 3324.517944897976, 4538.977305113486, 4553.476350219701, 4554.362389265505, 4568.177728008957, 4574.245249533823, 3984.0, 4181.958180418218, 4194.224068547329, 4235.343521754102, 4276.31578947367, 4936.629752768521, 4954.752262386903, 4955.306257124005, 4966.652334336598, 4972.254161875748, 3501.2297294595405, 3501.57981042274, 3512.8067956262394, 3514.1390359361862, 3521.8767343142868, 5030.597552195815, 5162.0, 5171.586273098181, 5202.037623039712, 5211.843644690665, 3595.5865075516126, 3601.4957905893198, 3605.152789094561, 3616.385214513539, 3618.4753210784816, 3661.5423072115987, 3679.5032670589662, 3681.9447708284397, 3695.316366472211, 3695.7619197569115, 4188.8324467020975, 4191.287481128215, 4202.810873510699, 4208.600182982612, 4209.957900421018, 4871.269309603588, 4973.32860063894, 4981.352424184905, 5003.5997120230295, 5005.3242812220615, 1261.4701825233424, 1265.9810102848464, 1270.720441502868, 1277.2783377391745, 1279.2772083772825, 794.1938931984041, 801.587182600961, 802.5987006496752, 827.462149602751, 841.2302742990217, 4345.391645169679, 4376.562343765661, 4388.71473354231, 4391.209582275221, 4419.734815911055, 4997.350344455271, 4998.175301075355, 5017.147084995559, 5019.0965626187635, 5037.798488060436, 4266.360045993064, 4359.04101097758, 4375.321825117112, 4385.320275357325, 4408.338749187647, 2622.868856557203, 2652.9734702652727, 2654.0, 2658.282263788766, 2661.8953134449375, 4733.692309999908, 4740.3837501124635, 4767.499412561631, 4775.283707443842, 4794.0, 4866.343043689128, 5099.413567439718, 5108.208227724708, 5132.640715149978, 5139.537441630197, 4757.928631070606, 4771.7593425709565, 4785.976070119627, 4803.519648035169, 4806.0, 5018.4730603286125, 5028.421731500925, 5030.798768049383, 5034.924476132787, 5041.596672266137, 4763.83286094909, 4909.877253068559, 4919.434265059564, 4922.523243027006, 4940.357753492023, 4920.21276595743, 4931.9753401232765, 4935.679180853376, 4937.481564435682, 4942.382202224722, 3622.3841946869625, 3664.3221004114325, 3675.5038069860225, 3680.2823449427106, 3688.2992231475932, 5070.569001634903, 5158.767855446439, 5166.914947860992, 5184.481551844785, 5213.504717051874, 4897.142999975062, 4965.776540055778, 4975.527324904128, 4987.576056035133, 5020.447750747342, 4953.182724850503, 4956.430010548833, 4961.5286547777905, 4981.975090124526, 5007.924881126859, 4699.906001880012, 4878.243872199815, 4912.877178070434, 4913.224028423929, 4924.50754924519, 4798.912473074224, 4862.197737373293, 4972.637996951419, 4997.425296090996, 5000.249962505508, 4852.660313778143, 4873.220284754422, 4874.2444921037295, 4889.9022019560125, 4901.166801643801], "value": 3733.0535093025237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7020570537552, 681.6625770243727, 738.162185918982, 760.418280015788, 777.234424092269, 12503.06227032974, 12620.558280460185, 12624.305663188521, 12713.555025574107, 12743.617691469259, 12371.566995155172, 12555.0, 12612.62162135135, 12632.368381580907, 12639.620811375651, 648.2868844271311, 786.4769927997875, 802.0856223904739, 808.4421748993205, 813.6948644258404, 813.8128230506987, 822.9218224268685, 823.0822632764455, 823.3660081737058, 824.2334628795218, 855.1448551448551, 858.3991206155684, 858.9742307730747, 859.3683642522741, 859.5186695450536, 678.7658257901016, 832.2551316571635, 847.0597636623343, 853.1766844994579, 858.4505916213566, 626.4706323156971, 626.7179769103876, 626.8558231606711, 627.1408170805979, 627.2034516164491, 12378.62864114069, 12399.566015189515, 12411.503539858395, 12437.689057773629, 12443.813342799865, 11970.401479926057, 12323.198992065487, 12361.505539778398, 12494.81257781134, 12698.111132220749, 10829.458527073615, 10866.67399978002, 10933.945330273376, 11095.944520277428, 11190.496427660693, 4101.241270364992, 4110.630043296118, 4142.813573389205, 4146.91706165875, 4209.010882442623, 46109.0, 46269.305960410624, 46379.76810115928, 46388.76805615984, 46787.532124678655, 9900.257480688833, 10023.0, 10033.09702126812, 10063.798724025479, 10194.43930583825, 17924.283028678707, 17954.102294885204, 17977.280908763765, 17997.37009204698, 18018.90990545065, 6826.351496607815, 6915.757948471779, 6932.930670693228, 7001.194862590765, 7118.039064726196, 3700.389435743126, 3793.2982398256413, 3794.9430758538642, 3800.0879788850475, 3802.5817160112365, 2715.117586784303, 2792.972070279271, 2798.748112669829, 2800.6779220389917, 2804.831710097401, 510.6323447118069, 521.3457111325338, 529.5551736541324, 534.770048878978, 543.1852221667499, 419.56169193459914, 438.8968592380788, 548.9560835133179, 556.274062348639, 562.2999365789618, 8321.334293256525, 8706.738797836075, 8742.737717868475, 8750.64997400097, 8895.0, 573.87948530809, 612.3784358875745, 630.0043294136443, 632.8734253149388, 648.9849018796568, 3912.8239229234755, 3984.7609143451486, 3988.8404463821703, 4052.371882358239, 4077.85727499542, 49893.0, 52244.0, 52701.0, 52875.73562132165, 52979.470205298225, 47817.76091119592, 47944.520554794704, 49273.0, 49460.258096128586, 50814.49185508172, 43529.30029372626, 44714.3292850601, 44779.0, 45000.0, 45470.0, 7618.733344332922, 7662.501937374052, 7763.262490063435, 7815.882761758692, 7854.567998759894, 31162.0, 31253.0, 31259.0, 31351.05946821599, 31482.055538333887, 37018.444723328634, 40023.1995360097, 40062.399064014644, 40715.38926916039, 40857.59142408538, 9023.413478124163, 10442.112420444044, 10461.738456538647, 10595.523201456108, 10772.138228941509, 10156.796864062826, 10282.691519254435, 10299.330543514647, 10327.277090603586, 10571.524281407508, 9203.40177888435, 9591.856122158313, 9681.9031809681, 9715.514224288898, 9797.167240784329, 9132.269418446642, 9572.0, 9729.173020293354, 10017.499125043865, 10946.159739704299, 11125.499352529318, 11361.659150225507, 11484.483198255932, 11961.461734221806, 12169.69575760613, 9555.761105972406, 9764.0, 9976.850347244943, 10126.72099464027, 10150.021346518508, 8893.955530222567, 9019.188273055457, 9551.235901128031, 9742.561584728846, 9794.559244833858], "value": 5985.6168780803, "unit": "score"}], "name": "dromaeo_css", "value": 6281.318179087118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 113.0, 111.0, 112.0, 112.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 137.0, 164.0, 133.0, 163.0, 164.0, 133.0, 188.0, 136.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 76.0, 109.0, 75.0, 75.0, 75.0, 78.0, 114.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 128.0, 84.0, 84.0, 85.0, 117.0, 84.0, 84.0, 118.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 79.0, 62.0, 62.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 87.0, 85.0, 82.0, 87.0, 84.0, 83.0, 89.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 135.0, 130.0, 138.0, 137.0, 144.0, 130.0, 174.0, 130.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 178.0, 170.0, 175.0, 170.0, 174.0, 168.0, 172.0, 170.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 66.0, 64.0, 66.0, 66.0, 66.0, 67.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1549.4, "alertThreshold": 2.0}]} 17:27:08 INFO - Return code: 0 17:27:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:08 ERROR - # TBPL SUCCESS # 17:27:08 INFO - Running post-action listener: _resource_record_post_action 17:27:08 INFO - ##### 17:27:08 INFO - ##### Finished run-tests step (success) 17:27:08 INFO - ##### 17:27:08 INFO - Running post-run listener: _resource_record_post_run 17:27:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 532303872; Read time: 240; Write time: 428244 17:27:08 INFO - TinderboxPrint: CPU usage
13.1% 17:27:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 240 17:27:08 INFO - TinderboxPrint: I/O write bytes / time
532,303,872 / 428,244 17:27:08 INFO - TinderboxPrint: CPU idle
8,325.2 (86.9%) 17:27:08 INFO - TinderboxPrint: CPU user
1,208.9 (12.6%) 17:27:08 INFO - TinderboxPrint: Swap in / out
0 / 0 17:27:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237125632; Read time: 0; Write time: 234308 17:27:08 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 295178240; Read time: 240; Write time: 193936 17:27:08 INFO - Running post-run listener: _upload_blobber_files 17:27:08 INFO - Blob upload gear active. 17:27:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:27:08 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 17:27:08 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'] 17:27:08 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 17:27:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:09 INFO - (blobuploader) - INFO - Done attempting. 17:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:13 INFO - (blobuploader) - INFO - Done attempting. 17:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:15 INFO - (blobuploader) - INFO - Done attempting. 17:27:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:27:15 INFO - Return code: 0 17:27:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:27:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:27:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74060525e52edbd99c2e99f752760787218ab8d13496129ce6f06376c36e41207c55f90467b880087f1e4a82464f793d06af70a4eabc0d9e6bfc3185a499f56f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01ec1fd236692fbfed1d898e98437231c33b172b7f0f1ddf2fd2e4f365dfdc04244b31fda625abe355547b1d8f1aea869fcedafd0b9201bf64e1ea7c2295a417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa94fc1a3c72b2aad6e821f28470ef13d0dfa5fd63434d6aac2145a7660b3760c8587ebd07dc05b553a7a6c3ae7bdd587c9663efc9e122ecf485c3bdd8da4a3"} 17:27:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:27:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:27:15 INFO - Contents: 17:27:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74060525e52edbd99c2e99f752760787218ab8d13496129ce6f06376c36e41207c55f90467b880087f1e4a82464f793d06af70a4eabc0d9e6bfc3185a499f56f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01ec1fd236692fbfed1d898e98437231c33b172b7f0f1ddf2fd2e4f365dfdc04244b31fda625abe355547b1d8f1aea869fcedafd0b9201bf64e1ea7c2295a417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa94fc1a3c72b2aad6e821f28470ef13d0dfa5fd63434d6aac2145a7660b3760c8587ebd07dc05b553a7a6c3ae7bdd587c9663efc9e122ecf485c3bdd8da4a3"} 17:27:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:27:15 INFO - Copying logs to upload dir... 17:27:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:27:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.748385 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 17:27:15.178840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:27:15.181886) ========= 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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 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/74060525e52edbd99c2e99f752760787218ab8d13496129ce6f06376c36e41207c55f90467b880087f1e4a82464f793d06af70a4eabc0d9e6bfc3185a499f56f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01ec1fd236692fbfed1d898e98437231c33b172b7f0f1ddf2fd2e4f365dfdc04244b31fda625abe355547b1d8f1aea869fcedafd0b9201bf64e1ea7c2295a417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa94fc1a3c72b2aad6e821f28470ef13d0dfa5fd63434d6aac2145a7660b3760c8587ebd07dc05b553a7a6c3ae7bdd587c9663efc9e122ecf485c3bdd8da4a3"} build_url:https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/Fcub5tKSQhSYhGwK90OFlQ/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/74060525e52edbd99c2e99f752760787218ab8d13496129ce6f06376c36e41207c55f90467b880087f1e4a82464f793d06af70a4eabc0d9e6bfc3185a499f56f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01ec1fd236692fbfed1d898e98437231c33b172b7f0f1ddf2fd2e4f365dfdc04244b31fda625abe355547b1d8f1aea869fcedafd0b9201bf64e1ea7c2295a417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa94fc1a3c72b2aad6e821f28470ef13d0dfa5fd63434d6aac2145a7660b3760c8587ebd07dc05b553a7a6c3ae7bdd587c9663efc9e122ecf485c3bdd8da4a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:27:15.211873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:27:15.212667) ========= 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=920470bf432669ad7e3a5387000001ca-1464134791.90382-1367477639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:27:15.292432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:27:15.292776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:27:15.293060) ========= ========= Total master_lag: 0.16 =========