builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1464686534.92 results: success (0) buildid: 20160530234442 builduid: 4587975f5a5b44a8a822f4e4397f23c9 revision: dc4d7f68030e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:14.918431) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:14.918907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:14.919351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:14.968821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:14.969075) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 02:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-05-31 02:22:15 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.083318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.083887) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014091 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.134899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.135349) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc4d7f68030e --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 dc4d7f68030e --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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 02:22:15,841 Setting DEBUG logging. 2016-05-31 02:22:15,841 attempt 1/10 2016-05-31 02:22:15,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc4d7f68030e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 02:22:16,151 unpacking tar archive at: fx-team-dc4d7f68030e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.804204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.804511) ========= script_repo_revision: dc4d7f68030e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.804900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.805170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.813044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-31 02:22:15.813330) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:16 INFO - MultiFileLogger online at 20160531 02:22:16 in /builds/slave/test 02:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:16 INFO - {'append_to_log': False, 02:22:16 INFO - 'base_work_dir': '/builds/slave/test', 02:22:16 INFO - 'blob_upload_branch': 'Fx-Team', 02:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:16 INFO - 'branch': 'Fx-Team', 02:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:16 INFO - 'config_files': ('talos/linux_config.py',), 02:22:16 INFO - 'default_actions': ('clobber', 02:22:16 INFO - 'read-buildbot-config', 02:22:16 INFO - 'download-and-extract', 02:22:16 INFO - 'populate-webroot', 02:22:16 INFO - 'create-virtualenv', 02:22:16 INFO - 'install', 02:22:16 INFO - 'run-tests'), 02:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:16 INFO - 'download_minidump_stackwalk': True, 02:22:16 INFO - 'download_symbols': 'ondemand', 02:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:16 INFO - 'installer_path': 'installer.exe', 02:22:16 INFO - 'log_level': 'info', 02:22:16 INFO - 'log_name': 'talos', 02:22:16 INFO - 'log_to_console': True, 02:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:16 INFO - 'opt_config_files': (), 02:22:16 INFO - 'pip_index': False, 02:22:16 INFO - 'sps_profile': False, 02:22:16 INFO - 'sps_profile_interval': 0, 02:22:16 INFO - 'suite': 'dromaeojs', 02:22:16 INFO - 'system_bits': '32', 02:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:16 INFO - 'title': 'talos-linux64-ix-057', 02:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:16 INFO - 'use_talos_json': True, 02:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:16 INFO - 'work_dir': 'build'} 02:22:16 INFO - ##### 02:22:16 INFO - ##### Running clobber step. 02:22:16 INFO - ##### 02:22:16 INFO - Running pre-action listener: _resource_record_pre_action 02:22:16 INFO - Running main action method: clobber 02:22:16 INFO - rmtree: /builds/slave/test/build 02:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:17 INFO - Running post-action listener: _resource_record_post_action 02:22:17 INFO - ##### 02:22:17 INFO - ##### Finished clobber step (success) 02:22:17 INFO - ##### 02:22:17 INFO - ##### 02:22:17 INFO - ##### Running read-buildbot-config step. 02:22:17 INFO - ##### 02:22:17 INFO - Running pre-action listener: _resource_record_pre_action 02:22:17 INFO - Running main action method: read_buildbot_config 02:22:17 INFO - Using buildbot properties: 02:22:17 INFO - { 02:22:17 INFO - "project": "", 02:22:17 INFO - "product": "firefox", 02:22:17 INFO - "script_repo_revision": "production", 02:22:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:22:17 INFO - "repository": "", 02:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:22:17 INFO - "buildid": "20160530234442", 02:22:17 INFO - "pgo_build": "True", 02:22:17 INFO - "basedir": "/builds/slave/test", 02:22:17 INFO - "buildnumber": 743, 02:22:17 INFO - "slavename": "talos-linux64-ix-057", 02:22:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:22:17 INFO - "platform": "ubuntu64_hw", 02:22:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:22:17 INFO - "branch": "fx-team", 02:22:17 INFO - "repo_path": "integration/fx-team", 02:22:17 INFO - "revision": "dc4d7f68030e", 02:22:17 INFO - "stage_platform": "linux64-pgo", 02:22:17 INFO - "builduid": "4587975f5a5b44a8a822f4e4397f23c9", 02:22:17 INFO - "slavebuilddir": "test" 02:22:17 INFO - } 02:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:22:17 INFO - Running post-action listener: _resource_record_post_action 02:22:17 INFO - ##### 02:22:17 INFO - ##### Finished read-buildbot-config step (success) 02:22:17 INFO - ##### 02:22:17 INFO - ##### 02:22:17 INFO - ##### Running download-and-extract step. 02:22:17 INFO - ##### 02:22:17 INFO - Running pre-action listener: _resource_record_pre_action 02:22:17 INFO - Running main action method: download_and_extract 02:22:17 INFO - mkdir: /builds/slave/test/build/tests 02:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:17 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:22 INFO - Downloaded 1361 bytes. 02:22:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:22 INFO - Using the following test package requirements: 02:22:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'jsshell-linux-x86_64.zip'], 02:22:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:22 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:23 INFO - Downloaded 24410442 bytes. 02:22:23 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'] 02:22:23 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 02:22:25 INFO - Return code: 0 02:22:25 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 02:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:25 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:27 INFO - Downloaded 24410442 bytes. 02:22:27 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'] 02:22:27 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 02:22:28 INFO - Return code: 0 02:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:28 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:29 INFO - Downloaded 10834055 bytes. 02:22:29 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'] 02:22:29 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 02:22:30 INFO - Return code: 0 02:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:30 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:31 INFO - Downloaded 58942948 bytes. 02:22:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:31 INFO - mkdir: /builds/slave/test/properties 02:22:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:31 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:31 INFO - Contents: 02:22:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:32 INFO - Running post-action listener: _resource_record_post_action 02:22:32 INFO - Running post-action listener: set_extra_try_arguments 02:22:32 INFO - ##### 02:22:32 INFO - ##### Finished download-and-extract step (success) 02:22:32 INFO - ##### 02:22:32 INFO - ##### 02:22:32 INFO - ##### Running populate-webroot step. 02:22:32 INFO - ##### 02:22:32 INFO - Running pre-action listener: _resource_record_pre_action 02:22:32 INFO - Running main action method: populate_webroot 02:22:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:32 INFO - '--tppagecycles', 02:22:32 INFO - '7'], 02:22:32 INFO - 'tests': ['tsvgm']}}, 02:22:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['damp', 'tps']}, 02:22:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'tests': ['damp', 'tps']}, 02:22:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['dromaeo_dom']}, 02:22:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tsvgx', 02:22:32 INFO - 'tsvgr_opacity', 02:22:32 INFO - 'tart', 02:22:32 INFO - 'tscrollx', 02:22:32 INFO - 'cart']}, 02:22:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:32 INFO - 'tsvgr_opacity', 02:22:32 INFO - 'tart', 02:22:32 INFO - 'tscrollx', 02:22:32 INFO - 'cart']}, 02:22:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tp5o']}, 02:22:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'tests': ['tp5o']}, 02:22:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s', 02:22:32 INFO - '--xperf_path', 02:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:32 INFO - 'tests': ['tp5n']}, 02:22:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:32 INFO - 'talos_options': ['--xperf_path', 02:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:32 INFO - 'tests': ['tp5n']}}, 02:22:32 INFO - 'talos.zip': {'path': '', 02:22:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:32 INFO - Running post-action listener: _resource_record_post_action 02:22:32 INFO - ##### 02:22:32 INFO - ##### Finished populate-webroot step (success) 02:22:32 INFO - ##### 02:22:32 INFO - ##### 02:22:32 INFO - ##### Running create-virtualenv step. 02:22:32 INFO - ##### 02:22:32 INFO - Running pre-action listener: _resource_record_pre_action 02:22:32 INFO - Running main action method: create_virtualenv 02:22:32 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:22:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:32 INFO - Using real prefix '/usr' 02:22:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:35 INFO - Installing pip.................done. 02:22:35 INFO - Return code: 0 02:22:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:22:35 INFO - Using env: {'DISPLAY': ':0', 02:22:35 INFO - 'HOME': '/home/cltbld', 02:22:35 INFO - 'LANG': 'en_US.UTF-8', 02:22:35 INFO - 'LANGUAGE': 'en_US:en', 02:22:35 INFO - 'LOGNAME': 'cltbld', 02:22:35 INFO - 'MAIL': '/var/mail/cltbld', 02:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:35 INFO - 'MOZ_NO_REMOTE': '1', 02:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:35 INFO - 'NO_EM_RESTART': '1', 02:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:35 INFO - 'PWD': '/builds/slave/test', 02:22:35 INFO - 'SHELL': '/bin/bash', 02:22:35 INFO - 'SHLVL': '1', 02:22:35 INFO - 'TERM': 'linux', 02:22:35 INFO - 'TMOUT': '86400', 02:22:35 INFO - 'USER': 'cltbld', 02:22:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:35 INFO - '_': '/tools/buildbot/bin/python'} 02:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:22:35 INFO - Cleaning up... 02:22:35 INFO - Return code: 0 02:22:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:22:35 INFO - Using env: {'DISPLAY': ':0', 02:22:35 INFO - 'HOME': '/home/cltbld', 02:22:35 INFO - 'LANG': 'en_US.UTF-8', 02:22:35 INFO - 'LANGUAGE': 'en_US:en', 02:22:35 INFO - 'LOGNAME': 'cltbld', 02:22:35 INFO - 'MAIL': '/var/mail/cltbld', 02:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:35 INFO - 'MOZ_NO_REMOTE': '1', 02:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:35 INFO - 'NO_EM_RESTART': '1', 02:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:35 INFO - 'PWD': '/builds/slave/test', 02:22:35 INFO - 'SHELL': '/bin/bash', 02:22:35 INFO - 'SHLVL': '1', 02:22:35 INFO - 'TERM': 'linux', 02:22:35 INFO - 'TMOUT': '86400', 02:22:35 INFO - 'USER': 'cltbld', 02:22:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:35 INFO - '_': '/tools/buildbot/bin/python'} 02:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:35 INFO - Downloading/unpacking psutil>=3.1.1 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:37 INFO - Installing collected packages: psutil 02:22:37 INFO - Running setup.py install for psutil 02:22:37 INFO - building 'psutil._psutil_linux' extension 02:22:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:22:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:22:37 INFO - building 'psutil._psutil_posix' extension 02:22:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:22:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:37 INFO - Successfully installed psutil 02:22:37 INFO - Cleaning up... 02:22:38 INFO - Return code: 0 02:22:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:38 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')]} 02:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:38 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')]} 02:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:38 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 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:38 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 02:22:38 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 02:22:38 INFO - Using env: {'DISPLAY': ':0', 02:22:38 INFO - 'HOME': '/home/cltbld', 02:22:38 INFO - 'LANG': 'en_US.UTF-8', 02:22:38 INFO - 'LANGUAGE': 'en_US:en', 02:22:38 INFO - 'LOGNAME': 'cltbld', 02:22:38 INFO - 'MAIL': '/var/mail/cltbld', 02:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:38 INFO - 'MOZ_NO_REMOTE': '1', 02:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:38 INFO - 'NO_EM_RESTART': '1', 02:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:38 INFO - 'PWD': '/builds/slave/test', 02:22:38 INFO - 'SHELL': '/bin/bash', 02:22:38 INFO - 'SHLVL': '1', 02:22:38 INFO - 'TERM': 'linux', 02:22:38 INFO - 'TMOUT': '86400', 02:22:38 INFO - 'USER': 'cltbld', 02:22:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:38 INFO - '_': '/tools/buildbot/bin/python'} 02:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:40 INFO - Installing collected packages: mozsystemmonitor 02:22:40 INFO - Running setup.py install for mozsystemmonitor 02:22:40 INFO - Successfully installed mozsystemmonitor 02:22:40 INFO - Cleaning up... 02:22:40 INFO - Return code: 0 02:22:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:22:40 INFO - Using env: {'DISPLAY': ':0', 02:22:40 INFO - 'HOME': '/home/cltbld', 02:22:40 INFO - 'LANG': 'en_US.UTF-8', 02:22:40 INFO - 'LANGUAGE': 'en_US:en', 02:22:40 INFO - 'LOGNAME': 'cltbld', 02:22:40 INFO - 'MAIL': '/var/mail/cltbld', 02:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:40 INFO - 'MOZ_NO_REMOTE': '1', 02:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:40 INFO - 'NO_EM_RESTART': '1', 02:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:40 INFO - 'PWD': '/builds/slave/test', 02:22:40 INFO - 'SHELL': '/bin/bash', 02:22:40 INFO - 'SHLVL': '1', 02:22:40 INFO - 'TERM': 'linux', 02:22:40 INFO - 'TMOUT': '86400', 02:22:40 INFO - 'USER': 'cltbld', 02:22:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:40 INFO - '_': '/tools/buildbot/bin/python'} 02:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:43 INFO - Downloading docopt-0.6.1.tar.gz 02:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:43 INFO - Running setup.py install for blobuploader 02:22:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:43 INFO - Running setup.py install for requests 02:22:43 INFO - Running setup.py install for docopt 02:22:43 INFO - Successfully installed blobuploader requests docopt 02:22:43 INFO - Cleaning up... 02:22:43 INFO - Return code: 0 02:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:43 INFO - Using env: {'DISPLAY': ':0', 02:22:43 INFO - 'HOME': '/home/cltbld', 02:22:43 INFO - 'LANG': 'en_US.UTF-8', 02:22:43 INFO - 'LANGUAGE': 'en_US:en', 02:22:43 INFO - 'LOGNAME': 'cltbld', 02:22:43 INFO - 'MAIL': '/var/mail/cltbld', 02:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:43 INFO - 'MOZ_NO_REMOTE': '1', 02:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:43 INFO - 'NO_EM_RESTART': '1', 02:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:43 INFO - 'PWD': '/builds/slave/test', 02:22:43 INFO - 'SHELL': '/bin/bash', 02:22:43 INFO - 'SHLVL': '1', 02:22:43 INFO - 'TERM': 'linux', 02:22:43 INFO - 'TMOUT': '86400', 02:22:43 INFO - 'USER': 'cltbld', 02:22:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:43 INFO - '_': '/tools/buildbot/bin/python'} 02:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:44 INFO - Running setup.py (path:/tmp/pip-jDHjX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:44 INFO - Running setup.py (path:/tmp/pip-mSAV1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:44 INFO - Running setup.py (path:/tmp/pip-bsDnUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:44 INFO - Running setup.py (path:/tmp/pip-AlBH3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:44 INFO - Running setup.py (path:/tmp/pip-TDc99q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:44 INFO - Running setup.py (path:/tmp/pip-e08GUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:44 INFO - Running setup.py (path:/tmp/pip-o5VL3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:44 INFO - Running setup.py (path:/tmp/pip-31Jcsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:44 INFO - Running setup.py (path:/tmp/pip-bok1ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:44 INFO - Running setup.py (path:/tmp/pip-QdCIKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:44 INFO - Running setup.py (path:/tmp/pip-aAToUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:44 INFO - Running setup.py (path:/tmp/pip-oURDiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:44 INFO - Running setup.py (path:/tmp/pip-tncGy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:44 INFO - Running setup.py (path:/tmp/pip-8q8gJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:45 INFO - Running setup.py (path:/tmp/pip-mtgcuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:45 INFO - Running setup.py (path:/tmp/pip-KnX90n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:45 INFO - Running setup.py (path:/tmp/pip-4ETSiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:45 INFO - Running setup.py install for manifestparser 02:22:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:45 INFO - Running setup.py install for mozcrash 02:22:45 INFO - Running setup.py install for mozdebug 02:22:45 INFO - Running setup.py install for mozdevice 02:22:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:45 INFO - Running setup.py install for mozfile 02:22:45 INFO - Running setup.py install for mozhttpd 02:22:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:45 INFO - Running setup.py install for mozinfo 02:22:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:45 INFO - Running setup.py install for mozInstall 02:22:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Running setup.py install for mozleak 02:22:46 INFO - Running setup.py install for mozlog 02:22:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Running setup.py install for moznetwork 02:22:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Running setup.py install for mozprocess 02:22:46 INFO - Running setup.py install for mozprofile 02:22:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Running setup.py install for mozrunner 02:22:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Running setup.py install for mozscreenshot 02:22:46 INFO - Running setup.py install for moztest 02:22:46 INFO - Running setup.py install for mozversion 02:22:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:46 INFO - Cleaning up... 02:22:47 INFO - Return code: 0 02:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:47 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 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:47 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 02:22:47 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 02:22:47 INFO - Using env: {'DISPLAY': ':0', 02:22:47 INFO - 'HOME': '/home/cltbld', 02:22:47 INFO - 'LANG': 'en_US.UTF-8', 02:22:47 INFO - 'LANGUAGE': 'en_US:en', 02:22:47 INFO - 'LOGNAME': 'cltbld', 02:22:47 INFO - 'MAIL': '/var/mail/cltbld', 02:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:47 INFO - 'MOZ_NO_REMOTE': '1', 02:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:47 INFO - 'NO_EM_RESTART': '1', 02:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:47 INFO - 'PWD': '/builds/slave/test', 02:22:47 INFO - 'SHELL': '/bin/bash', 02:22:47 INFO - 'SHLVL': '1', 02:22:47 INFO - 'TERM': 'linux', 02:22:47 INFO - 'TMOUT': '86400', 02:22:47 INFO - 'USER': 'cltbld', 02:22:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:47 INFO - '_': '/tools/buildbot/bin/python'} 02:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:47 INFO - Running setup.py (path:/tmp/pip-Xn2YSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:47 INFO - Running setup.py (path:/tmp/pip-FJ9URI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:47 INFO - Running setup.py (path:/tmp/pip-PLRyUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:47 INFO - Running setup.py (path:/tmp/pip-laOaoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:47 INFO - Running setup.py (path:/tmp/pip-KJbnEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:47 INFO - Running setup.py (path:/tmp/pip-A5El1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:47 INFO - Running setup.py (path:/tmp/pip-V5kyDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:47 INFO - Running setup.py (path:/tmp/pip-gJB91t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:47 INFO - Running setup.py (path:/tmp/pip-M5LbyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:47 INFO - Running setup.py (path:/tmp/pip-rKqYto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:47 INFO - Running setup.py (path:/tmp/pip-AX2igp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:48 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)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:48 INFO - Running setup.py (path:/tmp/pip-nDO9gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:48 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)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:48 INFO - Running setup.py (path:/tmp/pip-ComaCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:48 INFO - Running setup.py (path:/tmp/pip-4R3Wlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:48 INFO - Running setup.py (path:/tmp/pip-hU9Ay8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:48 INFO - Running setup.py (path:/tmp/pip-_T2g2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:48 INFO - Running setup.py (path:/tmp/pip-6xrQrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:50 INFO - Downloading blessings-1.6.tar.gz 02:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:50 INFO - Installing collected packages: blessings 02:22:50 INFO - Running setup.py install for blessings 02:22:50 INFO - Successfully installed blessings 02:22:50 INFO - Cleaning up... 02:22:50 INFO - Return code: 0 02:22:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:50 INFO - Reading from file tmpfile_stdout 02:22:50 INFO - Current package versions: 02:22:50 INFO - argparse == 1.2.1 02:22:50 INFO - blessings == 1.6 02:22:50 INFO - blobuploader == 1.2.4 02:22:50 INFO - docopt == 0.6.1 02:22:50 INFO - manifestparser == 1.1 02:22:50 INFO - mozInstall == 1.12 02:22:50 INFO - mozcrash == 0.17 02:22:50 INFO - mozdebug == 0.1 02:22:50 INFO - mozdevice == 0.48 02:22:50 INFO - mozfile == 1.2 02:22:50 INFO - mozhttpd == 0.7 02:22:50 INFO - mozinfo == 0.9 02:22:50 INFO - mozleak == 0.1 02:22:50 INFO - mozlog == 3.2 02:22:50 INFO - moznetwork == 0.27 02:22:50 INFO - mozprocess == 0.22 02:22:50 INFO - mozprofile == 0.28 02:22:50 INFO - mozrunner == 6.11 02:22:50 INFO - mozscreenshot == 0.1 02:22:50 INFO - mozsystemmonitor == 0.3 02:22:50 INFO - moztest == 0.7 02:22:50 INFO - mozversion == 1.4 02:22:50 INFO - psutil == 3.1.1 02:22:50 INFO - requests == 1.2.3 02:22:50 INFO - wsgiref == 0.1.2 02:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:50 INFO - Using env: {'DISPLAY': ':0', 02:22:50 INFO - 'HOME': '/home/cltbld', 02:22:50 INFO - 'LANG': 'en_US.UTF-8', 02:22:50 INFO - 'LANGUAGE': 'en_US:en', 02:22:50 INFO - 'LOGNAME': 'cltbld', 02:22:50 INFO - 'MAIL': '/var/mail/cltbld', 02:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:50 INFO - 'MOZ_NO_REMOTE': '1', 02:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:50 INFO - 'NO_EM_RESTART': '1', 02:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:50 INFO - 'PWD': '/builds/slave/test', 02:22:50 INFO - 'SHELL': '/bin/bash', 02:22:50 INFO - 'SHLVL': '1', 02:22:50 INFO - 'TERM': 'linux', 02:22:50 INFO - 'TMOUT': '86400', 02:22:50 INFO - 'USER': 'cltbld', 02:22:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:50 INFO - '_': '/tools/buildbot/bin/python'} 02:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:50 INFO - Cleaning up... 02:22:50 INFO - Return code: 0 02:22:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:50 INFO - Using env: {'DISPLAY': ':0', 02:22:50 INFO - 'HOME': '/home/cltbld', 02:22:50 INFO - 'LANG': 'en_US.UTF-8', 02:22:50 INFO - 'LANGUAGE': 'en_US:en', 02:22:50 INFO - 'LOGNAME': 'cltbld', 02:22:50 INFO - 'MAIL': '/var/mail/cltbld', 02:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:50 INFO - 'MOZ_NO_REMOTE': '1', 02:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:50 INFO - 'NO_EM_RESTART': '1', 02:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:50 INFO - 'PWD': '/builds/slave/test', 02:22:50 INFO - 'SHELL': '/bin/bash', 02:22:50 INFO - 'SHLVL': '1', 02:22:50 INFO - 'TERM': 'linux', 02:22:50 INFO - 'TMOUT': '86400', 02:22:50 INFO - 'USER': 'cltbld', 02:22:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:50 INFO - '_': '/tools/buildbot/bin/python'} 02:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:51 INFO - Downloading/unpacking jsonschema 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:53 INFO - Downloading/unpacking functools32 (from jsonschema) 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:53 INFO - warning: no files found matching '*.txt' 02:22:53 INFO - no previously-included directories found matching 'build' 02:22:53 INFO - no previously-included directories found matching 'dist' 02:22:53 INFO - no previously-included directories found matching '.git*' 02:22:53 INFO - Installing collected packages: jsonschema, functools32 02:22:53 INFO - Running setup.py install for functools32 02:22:53 INFO - warning: no files found matching '*.txt' 02:22:53 INFO - no previously-included directories found matching 'build' 02:22:53 INFO - no previously-included directories found matching 'dist' 02:22:53 INFO - no previously-included directories found matching '.git*' 02:22:53 INFO - Successfully installed jsonschema functools32 02:22:53 INFO - Cleaning up... 02:22:53 INFO - Return code: 0 02:22:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9206bc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', '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 02:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:22:53 INFO - Using env: {'DISPLAY': ':0', 02:22:53 INFO - 'HOME': '/home/cltbld', 02:22:53 INFO - 'LANG': 'en_US.UTF-8', 02:22:53 INFO - 'LANGUAGE': 'en_US:en', 02:22:53 INFO - 'LOGNAME': 'cltbld', 02:22:53 INFO - 'MAIL': '/var/mail/cltbld', 02:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:53 INFO - 'MOZ_NO_REMOTE': '1', 02:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:53 INFO - 'NO_EM_RESTART': '1', 02:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:53 INFO - 'PWD': '/builds/slave/test', 02:22:53 INFO - 'SHELL': '/bin/bash', 02:22:53 INFO - 'SHLVL': '1', 02:22:53 INFO - 'TERM': 'linux', 02:22:53 INFO - 'TMOUT': '86400', 02:22:53 INFO - 'USER': 'cltbld', 02:22:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:53 INFO - '_': '/tools/buildbot/bin/python'} 02:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:53 INFO - Downloading/unpacking flake8 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:22:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:22:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:22:56 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 02:22:56 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 02:22:56 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 02:22:56 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 02:22:56 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 02:22:56 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 02:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:22:56 INFO - no previously-included directories found matching 'docs/_build' 02:22:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:22:56 INFO - Running setup.py install for pep8 02:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:22:56 INFO - no previously-included directories found matching 'docs/_build' 02:22:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:22:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:22:56 INFO - Cleaning up... 02:22:56 INFO - Return code: 0 02:22:56 INFO - Running post-action listener: _resource_record_post_action 02:22:56 INFO - Running post-action listener: _start_resource_monitoring 02:22:56 INFO - Starting resource monitoring. 02:22:56 INFO - ##### 02:22:56 INFO - ##### Finished create-virtualenv step (success) 02:22:56 INFO - ##### 02:22:56 INFO - ##### 02:22:56 INFO - ##### Running install step. 02:22:56 INFO - ##### 02:22:56 INFO - Running pre-action listener: _resource_record_pre_action 02:22:56 INFO - Running main action method: install 02:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:56 INFO - Reading from file tmpfile_stdout 02:22:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:56 INFO - Reading from file tmpfile_stdout 02:22:56 INFO - Output received: 02:22:56 INFO - Usage: mozinstall [options] installer 02:22:56 INFO - Options: 02:22:56 INFO - -h, --help show this help message and exit 02:22:56 INFO - -d DEST, --destination=DEST 02:22:56 INFO - Directory to install application into. [default: 02:22:56 INFO - "/builds/slave/test"] 02:22:56 INFO - --app=APP Application being installed. [default: firefox] 02:22:56 INFO - mkdir: /builds/slave/test/build/application 02:22:56 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'] 02:22:56 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 02:23:13 INFO - Reading from file tmpfile_stdout 02:23:13 INFO - Output received: 02:23:13 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:13 INFO - Running post-action listener: _resource_record_post_action 02:23:13 INFO - ##### 02:23:13 INFO - ##### Finished install step (success) 02:23:13 INFO - ##### 02:23:13 INFO - ##### 02:23:13 INFO - ##### Running run-tests step. 02:23:13 INFO - ##### 02:23:13 INFO - Running pre-action listener: _resource_record_pre_action 02:23:13 INFO - Running main action method: run_tests 02:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:13 INFO - Python 2.7.3 02:23:13 INFO - Return code: 0 02:23:13 INFO - grabbing minidump binary from tooltool 02:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:23:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:23:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:23:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:13 INFO - Return code: 0 02:23:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:23:14 INFO - Return code: 0 02:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 02:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 02:23:14 INFO - Using env: {'DISPLAY': ':0', 02:23:14 INFO - 'HOME': '/home/cltbld', 02:23:14 INFO - 'LANG': 'en_US.UTF-8', 02:23:14 INFO - 'LANGUAGE': 'en_US:en', 02:23:14 INFO - 'LOGNAME': 'cltbld', 02:23:14 INFO - 'MAIL': '/var/mail/cltbld', 02:23:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:14 INFO - 'MOZ_NO_REMOTE': '1', 02:23:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:14 INFO - 'NO_EM_RESTART': '1', 02:23:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:14 INFO - 'PWD': '/builds/slave/test', 02:23:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:14 INFO - 'SHELL': '/bin/bash', 02:23:14 INFO - 'SHLVL': '1', 02:23:14 INFO - 'TERM': 'linux', 02:23:14 INFO - 'TMOUT': '86400', 02:23:14 INFO - 'USER': 'cltbld', 02:23:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388', 02:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:14 INFO - '_': '/tools/buildbot/bin/python'} 02:23:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 02:23:14 INFO - mozversion application_buildid: 20160530234442 02:23:14 INFO - mozversion application_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:23:14 INFO - mozversion application_display_name: Nightly 02:23:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:14 INFO - mozversion application_name: Firefox 02:23:14 INFO - mozversion application_remotingname: firefox 02:23:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:23:14 INFO - mozversion application_vendor: Mozilla 02:23:14 INFO - mozversion application_version: 49.0a1 02:23:14 INFO - mozversion platform_buildid: 20160530234442 02:23:14 INFO - mozversion platform_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:23:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:23:14 INFO - mozversion platform_version: 49.0a1 02:23:14 INFO - using testdate: 1464686594 02:23:14 INFO - actual date: 1464686594 02:23:14 INFO - starting webserver on 'localhost:52647' 02:23:14 INFO - SUITE-START | Running 2 tests 02:23:14 INFO - TEST-START | dromaeo_css 02:23:14 INFO - operating with platform_type : linux_ 02:23:14 INFO - Initialising browser for dromaeo_css test... 02:23:14 INFO - TEST-INFO | started process 28424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphN1EOB/profile http://localhost:52647/getInfo.html) 02:23:19 INFO - PROCESS | 28424 | __metrics Screen width/height:1600/1200 02:23:19 INFO - PROCESS | 28424 | colorDepth:24 02:23:19 INFO - PROCESS | 28424 | Browser inner width/height: 1024/697 02:23:19 INFO - PROCESS | 28424 | __metrics 02:23:20 ERROR - PROCESS | 28424 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:23:21 INFO - TEST-INFO | 28424: exit 0 02:23:21 INFO - Browser initialized. 02:23:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:21 INFO - TEST-INFO | started process 28506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphN1EOB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:32 INFO - PROCESS | 28506 | RSS: Main: 155738112 02:23:32 INFO - PROCESS | 28506 | 02:24:24 INFO - PROCESS | 28506 | 1464686664166 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] 02:26:31 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52647/tests/dromaeo/cssquery-ext.html) 02:26:33 INFO - PROCESS | 28506 | RSS: Main: 244744192 02:26:33 INFO - PROCESS | 28506 | 02:29:35 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-ext.html (next: http://localhost:52647/tests/dromaeo/cssquery-jquery.html) 02:29:36 INFO - PROCESS | 28506 | RSS: Main: 238497792 02:29:36 INFO - PROCESS | 28506 | 02:32:38 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52647/tests/dromaeo/cssquery-mootools.html) 02:32:38 INFO - PROCESS | 28506 | RSS: Main: 244588544 02:32:38 INFO - PROCESS | 28506 | 02:35:40 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52647/tests/dromaeo/cssquery-prototype.html) 02:35:41 INFO - PROCESS | 28506 | RSS: Main: 236515328 02:35:41 INFO - PROCESS | 28506 | 02:38:44 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52647/tests/dromaeo/cssquery-yui.html) 02:38:44 INFO - PROCESS | 28506 | RSS: Main: 229982208 02:38:44 INFO - PROCESS | 28506 | 02:41:47 INFO - PROCESS | 28506 | Cycle 1(1): loaded http://localhost:52647/tests/dromaeo/cssquery-yui.html (next: http://localhost:52647/tests/dromaeo/cssquery-dojo.html) 02:41:48 INFO - PROCESS | 28506 | RSS: Main: 295251968 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | __start_tp_report 02:41:48 INFO - PROCESS | 28506 | _x_x_mozilla_page_load 02:41:48 INFO - PROCESS | 28506 | _x_x_mozilla_page_load_details 02:41:48 INFO - PROCESS | 28506 | |i|pagename|runs| 02:41:48 INFO - PROCESS | 28506 | |0;dojo.html;3183.697548732871;3200.1039708881513;3214.453542897708;3238.886638967637;3248.2529018325786;5322.414534401213;5472.699001554913;5525.530329921957;5586.608937374385;5600.243967064445;5314.681119132854;5342.519173274404;5425.213344065108;5524.447555244474;5553.972230138854;4811.422629284482;4879.756012199394;4907.779149938261;4910.042541704369;5039.974800125994;4937.80248790048;4985.825496107637;4993.700377977315;5004.674696144757;5054.494550544953;4930.556249937505;4979.377577802757;4985.302057711923;5001.774920128585;5023.899522009576;4981.053599816023;4999.9500004999845;5003.199488081926;5013.222950442687;5066.392032956032;5012.8496145115705;5029.094762942669;5049.242613607951;5060.190369540893;5087.084324821531;5289.576833853283;5351.036813373591;5397.946020539784;5439.646422982533;5527.170924361338;5961.195238642815;6002.969985150046;6009.1587177795145;6015;6029.21620189377;6024.277086749618;6049.455549000611;6049.879002419927;6056.21269235001;6063.9090413643835;5423.105187644034;5444.101723215665;5570.136628822498;5575.637583557096;5643.887122257532;6119.2350956130485;6137.601055931439;6137.96931015351;6139.6009259398;6142.662153581596;5901.114832775118;5930.7924222652;5930.970345148246;5931.466168044896;5932.49573786233;5632.690202038927;5675.460831221028;5701.543876489871;5719.19931209631;5731.742071606787;5742.397048309951;5782.537397008229;5784.566157538202;5786.276715410574;5789.971050144806;5745.511631511285;5752.568557358215;5793.797217097382;5796.710164491758;5806.332271788714;4452.265376212888;4497.325401189848;4507.391502147234;4509.729416235036;4510.909781804346;3997.9400308995387;4004.3192657247755;4006.757905049444;4026.859059932947;4041;5487.286652735119;5554.972225138929;5622.95975244581;5626.2967129108865;5633.3240011198095;5890.558208134407;5910.586258961917;5932.169496270526;5936;5942.197803296586;5546.805861794898;5547.639403438844;5548.167774833807;5552.52803511706;5555.472230138131;5008.223725322581;5040.36995375578;5091.770870310845;5100.540951314325;5147.845564633067;6109.297430795426;6170.753169873155;6176.073588961602;6176.135341052256;6178.289496707846;5972.671503067373;5978.730957106854;5979.5814292999075;5980.19267398913;6016.699165041818;5951.226340575698;6117.0824376342125;6121.971262793429;6152.16945712341;6164.568480206522;5874.265716785402;5919.230500034968;5920.674362909909;5923.141144534105;5968.552358573038;5965.642061476326;6037.849053773691;6046.183765191643;6049.062395328731;6050.6369617823075;5645.68948707825;5729.427057294237;5741.569382296261;5746;5850.23946886919;5797.797077102281;5810.041343178328;5813.302403711582;5821.330546987151;5823.126531020381;5665.575081868794;5669.971650141723;5675.035244008611;5681.289838770153;5683.8863222736145;5714.714264286852;5833.095870140135;5905.91141132892;5934.643921364732;5948.256467941507;5721.914171287351;5752.539796816328;5756.0502517084215;5768.480836724715;5789.91315130265 02:41:48 INFO - PROCESS | 28506 | |1;ext.html;587.0929414055284;605.2525131462643;612.5344737999122;616.6608365399035;623.8128561431571;30787.230319242;42931.57068429315;42989.35515967263;42994.57005429941;43459;44958;46031.309530356986;46048;46091.30863037057;46285.76857115718;8614.440061396004;8836.469811811312;8842.823143537125;8849.95575022124;8851.867221991675;8562.272206862424;8699.652013919436;8701.869471957925;8705.260052895512;8709.912900871006;8793.516356600385;8805.20753132218;8837.337199710015;8841.425307355034;8845;8726.083761205076;8736.21374076333;8751.693690720795;8753.431026983226;8760.912390876074;8798.384113112084;8879.822403551892;8898.911010889939;8901.866472002925;8906.55467226636;42073.368899466535;42405.78797106026;42416.57583424188;42509;42637.78681106606;3321.734261259118;3415.1803567143706;3739.8878033659034;3882.301185786557;4030.2544029354663;32121.83939080313;32245.838770805996;32460.35079298401;32703.18242043944;33072.66927330744;4270.359446083081;4331.6534677225745;4359.760213188273;4430.490493593245;4471.3293006049025;346279;346376;347093;347673;348721;57764;58157;58467.415325846196;58481.41518584845;58623;53155.73422132865;53744.731276343366;60059.69970150121;60767.39232607706;61098.694506528074;12977.610671679864;13258.40337184829;15110.697786044437;15170.772438413433;15247.23763811805;11914.76170476603;11987.700307492383;12009.09931755122;12015.098867584966;12028.518859245707;16220.59448513773;16262.837371626369;16267.105309208107;16267.18664066792;16306.266218020217;5151.8196863109615;5880.353161152269;6013.819585412444;6393.6483493408305;6544.247411547638;964.5273815830193;1040.7294103532984;1099.2580008494235;1105.3588918427292;1123.500042481088;32198.19504512359;32241.51637725436;32496.350072998408;32544;32677.346453070804;1082.312731415541;1097.1223021582862;1126.1666366888444;1130.6608017594688;1172.4255114993591;16391.180440977903;16711.41510047167;16921.915390423215;16923.323067077425;17183.742243866353;514665;518880;520427;523341;523718;58600.41399586035;58608.41391586029;58623;58747.118793218135;58844.705776470844;1283.1723538317733;1360.673438374783;1369.0621923982103;1374.71131062476;1383.0733408616252;30659.386812264074;32095.839520802245;32116.67883321137;32253.51619725753;33067.83466082654;47555.28667070066;47870;48013.75993120012;48173;48199.277010845566;401616;406615;406892;408569;409284;35033.82483087568;39111.6088839108;39552.60447395489;40269.1946161081;43916.56083439253;48558.75720621374;48583.75708121437;48591.59858809991;49165.508344916096;49582.25626615532;40034.39948400835;40622.39066414065;40641.59358406378;40772.79613601913;41327;40437.393439099025;40783.796081019405;41007.38488922609;41262.58737412708;41477.37783933183;41804.790976044926;41846.58153418548;43605.78197108994;44196;44229.55770442254;33942.8302858494;36571;36822.63177368192;37354;37391;27116.32209194786;27735.722642773315;27870.86064569664;28085.914085914086;28259.434811303247 02:41:48 INFO - PROCESS | 28506 | |2;jquery.html;380.23952095808386;387.3504356478898;390.58597886240585;394.63496265953995;413.4459823836059;14102.647433814134;16423.42518011867;18396.54008649783;19858.702119468202;19909.104090315952;17565.385211517598;17958;18385.08074596268;18399.356022539214;18987.905060474714;5195.974020129904;5325.227841962913;5362.758675859595;5379.542738867201;5385.596080293974;3928.705347098965;5213.817516386927;5307.575393968474;5650.350209725872;5922.822315330525;5990.131430942511;5993.101034844764;5993.430624090704;6004.3395226525045;6020.548458865603;5817.389174136697;5956.106584012389;5991.940080599182;6002.279726432812;6031.517478601701;5609.719514024323;5659.971700141514;5701.230333904911;5728.054870946289;5730.083186690152;13506.392212350369;13824.654383640389;13856.93071534646;13863.098898571661;13865.09876858001;2191.6712493126;2215.0586000949693;2218.9334319970267;2241.68616393705;2883.2215301868587;9614.23086153113;10002.199824014135;10108.595656173744;10434.582616695323;10489.947550262275;1888.650599639071;1928.9264041155673;1983.3950645053253;2028.98985505073;2036.4094412620323;75795;76481.23518764852;78128.60935695285;79273;80740.78888816731;10326.638567650096;10408.895911040943;10459.895401046044;10498.317609355367;10989.725256868642;13424.798628020588;13911.79132313016;14446.927765361106;14466.566003019716;14468.927655361656;6293.150424692608;6550.246721627074;7446.292602202782;7913.366930645535;7985.880211796712;7543.358814500719;7577.772666820004;7610.847783044308;7748.6125693715085;7751.379889608817;4509.436320459942;4531.071130418256;4547.15877562652;4554.817807287672;4632.559906808848;1800.558863078528;1868.7010078387393;1930.6042261336393;1935.6032013437211;1976.901154942276;960.841461158901;963.9325247232766;968.651285537206;971.9514024298757;1021.4973315377207;17596.824031759774;17946.730799038025;18150.909245453953;18417.539561510803;19051.333203337817;959.2182371367313;970.5583959298502;979.6179489998906;986.6250824686716;1067.2849191042021;10126.443045632413;10589.241664677324;10614.787704245871;10711.25021248505;10734.141268698486;463489;470459;474689;479580;484469;91309;92583.53708231551;92794.53602731944;93358.06641933629;93948;1001.9699409017741;1013.8834034086175;1053.6628278950816;1069.534752382716;1082.4912291223113;16329.591760206089;16456.177191140636;16579.50261492157;16671.666566668355;17615.295388184328;32788.83605581957;37719.24561508809;39558;41548.16903661849;44445.11109777722;53621.46378536321;58530.414695852494;59130.56520760874;59625.7018714921;59673.7016314933;8540.658373664985;8674.219320261207;8697.39118261741;8822.911770882209;9077.31920106008;9830.311878168459;13384.93307533456;13776.448942042607;13785.724285514032;13895.444182232597;11106.278091924;11882.940585297018;12168.93915530452;12173.634790956285;12496.750064998467;11328.207025508465;11870.940645296718;12013.099017573542;12201.389930503261;12470.563530276397;6619.3049729779605;10611.575536978435;12014.918657320883;12567.811482827949;12683.682907927006;8701.52141632191;8733.956330218309;8756.737297881074;8797.208251257418;9014.098590140933;11441.885581144415;12095.334756588472;12438.937805310916;12465.252084874937;12496.562620308245 02:41:48 INFO - PROCESS | 28506 | |3;mootools.html;1259.124908188808;1485.1237769715867;1485.6805786755845;1686.4771920704582;1863.30126202674;8595.398322117446;8987.550622468874;9023.909760902388;9159.35884488086;9159.908400915989;8734;9010;9015.504147271897;9017.413868098569;9030.909690903089;2050.7026481160224;2258.1306197114063;2291.873946932914;2314.2131675230416;2318.6406107053435;2313.467902382453;2316.177756896303;2321.257197696738;2325.732540757809;2328.2898715891647;2305.873176975266;2319.5476882008015;2322.512272422793;2322.7444981052154;2333.8599684018927;2003.649361361763;2069.8758074515426;2072.5958438104576;2185.672149177636;2249.5613355395703;2176.9564608707738;2203;2204.1183526589334;2209.591225623265;2212.15937943582;8840.071792461764;8893.11068893112;8908.643654253887;8911.688090916852;8926.419782714103;5110.182370820688;5232.92150617741;5238.135707608279;5240.68555886648;5253.763580638881;3149.086764838194;3254.1539199807985;3282.2614911644687;3293.7200337971303;3301.6203136639356;1032.8295831187845;1049.2235745548317;1063.5479921033607;1110.8946598134826;1113.6325012745774;12969.610911672571;12976.286304253263;12977.545785897542;12986;13030.348482575833;4390.868273951786;4577.5880170784785;4614.2617181250835;4629.4676112247525;4667.579917807414;10732.73168170802;10748.946255268673;10760.56957721698;10763.13894888407;10777.35335879834;5191.195364718475;5191.740412979336;5195.68825870449;5196.1166601677805;5197.0905091609575;4197.349410841324;4478.641708663299;4563.1101935123;4589.1051245007575;4678.087772884255;3910.393888947218;4034.4150098236178;4056.1076563156057;4084.4690190275073;4118.546959834416;1279.8080287956882;1284.678830292427;1292.1665525735848;1297.0985165310208;1297.6690943809267;783.4868161354322;884.6859364925488;893.1247377569888;915.6154415145655;932.1424289653535;5954.732037058343;5989.071693887455;6052.606580572248;6159.260888693296;6409.391107844747;945.026622578745;968.1431932739576;972.4359871274785;996.1731762636994;1002.8796544414716;3614.1145419371896;3744.9063773405883;3818.6563209311294;3832.5209348831395;3873.2447172801035;10957.50691218897;11451.083913286917;11568.421578921021;11595.188336816342;11605.30368177912;11269.267497612629;11296.943515282372;11371.601993930173;11406.08751299894;11488.25326353801;8507.319414446829;8526.488410695378;8676.349273804364;8688.956555217184;8705.564721763887;5532.529734972572;5631.831045068655;5672.234248376416;5674.659520428788;5719.399463056486;10584.576616935236;10691.8930810694;10704.411257380918;10737.46312684347;10748.677539673823;10493.9475302623;10792.136629069813;10929.672109836718;10944.616938407436;10955.945220273848;6910.7581234656545;7113.181984071898;7299.248180436551;7488.588127653032;7636.389088872988;8546.615402307036;8774.078721734126;8807.119288071142;8817.38278320537;8817.426867253607;7694.846103077795;7804.726834560764;7814.609269536614;7900.249476299742;7994.320482759031;7658.349040331635;7744.419168562267;7821.374290056896;7951;7973.44185906981;6648.16897887764;6671.5997040177745;6687.598744075371;6707.5304728668525;6722.058911752456;4698.953010469988;4777.522247775195;4808.06242782654;4847.103285892122;4887.413510378778;4855;4903.092927808367;4975.402951645681;4984.975075124601;5029.924551131663 02:41:48 INFO - PROCESS | 28506 | |4;prototype.html;315.2921690804145;317.5522513256309;319.4648962986999;322.49851480947126;326.3440484625902;5261.210818377241;5275.8944821103605;5296.894062118756;5302.681839089657;5350.35795704516;5176.0683077046115;5195.9348333591615;5196.58427325814;5228.594846370674;5248.790048398059;3908.902277443058;3983.243183795084;4049.6152865477734;4051;4057.7768222747736;3956.9208615827665;4139.772312522825;4154.231467178566;4160.7087503874745;4161.895952601179;4031.093004074089;4062.3500239961613;4100.528439229482;4110.671146308288;4130.401091841682;3897.8830635080994;3986.2824691555506;4042.919141617151;4071.7760523171064;4089.7546147231114;3606.9278614427826;3620.4026335654585;3620.873269435557;3623.7282203834816;3628.6734193922675;5051.621128415383;5054.241863720435;5090.643654944119;5110.003549307887;5123.590112790967;4442.822287108512;4694.319323698045;4694.366260554815;4728.40894888139;4738.289256611536;5471.003083874397;5488.298627425511;5502;5523.696196709179;5533.810230800357;3956.149427873021;3993.8402463901407;3997.72015958883;3997.8001099944886;4005.198960207941;5324.92012619811;5409.890972350659;5782.277215348082;5827.854303642401;5895.734691938873;3921.9410759095454;3970.404439334123;3972.6424621784176;3975.980120099381;3991.201759648082;3982.542007669097;3991.1419044904906;4004.139110091286;4007.699422543321;4029.315016447211;4627.583517483443;4633.4208223972;4646.907061858744;4669.929951050737;4676.321933319649;5285.810692594136;5499.642523235977;5521.861953451196;5546.252930326934;5573.777048918079;1392.2527228328383;1393.4356585582855;1411.2167746900363;1418.7871819227198;1420.5383250443647;823.5957692134896;853.9658413663508;867.7093173786726;873.3711727556276;876.8903887014123;4683.461401938753;4712.31671407644;4717.976410117927;4731.597814185764;4740.336352910595;5044.798208071636;5079.704675307847;5097.439281679012;5133.897322053538;5197.714125723046;4823.686460380064;4848.539388758062;4852.56326930578;4882.829100981519;5047.697138171721;3071.8497052063644;3074.308280636839;3084.1981084918084;3091.27355071558;3094.675059118805;5956.285245770535;5986.5809393342915;5988.28140623128;5993.31076926159;5999.700014999233;5540.972295138498;5834.445727655866;5834.679092649945;5843.707814609253;5888.205092312569;5644.604877658607;5730.398308177581;5895.35151133375;5917.201177841109;5949.6430214187285;5722.456366645162;5754.625949313281;5759.596828221985;5765.481106700249;5775.5090817281;5548.195511650869;5655;5658.575606829422;5685.573581981285;5699.401562835843;5872.766718988889;5873.091245345195;5898.820235952912;5904.291485021825;5923.585349025527;4065.329220678673;4092.3656833190903;4094.877153685394;4142.212979533879;4142.979285103555;5617.606767526234;5741;5799.449052340021;5826.184334193132;5864.472197502245;5539.806106786243;5565.3599836019375;5582.3859375467855;5602.607817452739;5607.158926161109;5538.169274608841;5560.805371811967;5570.359408668055;5571.247881535941;5604.523615492729;5212.869678258074;5405.297311349499;5452.400235974119;5453.7818487260065;5471.097268950579;5574.191742197439;5577.693226872399;5582.637128586792;5611.494965453129;5625.296837895263;5353.741870660314;5467.6719396836315;5475.342958844964;5533.916991245215;5536.667799932017 02:41:48 INFO - PROCESS | 28506 | |5;yui.html;729.7591794707747;772.112071118214;776.2703059124426;783.0368646564725;805.9798505037376;14895.776563351545;15066.09603423794;15347.92326038371;15396;15397.538073857788;14198;14238.71522569548;14251;14292;14312.35594398252;687.7317846040023;795.6379847169553;809.3646487507308;821.765796747927;826.8883700700419;810.9837803243931;817.5217497763815;819.7950512371907;820.1060843680417;821.3962737388015;870.1776820904248;871.4422769427572;872.5637181409295;873.1704880363649;873.480279233858;703.9366457018867;825.4881973176639;850.685246458808;851.2806678356778;866.1122349591656;621.2327775197673;621.3258614403378;621.4003486635419;621.4375989729302;622.0917460507665;12218.75562488754;12224.633261002095;12235.816462753066;12261.816072758917;12267;12820.487180512768;13181.143225690395;13314.201147931155;13355.332233388292;13383;11630.476628551736;11872.841459894746;11956.065901148277;12201.38993050344;12448.62654120378;4302.376155457472;4347.673924455678;4354.4992325882295;4382.715123516961;4537.274036154199;59299.70350148265;59904.40095599076;60066.399336006514;60069;60606.09090863597;10540.57837686484;10667.733306667395;10671.679849604525;10750.946245268724;10963.177761667906;17905.552361191076;18376.632467350577;18396.908015459838;18986.335478258196;19470.610587788164;8209.302209312156;8334.458260213067;8437.367197460215;8519.778944130812;8737.126287371339;4534.682572219913;4630.629549636021;4655.162070827284;4658.464276608166;4718.976405117953;3224.3712476066944;3321.4685650295837;3322.2192784695576;3325.0357396354784;3414.0781988863364;594.5303210463771;663.2074670768482;667.172705844749;671.050463594009;687.4431710314661;633.4900405173787;706.3501578547748;706.6890568149997;710.1797423975316;715.1668306423063;9330.90669093314;9670.56482458291;9714.951425242829;9793.755156121011;9840.606375745034;671.7706596927611;691.180950573572;708.0724251230904;713.50411464032;728.0426239495047;4333.133373325348;4383.232934236496;4538.931916021263;4562.156001139733;4624.427694583857;71850.64074679594;72446;73498.63250683712;73550;73699.63150184214;47017.29474057892;60792.08811867826;64541.67729161418;65044.34955650478;68426.315736843;58575;59004.704976474844;59155.40844591585;60425.39574604286;60896.39103608996;8540.308033855885;8565.743027709179;8629.09394513567;8699.478031318142;8766.736997890073;40189;40248.396274055325;40781.79609101936;41007.58992410157;41132.58867411407;51057.489425105276;54328.45671543234;55059.72470137624;55756.72121639366;56143;11154.888203011296;11245.943770281423;11283.210175287979;11585.536578536765;11779.646610601696;12697.4286157125;12741.8088728671;12890.806637900252;13297.069205155547;13407.530736424178;12779.04157188196;13126.934365328494;13208.603741887759;13228.867711323148;13822.93088534551;12861.164024338388;13213.867861321649;13287.335633218107;13633.659158520719;13692.726145477234;13033.283169425393;13144.518877288649;13166.535264118998;13181.406836692564;13362.331883405985;10451.372917624967;10580.4709764513;10662.697540606981;10673.519691613741;11156.274842135235;10160.898391015995;10500.369977801356;11162.553497859995;11201.121902460156;11501.712457188638 02:41:48 INFO - PROCESS | 28506 | __end_tp_report 02:41:48 INFO - PROCESS | 28506 | __start_cc_report 02:41:48 INFO - PROCESS | 28506 | _x_x_mozilla_cycle_collect,1001 02:41:48 INFO - PROCESS | 28506 | __end_cc_report 02:41:48 INFO - PROCESS | 28506 | __startTimestamp1464687708046__endTimestamp 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | ------- Summary: start ------- 02:41:48 INFO - PROCESS | 28506 | Number of tests: 6 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#0] dojo.html Cycles:165 Average:5487.77 Median:5683.89 stddev:639.17 (11.2%) stddev-sans-first:615.04 02:41:48 INFO - PROCESS | 28506 | Values: 3183.7 3200.1 3214.5 3238.9 3248.3 5322.4 5472.7 5525.5 5586.6 5600.2 5314.7 5342.5 5425.2 5524.4 5554.0 4811.4 4879.8 4907.8 4910.0 5040.0 4937.8 4985.8 4993.7 5004.7 5054.5 4930.6 4979.4 4985.3 5001.8 5023.9 4981.1 5000.0 5003.2 5013.2 5066.4 5012.8 5029.1 5049.2 5060.2 5087.1 5289.6 5351.0 5397.9 5439.6 5527.2 5961.2 6003.0 6009.2 6015.0 6029.2 6024.3 6049.5 6049.9 6056.2 6063.9 5423.1 5444.1 5570.1 5575.6 5643.9 6119.2 6137.6 6138.0 6139.6 6142.7 5901.1 5930.8 5931.0 5931.5 5932.5 5632.7 5675.5 5701.5 5719.2 5731.7 5742.4 5782.5 5784.6 5786.3 5790.0 5745.5 5752.6 5793.8 5796.7 5806.3 4452.3 4497.3 4507.4 4509.7 4510.9 3997.9 4004.3 4006.8 4026.9 4041.0 5487.3 5555.0 5623.0 5626.3 5633.3 5890.6 5910.6 5932.2 5936.0 5942.2 5546.8 5547.6 5548.2 5552.5 5555.5 5008.2 5040.4 5091.8 5100.5 5147.8 6109.3 6170.8 6176.1 6176.1 6178.3 5972.7 5978.7 5979.6 5980.2 6016.7 5951.2 6117.1 6122.0 6152.2 6164.6 5874.3 5919.2 5920.7 5923.1 5968.6 5965.6 6037.8 6046.2 6049.1 6050.6 5645.7 5729.4 5741.6 5746.0 5850.2 5797.8 5810.0 5813.3 5821.3 5823.1 5665.6 5670.0 5675.0 5681.3 5683.9 5714.7 5833.1 5905.9 5934.6 5948.3 5721.9 5752.5 5756.1 5768.5 5789.9 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#1] ext.html Cycles:180 Average:58936.79 Median:41959.98 stddev:114005.77 (271.7%) stddev-sans-first:114241.41 02:41:48 INFO - PROCESS | 28506 | Values: 587.1 605.3 612.5 616.7 623.8 30787.2 42931.6 42989.4 42994.6 43459.0 44958.0 46031.3 46048.0 46091.3 46285.8 8614.4 8836.5 8842.8 8850.0 8851.9 8562.3 8699.7 8701.9 8705.3 8709.9 8793.5 8805.2 8837.3 8841.4 8845.0 8726.1 8736.2 8751.7 8753.4 8760.9 8798.4 8879.8 8898.9 8901.9 8906.6 42073.4 42405.8 42416.6 42509.0 42637.8 3321.7 3415.2 3739.9 3882.3 4030.3 32121.8 32245.8 32460.4 32703.2 33072.7 4270.4 4331.7 4359.8 4430.5 4471.3 346279.0 346376.0 347093.0 347673.0 348721.0 57764.0 58157.0 58467.4 58481.4 58623.0 53155.7 53744.7 60059.7 60767.4 61098.7 12977.6 13258.4 15110.7 15170.8 15247.2 11914.8 11987.7 12009.1 12015.1 12028.5 16220.6 16262.8 16267.1 16267.2 16306.3 5151.8 5880.4 6013.8 6393.6 6544.2 964.5 1040.7 1099.3 1105.4 1123.5 32198.2 32241.5 32496.4 32544.0 32677.3 1082.3 1097.1 1126.2 1130.7 1172.4 16391.2 16711.4 16921.9 16923.3 17183.7 514665.0 518880.0 520427.0 523341.0 523718.0 58600.4 58608.4 58623.0 58747.1 58844.7 1283.2 1360.7 1369.1 1374.7 1383.1 30659.4 32095.8 32116.7 32253.5 33067.8 47555.3 47870.0 48013.8 48173.0 48199.3 401616.0 406615.0 406892.0 408569.0 409284.0 35033.8 39111.6 39552.6 40269.2 43916.6 48558.8 48583.8 48591.6 49165.5 49582.3 40034.4 40622.4 40641.6 40772.8 41327.0 40437.4 40783.8 41007.4 41262.6 41477.4 41804.8 41846.6 43605.8 44196.0 44229.6 33942.8 36571.0 36822.6 37354.0 37391.0 27116.3 27735.7 27870.9 28085.9 28259.4 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#2] jquery.html Cycles:180 Average:27989.93 Median:19049.74 stddev:78365.99 (411.4%) stddev-sans-first:78558.41 02:41:48 INFO - PROCESS | 28506 | Values: 380.2 387.4 390.6 394.6 413.4 14102.6 16423.4 18396.5 19858.7 19909.1 17565.4 17958.0 18385.1 18399.4 18987.9 5196.0 5325.2 5362.8 5379.5 5385.6 3928.7 5213.8 5307.6 5650.4 5922.8 5990.1 5993.1 5993.4 6004.3 6020.5 5817.4 5956.1 5991.9 6002.3 6031.5 5609.7 5660.0 5701.2 5728.1 5730.1 13506.4 13824.7 13856.9 13863.1 13865.1 2191.7 2215.1 2218.9 2241.7 2883.2 9614.2 10002.2 10108.6 10434.6 10489.9 1888.7 1928.9 1983.4 2029.0 2036.4 75795.0 76481.2 78128.6 79273.0 80740.8 10326.6 10408.9 10459.9 10498.3 10989.7 13424.8 13911.8 14446.9 14466.6 14468.9 6293.2 6550.2 7446.3 7913.4 7985.9 7543.4 7577.8 7610.8 7748.6 7751.4 4509.4 4531.1 4547.2 4554.8 4632.6 1800.6 1868.7 1930.6 1935.6 1976.9 960.8 963.9 968.7 972.0 1021.5 17596.8 17946.7 18150.9 18417.5 19051.3 959.2 970.6 979.6 986.6 1067.3 10126.4 10589.2 10614.8 10711.3 10734.1 463489.0 470459.0 474689.0 479580.0 484469.0 91309.0 92583.5 92794.5 93358.1 93948.0 1002.0 1013.9 1053.7 1069.5 1082.5 16329.6 16456.2 16579.5 16671.7 17615.3 32788.8 37719.2 39558.0 41548.2 44445.1 53621.5 58530.4 59130.6 59625.7 59673.7 8540.7 8674.2 8697.4 8822.9 9077.3 9830.3 13384.9 13776.4 13785.7 13895.4 11106.3 11882.9 12168.9 12173.6 12496.8 11328.2 11870.9 12013.1 12201.4 12470.6 6619.3 10611.6 12014.9 12567.8 12683.7 8701.5 8734.0 8756.7 8797.2 9014.1 11441.9 12095.3 12438.9 12465.3 12496.6 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#3] mootools.html Cycles:180 Average:5860.72 Median:4583.35 stddev:3493.92 (76.2%) stddev-sans-first:3486.61 02:41:48 INFO - PROCESS | 28506 | Values: 1259.1 1485.1 1485.7 1686.5 1863.3 8595.4 8987.6 9023.9 9159.4 9159.9 8734.0 9010.0 9015.5 9017.4 9030.9 2050.7 2258.1 2291.9 2314.2 2318.6 2313.5 2316.2 2321.3 2325.7 2328.3 2305.9 2319.5 2322.5 2322.7 2333.9 2003.6 2069.9 2072.6 2185.7 2249.6 2177.0 2203.0 2204.1 2209.6 2212.2 8840.1 8893.1 8908.6 8911.7 8926.4 5110.2 5232.9 5238.1 5240.7 5253.8 3149.1 3254.2 3282.3 3293.7 3301.6 1032.8 1049.2 1063.5 1110.9 1113.6 12969.6 12976.3 12977.5 12986.0 13030.3 4390.9 4577.6 4614.3 4629.5 4667.6 10732.7 10748.9 10760.6 10763.1 10777.4 5191.2 5191.7 5195.7 5196.1 5197.1 4197.3 4478.6 4563.1 4589.1 4678.1 3910.4 4034.4 4056.1 4084.5 4118.5 1279.8 1284.7 1292.2 1297.1 1297.7 783.5 884.7 893.1 915.6 932.1 5954.7 5989.1 6052.6 6159.3 6409.4 945.0 968.1 972.4 996.2 1002.9 3614.1 3744.9 3818.7 3832.5 3873.2 10957.5 11451.1 11568.4 11595.2 11605.3 11269.3 11296.9 11371.6 11406.1 11488.3 8507.3 8526.5 8676.3 8689.0 8705.6 5532.5 5631.8 5672.2 5674.7 5719.4 10584.6 10691.9 10704.4 10737.5 10748.7 10493.9 10792.1 10929.7 10944.6 10955.9 6910.8 7113.2 7299.2 7488.6 7636.4 8546.6 8774.1 8807.1 8817.4 8817.4 7694.8 7804.7 7814.6 7900.2 7994.3 7658.3 7744.4 7821.4 7951.0 7973.4 6648.2 6671.6 6687.6 6707.5 6722.1 4699.0 4777.5 4808.1 4847.1 4887.4 4855.0 4903.1 4975.4 4985.0 5029.9 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#4] prototype.html Cycles:180 Average:4614.75 Median:5196.26 stddev:1370.52 (26.4%) stddev-sans-first:1335.83 02:41:48 INFO - PROCESS | 28506 | Values: 315.3 317.6 319.5 322.5 326.3 5261.2 5275.9 5296.9 5302.7 5350.4 5176.1 5195.9 5196.6 5228.6 5248.8 3908.9 3983.2 4049.6 4051.0 4057.8 3956.9 4139.8 4154.2 4160.7 4161.9 4031.1 4062.4 4100.5 4110.7 4130.4 3897.9 3986.3 4042.9 4071.8 4089.8 3606.9 3620.4 3620.9 3623.7 3628.7 5051.6 5054.2 5090.6 5110.0 5123.6 4442.8 4694.3 4694.4 4728.4 4738.3 5471.0 5488.3 5502.0 5523.7 5533.8 3956.1 3993.8 3997.7 3997.8 4005.2 5324.9 5409.9 5782.3 5827.9 5895.7 3921.9 3970.4 3972.6 3976.0 3991.2 3982.5 3991.1 4004.1 4007.7 4029.3 4627.6 4633.4 4646.9 4669.9 4676.3 5285.8 5499.6 5521.9 5546.3 5573.8 1392.3 1393.4 1411.2 1418.8 1420.5 823.6 854.0 867.7 873.4 876.9 4683.5 4712.3 4718.0 4731.6 4740.3 5044.8 5079.7 5097.4 5133.9 5197.7 4823.7 4848.5 4852.6 4882.8 5047.7 3071.8 3074.3 3084.2 3091.3 3094.7 5956.3 5986.6 5988.3 5993.3 5999.7 5541.0 5834.4 5834.7 5843.7 5888.2 5644.6 5730.4 5895.4 5917.2 5949.6 5722.5 5754.6 5759.6 5765.5 5775.5 5548.2 5655.0 5658.6 5685.6 5699.4 5872.8 5873.1 5898.8 5904.3 5923.6 4065.3 4092.4 4094.9 4142.2 4143.0 5617.6 5741.0 5799.4 5826.2 5864.5 5539.8 5565.4 5582.4 5602.6 5607.2 5538.2 5560.8 5570.4 5571.2 5604.5 5212.9 5405.3 5452.4 5453.8 5471.1 5574.2 5577.7 5582.6 5611.5 5625.3 5353.7 5467.7 5475.3 5533.9 5536.7 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - PROCESS | 28506 | [#5] yui.html Cycles:180 Average:16148.02 Median:4627.53 stddev:19958.99 (431.3%) stddev-sans-first:19981.40 02:41:48 INFO - PROCESS | 28506 | Values: 729.8 772.1 776.3 783.0 806.0 14895.8 15066.1 15347.9 15396.0 15397.5 14198.0 14238.7 14251.0 14292.0 14312.4 687.7 795.6 809.4 821.8 826.9 811.0 817.5 819.8 820.1 821.4 870.2 871.4 872.6 873.2 873.5 703.9 825.5 850.7 851.3 866.1 621.2 621.3 621.4 621.4 622.1 12218.8 12224.6 12235.8 12261.8 12267.0 12820.5 13181.1 13314.2 13355.3 13383.0 11630.5 11872.8 11956.1 12201.4 12448.6 4302.4 4347.7 4354.5 4382.7 4537.3 59299.7 59904.4 60066.4 60069.0 60606.1 10540.6 10667.7 10671.7 10750.9 10963.2 17905.6 18376.6 18396.9 18986.3 19470.6 8209.3 8334.5 8437.4 8519.8 8737.1 4534.7 4630.6 4655.2 4658.5 4719.0 3224.4 3321.5 3322.2 3325.0 3414.1 594.5 663.2 667.2 671.1 687.4 633.5 706.4 706.7 710.2 715.2 9330.9 9670.6 9715.0 9793.8 9840.6 671.8 691.2 708.1 713.5 728.0 4333.1 4383.2 4538.9 4562.2 4624.4 71850.6 72446.0 73498.6 73550.0 73699.6 47017.3 60792.1 64541.7 65044.3 68426.3 58575.0 59004.7 59155.4 60425.4 60896.4 8540.3 8565.7 8629.1 8699.5 8766.7 40189.0 40248.4 40781.8 41007.6 41132.6 51057.5 54328.5 55059.7 55756.7 56143.0 11154.9 11245.9 11283.2 11585.5 11779.6 12697.4 12741.8 12890.8 13297.1 13407.5 12779.0 13126.9 13208.6 13228.9 13822.9 12861.2 13213.9 13287.3 13633.7 13692.7 13033.3 13144.5 13166.5 13181.4 13362.3 10451.4 10580.5 10662.7 10673.5 11156.3 10160.9 10500.4 11162.6 11201.1 11501.7 02:41:48 INFO - PROCESS | 28506 | -------- Summary: end -------- 02:41:48 INFO - PROCESS | 28506 | 02:41:48 INFO - TEST-INFO | 28506: exit 0 02:41:48 INFO - TEST-OK | dromaeo_css | took 1113849ms 02:41:48 INFO - TEST-START | kraken 02:41:48 INFO - operating with platform_type : linux_ 02:41:48 INFO - Initialising browser for kraken test... 02:41:48 INFO - TEST-INFO | started process 28686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHOxKU8/profile http://localhost:52647/getInfo.html) 02:41:53 INFO - PROCESS | 28686 | __metrics Screen width/height:1600/1200 02:41:53 INFO - PROCESS | 28686 | colorDepth:24 02:41:53 INFO - PROCESS | 28686 | Browser inner width/height: 1024/697 02:41:53 INFO - PROCESS | 28686 | __metrics 02:41:54 ERROR - PROCESS | 28686 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:41:54 INFO - TEST-INFO | 28686: exit 0 02:41:54 INFO - Browser initialized. 02:41:54 INFO - Running cycle 1/1 for kraken test... 02:41:54 INFO - TEST-INFO | started process 28771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHOxKU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:06 INFO - PROCESS | 28771 | RSS: Main: 155586560 02:42:06 INFO - PROCESS | 28771 | 02:42:09 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52647/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:10 INFO - PROCESS | 28771 | RSS: Main: 214278144 02:42:10 INFO - PROCESS | 28771 | 02:42:12 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52647/tests/kraken/driver.html?testName=audio-dft) 02:42:13 INFO - PROCESS | 28771 | RSS: Main: 198995968 02:42:13 INFO - PROCESS | 28771 | 02:42:16 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52647/tests/kraken/driver.html?testName=audio-fft) 02:42:17 INFO - PROCESS | 28771 | RSS: Main: 268730368 02:42:17 INFO - PROCESS | 28771 | 02:42:19 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52647/tests/kraken/driver.html?testName=audio-oscillator) 02:42:19 INFO - PROCESS | 28771 | RSS: Main: 179748864 02:42:19 INFO - PROCESS | 28771 | 02:42:21 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:22 INFO - PROCESS | 28771 | RSS: Main: 182767616 02:42:22 INFO - PROCESS | 28771 | 02:42:25 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52647/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:26 INFO - PROCESS | 28771 | RSS: Main: 218931200 02:42:26 INFO - PROCESS | 28771 | 02:42:29 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52647/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:30 INFO - PROCESS | 28771 | RSS: Main: 220332032 02:42:30 INFO - PROCESS | 28771 | 02:42:33 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52647/tests/kraken/driver.html?testName=json-parse-financial) 02:42:33 INFO - PROCESS | 28771 | RSS: Main: 220418048 02:42:33 INFO - PROCESS | 28771 | 02:42:35 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:35 INFO - PROCESS | 28771 | RSS: Main: 208912384 02:42:35 INFO - PROCESS | 28771 | 02:42:37 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:38 INFO - PROCESS | 28771 | RSS: Main: 210731008 02:42:38 INFO - PROCESS | 28771 | 02:42:40 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:40 INFO - PROCESS | 28771 | RSS: Main: 217296896 02:42:40 INFO - PROCESS | 28771 | 02:42:43 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:43 INFO - PROCESS | 28771 | RSS: Main: 221913088 02:42:43 INFO - PROCESS | 28771 | 02:42:46 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:47 INFO - PROCESS | 28771 | RSS: Main: 222949376 02:42:47 INFO - PROCESS | 28771 | 02:42:48 INFO - PROCESS | 28771 | Cycle 1(1): loaded http://localhost:52647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52647/tests/kraken/driver.html?testName=ai-astar) 02:42:49 INFO - PROCESS | 28771 | RSS: Main: 265437184 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | __start_tp_report 02:42:49 INFO - PROCESS | 28771 | _x_x_mozilla_page_load 02:42:49 INFO - PROCESS | 28771 | _x_x_mozilla_page_load_details 02:42:49 INFO - PROCESS | 28771 | |i|pagename|runs| 02:42:49 INFO - PROCESS | 28771 | |0;ai-astar;110;105;111;110;111;111;111;109;110;111 02:42:49 INFO - PROCESS | 28771 | |1;audio-beat-detection;160;133;126;181;126;126;151;124;167;124 02:42:49 INFO - PROCESS | 28771 | |2;audio-dft;162;162;164;163;160;159;160;162;161;160 02:42:49 INFO - PROCESS | 28771 | |3;audio-fft;74;74;74;116;75;75;75;74;116;75 02:42:49 INFO - PROCESS | 28771 | |4;audio-oscillator;83;83;110;84;83;83;126;82;83;131 02:42:49 INFO - PROCESS | 28771 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;116;117 02:42:49 INFO - PROCESS | 28771 | |6;imaging-darkroom;146;147;147;146;146;146;145;146;146;145 02:42:49 INFO - PROCESS | 28771 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;95 02:42:49 INFO - PROCESS | 28771 | |8;json-parse-financial;56;53;55;54;54;54;54;55;54;65 02:42:49 INFO - PROCESS | 28771 | |9;json-stringify-tinderbox;62;63;62;62;63;63;63;62;63;64 02:42:49 INFO - PROCESS | 28771 | |10;stanford-crypto-aes;79;79;86;79;80;80;80;81;109;80 02:42:49 INFO - PROCESS | 28771 | |11;stanford-crypto-ccm;119;120;126;125;128;127;120;124;129;123 02:42:49 INFO - PROCESS | 28771 | |12;stanford-crypto-pbkdf2;164;160;158;158;159;164;158;159;157;160 02:42:49 INFO - PROCESS | 28771 | |13;stanford-crypto-sha256-iterative;67;64;67;63;64;65;63;62;63;61 02:42:49 INFO - PROCESS | 28771 | __end_tp_report 02:42:49 INFO - PROCESS | 28771 | __start_cc_report 02:42:49 INFO - PROCESS | 28771 | _x_x_mozilla_cycle_collect,1651 02:42:49 INFO - PROCESS | 28771 | __end_cc_report 02:42:49 INFO - PROCESS | 28771 | __startTimestamp1464687769163__endTimestamp 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | ------- Summary: start ------- 02:42:49 INFO - PROCESS | 28771 | Number of tests: 14 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.85 (1.7%) stddev-sans-first:1.96 02:42:49 INFO - PROCESS | 28771 | Values: 110.0 105.0 111.0 110.0 111.0 111.0 111.0 109.0 110.0 111.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:142.00 stddev:21.21 (14.9%) stddev-sans-first:21.45 02:42:49 INFO - PROCESS | 28771 | Values: 160.0 133.0 126.0 181.0 126.0 126.0 151.0 124.0 167.0 124.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.64 02:42:49 INFO - PROCESS | 28771 | Values: 162.0 162.0 164.0 163.0 160.0 159.0 160.0 162.0 161.0 160.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.50 stddev:17.50 (23.5%) stddev-sans-first:18.27 02:42:49 INFO - PROCESS | 28771 | Values: 74.0 74.0 74.0 116.0 75.0 75.0 75.0 74.0 116.0 75.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.00 stddev:19.70 (23.7%) stddev-sans-first:20.42 02:42:49 INFO - PROCESS | 28771 | Values: 83.0 83.0 110.0 84.0 83.0 83.0 126.0 82.0 83.0 131.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:42:49 INFO - PROCESS | 28771 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:42:49 INFO - PROCESS | 28771 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:42:49 INFO - PROCESS | 28771 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.47 (6.4%) stddev-sans-first:3.67 02:42:49 INFO - PROCESS | 28771 | Values: 56.0 53.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 65.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 02:42:49 INFO - PROCESS | 28771 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 64.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.00 stddev:9.26 (11.6%) stddev-sans-first:9.69 02:42:49 INFO - PROCESS | 28771 | Values: 79.0 79.0 86.0 79.0 80.0 80.0 80.0 81.0 109.0 80.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:3.54 (2.8%) stddev-sans-first:3.24 02:42:49 INFO - PROCESS | 28771 | Values: 119.0 120.0 126.0 125.0 128.0 127.0 120.0 124.0 129.0 123.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.50 stddev:2.45 (1.5%) stddev-sans-first:2.05 02:42:49 INFO - PROCESS | 28771 | Values: 164.0 160.0 158.0 158.0 159.0 164.0 158.0 159.0 157.0 160.0 02:42:49 INFO - PROCESS | 28771 | 02:42:49 INFO - PROCESS | 28771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:1.74 02:42:49 INFO - PROCESS | 28771 | Values: 67.0 64.0 67.0 63.0 64.0 65.0 63.0 62.0 63.0 61.0 02:42:49 INFO - PROCESS | 28771 | -------- Summary: end -------- 02:42:49 INFO - PROCESS | 28771 | 02:42:50 INFO - TEST-INFO | 28771: exit 0 02:42:50 INFO - TEST-OK | kraken | took 61397ms 02:42:50 INFO - SUITE-END | took 1175s 02:42:50 INFO - Completed test suite (00:19:35) 02:42:50 INFO - javascript benchmark 02:42:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.697548732871, 3200.1039708881513, 3214.453542897708, 3238.886638967637, 3248.2529018325786, 5322.414534401213, 5472.699001554913, 5525.530329921957, 5586.608937374385, 5600.243967064445, 5314.681119132854, 5342.519173274404, 5425.213344065108, 5524.447555244474, 5553.972230138854, 4811.422629284482, 4879.756012199394, 4907.779149938261, 4910.042541704369, 5039.974800125994, 4937.80248790048, 4985.825496107637, 4993.700377977315, 5004.674696144757, 5054.494550544953, 4930.556249937505, 4979.377577802757, 4985.302057711923, 5001.774920128585, 5023.899522009576, 4981.053599816023, 4999.9500004999845, 5003.199488081926, 5013.222950442687, 5066.392032956032, 5012.8496145115705, 5029.094762942669, 5049.242613607951, 5060.190369540893, 5087.084324821531, 5289.576833853283, 5351.036813373591, 5397.946020539784, 5439.646422982533, 5527.170924361338, 5961.195238642815, 6002.969985150046, 6009.1587177795145, 6015.0, 6029.21620189377, 6024.277086749618, 6049.455549000611, 6049.879002419927, 6056.21269235001, 6063.9090413643835, 5423.105187644034, 5444.101723215665, 5570.136628822498, 5575.637583557096, 5643.887122257532, 6119.2350956130485, 6137.601055931439, 6137.96931015351, 6139.6009259398, 6142.662153581596, 5901.114832775118, 5930.7924222652, 5930.970345148246, 5931.466168044896, 5932.49573786233, 5632.690202038927, 5675.460831221028, 5701.543876489871, 5719.19931209631, 5731.742071606787, 5742.397048309951, 5782.537397008229, 5784.566157538202, 5786.276715410574, 5789.971050144806, 5745.511631511285, 5752.568557358215, 5793.797217097382, 5796.710164491758, 5806.332271788714, 4452.265376212888, 4497.325401189848, 4507.391502147234, 4509.729416235036, 4510.909781804346, 3997.9400308995387, 4004.3192657247755, 4006.757905049444, 4026.859059932947, 4041.0, 5487.286652735119, 5554.972225138929, 5622.95975244581, 5626.2967129108865, 5633.3240011198095, 5890.558208134407, 5910.586258961917, 5932.169496270526, 5936.0, 5942.197803296586, 5546.805861794898, 5547.639403438844, 5548.167774833807, 5552.52803511706, 5555.472230138131, 5008.223725322581, 5040.36995375578, 5091.770870310845, 5100.540951314325, 5147.845564633067, 6109.297430795426, 6170.753169873155, 6176.073588961602, 6176.135341052256, 6178.289496707846, 5972.671503067373, 5978.730957106854, 5979.5814292999075, 5980.19267398913, 6016.699165041818, 5951.226340575698, 6117.0824376342125, 6121.971262793429, 6152.16945712341, 6164.568480206522, 5874.265716785402, 5919.230500034968, 5920.674362909909, 5923.141144534105, 5968.552358573038, 5965.642061476326, 6037.849053773691, 6046.183765191643, 6049.062395328731, 6050.6369617823075, 5645.68948707825, 5729.427057294237, 5741.569382296261, 5746.0, 5850.23946886919, 5797.797077102281, 5810.041343178328, 5813.302403711582, 5821.330546987151, 5823.126531020381, 5665.575081868794, 5669.971650141723, 5675.035244008611, 5681.289838770153, 5683.8863222736145, 5714.714264286852, 5833.095870140135, 5905.91141132892, 5934.643921364732, 5948.256467941507, 5721.914171287351, 5752.539796816328, 5756.0502517084215, 5768.480836724715, 5789.91315130265], "value": 5443.991414771056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0929414055284, 605.2525131462643, 612.5344737999122, 616.6608365399035, 623.8128561431571, 30787.230319242, 42931.57068429315, 42989.35515967263, 42994.57005429941, 43459.0, 44958.0, 46031.309530356986, 46048.0, 46091.30863037057, 46285.76857115718, 8614.440061396004, 8836.469811811312, 8842.823143537125, 8849.95575022124, 8851.867221991675, 8562.272206862424, 8699.652013919436, 8701.869471957925, 8705.260052895512, 8709.912900871006, 8793.516356600385, 8805.20753132218, 8837.337199710015, 8841.425307355034, 8845.0, 8726.083761205076, 8736.21374076333, 8751.693690720795, 8753.431026983226, 8760.912390876074, 8798.384113112084, 8879.822403551892, 8898.911010889939, 8901.866472002925, 8906.55467226636, 42073.368899466535, 42405.78797106026, 42416.57583424188, 42509.0, 42637.78681106606, 3321.734261259118, 3415.1803567143706, 3739.8878033659034, 3882.301185786557, 4030.2544029354663, 32121.83939080313, 32245.838770805996, 32460.35079298401, 32703.18242043944, 33072.66927330744, 4270.359446083081, 4331.6534677225745, 4359.760213188273, 4430.490493593245, 4471.3293006049025, 346279.0, 346376.0, 347093.0, 347673.0, 348721.0, 57764.0, 58157.0, 58467.415325846196, 58481.41518584845, 58623.0, 53155.73422132865, 53744.731276343366, 60059.69970150121, 60767.39232607706, 61098.694506528074, 12977.610671679864, 13258.40337184829, 15110.697786044437, 15170.772438413433, 15247.23763811805, 11914.76170476603, 11987.700307492383, 12009.09931755122, 12015.098867584966, 12028.518859245707, 16220.59448513773, 16262.837371626369, 16267.105309208107, 16267.18664066792, 16306.266218020217, 5151.8196863109615, 5880.353161152269, 6013.819585412444, 6393.6483493408305, 6544.247411547638, 964.5273815830193, 1040.7294103532984, 1099.2580008494235, 1105.3588918427292, 1123.500042481088, 32198.19504512359, 32241.51637725436, 32496.350072998408, 32544.0, 32677.346453070804, 1082.312731415541, 1097.1223021582862, 1126.1666366888444, 1130.6608017594688, 1172.4255114993591, 16391.180440977903, 16711.41510047167, 16921.915390423215, 16923.323067077425, 17183.742243866353, 514665.0, 518880.0, 520427.0, 523341.0, 523718.0, 58600.41399586035, 58608.41391586029, 58623.0, 58747.118793218135, 58844.705776470844, 1283.1723538317733, 1360.673438374783, 1369.0621923982103, 1374.71131062476, 1383.0733408616252, 30659.386812264074, 32095.839520802245, 32116.67883321137, 32253.51619725753, 33067.83466082654, 47555.28667070066, 47870.0, 48013.75993120012, 48173.0, 48199.277010845566, 401616.0, 406615.0, 406892.0, 408569.0, 409284.0, 35033.82483087568, 39111.6088839108, 39552.60447395489, 40269.1946161081, 43916.56083439253, 48558.75720621374, 48583.75708121437, 48591.59858809991, 49165.508344916096, 49582.25626615532, 40034.39948400835, 40622.39066414065, 40641.59358406378, 40772.79613601913, 41327.0, 40437.393439099025, 40783.796081019405, 41007.38488922609, 41262.58737412708, 41477.37783933183, 41804.790976044926, 41846.58153418548, 43605.78197108994, 44196.0, 44229.55770442254, 33942.8302858494, 36571.0, 36822.63177368192, 37354.0, 37391.0, 27116.32209194786, 27735.722642773315, 27870.86064569664, 28085.914085914086, 28259.434811303247], "value": 19940.669961504434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.23952095808386, 387.3504356478898, 390.58597886240585, 394.63496265953995, 413.4459823836059, 14102.647433814134, 16423.42518011867, 18396.54008649783, 19858.702119468202, 19909.104090315952, 17565.385211517598, 17958.0, 18385.08074596268, 18399.356022539214, 18987.905060474714, 5195.974020129904, 5325.227841962913, 5362.758675859595, 5379.542738867201, 5385.596080293974, 3928.705347098965, 5213.817516386927, 5307.575393968474, 5650.350209725872, 5922.822315330525, 5990.131430942511, 5993.101034844764, 5993.430624090704, 6004.3395226525045, 6020.548458865603, 5817.389174136697, 5956.106584012389, 5991.940080599182, 6002.279726432812, 6031.517478601701, 5609.719514024323, 5659.971700141514, 5701.230333904911, 5728.054870946289, 5730.083186690152, 13506.392212350369, 13824.654383640389, 13856.93071534646, 13863.098898571661, 13865.09876858001, 2191.6712493126, 2215.0586000949693, 2218.9334319970267, 2241.68616393705, 2883.2215301868587, 9614.23086153113, 10002.199824014135, 10108.595656173744, 10434.582616695323, 10489.947550262275, 1888.650599639071, 1928.9264041155673, 1983.3950645053253, 2028.98985505073, 2036.4094412620323, 75795.0, 76481.23518764852, 78128.60935695285, 79273.0, 80740.78888816731, 10326.638567650096, 10408.895911040943, 10459.895401046044, 10498.317609355367, 10989.725256868642, 13424.798628020588, 13911.79132313016, 14446.927765361106, 14466.566003019716, 14468.927655361656, 6293.150424692608, 6550.246721627074, 7446.292602202782, 7913.366930645535, 7985.880211796712, 7543.358814500719, 7577.772666820004, 7610.847783044308, 7748.6125693715085, 7751.379889608817, 4509.436320459942, 4531.071130418256, 4547.15877562652, 4554.817807287672, 4632.559906808848, 1800.558863078528, 1868.7010078387393, 1930.6042261336393, 1935.6032013437211, 1976.901154942276, 960.841461158901, 963.9325247232766, 968.651285537206, 971.9514024298757, 1021.4973315377207, 17596.824031759774, 17946.730799038025, 18150.909245453953, 18417.539561510803, 19051.333203337817, 959.2182371367313, 970.5583959298502, 979.6179489998906, 986.6250824686716, 1067.2849191042021, 10126.443045632413, 10589.241664677324, 10614.787704245871, 10711.25021248505, 10734.141268698486, 463489.0, 470459.0, 474689.0, 479580.0, 484469.0, 91309.0, 92583.53708231551, 92794.53602731944, 93358.06641933629, 93948.0, 1001.9699409017741, 1013.8834034086175, 1053.6628278950816, 1069.534752382716, 1082.4912291223113, 16329.591760206089, 16456.177191140636, 16579.50261492157, 16671.666566668355, 17615.295388184328, 32788.83605581957, 37719.24561508809, 39558.0, 41548.16903661849, 44445.11109777722, 53621.46378536321, 58530.414695852494, 59130.56520760874, 59625.7018714921, 59673.7016314933, 8540.658373664985, 8674.219320261207, 8697.39118261741, 8822.911770882209, 9077.31920106008, 9830.311878168459, 13384.93307533456, 13776.448942042607, 13785.724285514032, 13895.444182232597, 11106.278091924, 11882.940585297018, 12168.93915530452, 12173.634790956285, 12496.750064998467, 11328.207025508465, 11870.940645296718, 12013.099017573542, 12201.389930503261, 12470.563530276397, 6619.3049729779605, 10611.575536978435, 12014.918657320883, 12567.811482827949, 12683.682907927006, 8701.52141632191, 8733.956330218309, 8756.737297881074, 8797.208251257418, 9014.098590140933, 11441.885581144415, 12095.334756588472, 12438.937805310916, 12465.252084874937, 12496.562620308245], "value": 8918.391489978687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.124908188808, 1485.1237769715867, 1485.6805786755845, 1686.4771920704582, 1863.30126202674, 8595.398322117446, 8987.550622468874, 9023.909760902388, 9159.35884488086, 9159.908400915989, 8734.0, 9010.0, 9015.504147271897, 9017.413868098569, 9030.909690903089, 2050.7026481160224, 2258.1306197114063, 2291.873946932914, 2314.2131675230416, 2318.6406107053435, 2313.467902382453, 2316.177756896303, 2321.257197696738, 2325.732540757809, 2328.2898715891647, 2305.873176975266, 2319.5476882008015, 2322.512272422793, 2322.7444981052154, 2333.8599684018927, 2003.649361361763, 2069.8758074515426, 2072.5958438104576, 2185.672149177636, 2249.5613355395703, 2176.9564608707738, 2203.0, 2204.1183526589334, 2209.591225623265, 2212.15937943582, 8840.071792461764, 8893.11068893112, 8908.643654253887, 8911.688090916852, 8926.419782714103, 5110.182370820688, 5232.92150617741, 5238.135707608279, 5240.68555886648, 5253.763580638881, 3149.086764838194, 3254.1539199807985, 3282.2614911644687, 3293.7200337971303, 3301.6203136639356, 1032.8295831187845, 1049.2235745548317, 1063.5479921033607, 1110.8946598134826, 1113.6325012745774, 12969.610911672571, 12976.286304253263, 12977.545785897542, 12986.0, 13030.348482575833, 4390.868273951786, 4577.5880170784785, 4614.2617181250835, 4629.4676112247525, 4667.579917807414, 10732.73168170802, 10748.946255268673, 10760.56957721698, 10763.13894888407, 10777.35335879834, 5191.195364718475, 5191.740412979336, 5195.68825870449, 5196.1166601677805, 5197.0905091609575, 4197.349410841324, 4478.641708663299, 4563.1101935123, 4589.1051245007575, 4678.087772884255, 3910.393888947218, 4034.4150098236178, 4056.1076563156057, 4084.4690190275073, 4118.546959834416, 1279.8080287956882, 1284.678830292427, 1292.1665525735848, 1297.0985165310208, 1297.6690943809267, 783.4868161354322, 884.6859364925488, 893.1247377569888, 915.6154415145655, 932.1424289653535, 5954.732037058343, 5989.071693887455, 6052.606580572248, 6159.260888693296, 6409.391107844747, 945.026622578745, 968.1431932739576, 972.4359871274785, 996.1731762636994, 1002.8796544414716, 3614.1145419371896, 3744.9063773405883, 3818.6563209311294, 3832.5209348831395, 3873.2447172801035, 10957.50691218897, 11451.083913286917, 11568.421578921021, 11595.188336816342, 11605.30368177912, 11269.267497612629, 11296.943515282372, 11371.601993930173, 11406.08751299894, 11488.25326353801, 8507.319414446829, 8526.488410695378, 8676.349273804364, 8688.956555217184, 8705.564721763887, 5532.529734972572, 5631.831045068655, 5672.234248376416, 5674.659520428788, 5719.399463056486, 10584.576616935236, 10691.8930810694, 10704.411257380918, 10737.46312684347, 10748.677539673823, 10493.9475302623, 10792.136629069813, 10929.672109836718, 10944.616938407436, 10955.945220273848, 6910.7581234656545, 7113.181984071898, 7299.248180436551, 7488.588127653032, 7636.389088872988, 8546.615402307036, 8774.078721734126, 8807.119288071142, 8817.38278320537, 8817.426867253607, 7694.846103077795, 7804.726834560764, 7814.609269536614, 7900.249476299742, 7994.320482759031, 7658.349040331635, 7744.419168562267, 7821.374290056896, 7951.0, 7973.44185906981, 6648.16897887764, 6671.5997040177745, 6687.598744075371, 6707.5304728668525, 6722.058911752456, 4698.953010469988, 4777.522247775195, 4808.06242782654, 4847.103285892122, 4887.413510378778, 4855.0, 4903.092927808367, 4975.402951645681, 4984.975075124601, 5029.924551131663], "value": 4614.909709599878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2921690804145, 317.5522513256309, 319.4648962986999, 322.49851480947126, 326.3440484625902, 5261.210818377241, 5275.8944821103605, 5296.894062118756, 5302.681839089657, 5350.35795704516, 5176.0683077046115, 5195.9348333591615, 5196.58427325814, 5228.594846370674, 5248.790048398059, 3908.902277443058, 3983.243183795084, 4049.6152865477734, 4051.0, 4057.7768222747736, 3956.9208615827665, 4139.772312522825, 4154.231467178566, 4160.7087503874745, 4161.895952601179, 4031.093004074089, 4062.3500239961613, 4100.528439229482, 4110.671146308288, 4130.401091841682, 3897.8830635080994, 3986.2824691555506, 4042.919141617151, 4071.7760523171064, 4089.7546147231114, 3606.9278614427826, 3620.4026335654585, 3620.873269435557, 3623.7282203834816, 3628.6734193922675, 5051.621128415383, 5054.241863720435, 5090.643654944119, 5110.003549307887, 5123.590112790967, 4442.822287108512, 4694.319323698045, 4694.366260554815, 4728.40894888139, 4738.289256611536, 5471.003083874397, 5488.298627425511, 5502.0, 5523.696196709179, 5533.810230800357, 3956.149427873021, 3993.8402463901407, 3997.72015958883, 3997.8001099944886, 4005.198960207941, 5324.92012619811, 5409.890972350659, 5782.277215348082, 5827.854303642401, 5895.734691938873, 3921.9410759095454, 3970.404439334123, 3972.6424621784176, 3975.980120099381, 3991.201759648082, 3982.542007669097, 3991.1419044904906, 4004.139110091286, 4007.699422543321, 4029.315016447211, 4627.583517483443, 4633.4208223972, 4646.907061858744, 4669.929951050737, 4676.321933319649, 5285.810692594136, 5499.642523235977, 5521.861953451196, 5546.252930326934, 5573.777048918079, 1392.2527228328383, 1393.4356585582855, 1411.2167746900363, 1418.7871819227198, 1420.5383250443647, 823.5957692134896, 853.9658413663508, 867.7093173786726, 873.3711727556276, 876.8903887014123, 4683.461401938753, 4712.31671407644, 4717.976410117927, 4731.597814185764, 4740.336352910595, 5044.798208071636, 5079.704675307847, 5097.439281679012, 5133.897322053538, 5197.714125723046, 4823.686460380064, 4848.539388758062, 4852.56326930578, 4882.829100981519, 5047.697138171721, 3071.8497052063644, 3074.308280636839, 3084.1981084918084, 3091.27355071558, 3094.675059118805, 5956.285245770535, 5986.5809393342915, 5988.28140623128, 5993.31076926159, 5999.700014999233, 5540.972295138498, 5834.445727655866, 5834.679092649945, 5843.707814609253, 5888.205092312569, 5644.604877658607, 5730.398308177581, 5895.35151133375, 5917.201177841109, 5949.6430214187285, 5722.456366645162, 5754.625949313281, 5759.596828221985, 5765.481106700249, 5775.5090817281, 5548.195511650869, 5655.0, 5658.575606829422, 5685.573581981285, 5699.401562835843, 5872.766718988889, 5873.091245345195, 5898.820235952912, 5904.291485021825, 5923.585349025527, 4065.329220678673, 4092.3656833190903, 4094.877153685394, 4142.212979533879, 4142.979285103555, 5617.606767526234, 5741.0, 5799.449052340021, 5826.184334193132, 5864.472197502245, 5539.806106786243, 5565.3599836019375, 5582.3859375467855, 5602.607817452739, 5607.158926161109, 5538.169274608841, 5560.805371811967, 5570.359408668055, 5571.247881535941, 5604.523615492729, 5212.869678258074, 5405.297311349499, 5452.400235974119, 5453.7818487260065, 5471.097268950579, 5574.191742197439, 5577.693226872399, 5582.637128586792, 5611.494965453129, 5625.296837895263, 5353.741870660314, 5467.6719396836315, 5475.342958844964, 5533.916991245215, 5536.667799932017], "value": 4171.669034215051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.7591794707747, 772.112071118214, 776.2703059124426, 783.0368646564725, 805.9798505037376, 14895.776563351545, 15066.09603423794, 15347.92326038371, 15396.0, 15397.538073857788, 14198.0, 14238.71522569548, 14251.0, 14292.0, 14312.35594398252, 687.7317846040023, 795.6379847169553, 809.3646487507308, 821.765796747927, 826.8883700700419, 810.9837803243931, 817.5217497763815, 819.7950512371907, 820.1060843680417, 821.3962737388015, 870.1776820904248, 871.4422769427572, 872.5637181409295, 873.1704880363649, 873.480279233858, 703.9366457018867, 825.4881973176639, 850.685246458808, 851.2806678356778, 866.1122349591656, 621.2327775197673, 621.3258614403378, 621.4003486635419, 621.4375989729302, 622.0917460507665, 12218.75562488754, 12224.633261002095, 12235.816462753066, 12261.816072758917, 12267.0, 12820.487180512768, 13181.143225690395, 13314.201147931155, 13355.332233388292, 13383.0, 11630.476628551736, 11872.841459894746, 11956.065901148277, 12201.38993050344, 12448.62654120378, 4302.376155457472, 4347.673924455678, 4354.4992325882295, 4382.715123516961, 4537.274036154199, 59299.70350148265, 59904.40095599076, 60066.399336006514, 60069.0, 60606.09090863597, 10540.57837686484, 10667.733306667395, 10671.679849604525, 10750.946245268724, 10963.177761667906, 17905.552361191076, 18376.632467350577, 18396.908015459838, 18986.335478258196, 19470.610587788164, 8209.302209312156, 8334.458260213067, 8437.367197460215, 8519.778944130812, 8737.126287371339, 4534.682572219913, 4630.629549636021, 4655.162070827284, 4658.464276608166, 4718.976405117953, 3224.3712476066944, 3321.4685650295837, 3322.2192784695576, 3325.0357396354784, 3414.0781988863364, 594.5303210463771, 663.2074670768482, 667.172705844749, 671.050463594009, 687.4431710314661, 633.4900405173787, 706.3501578547748, 706.6890568149997, 710.1797423975316, 715.1668306423063, 9330.90669093314, 9670.56482458291, 9714.951425242829, 9793.755156121011, 9840.606375745034, 671.7706596927611, 691.180950573572, 708.0724251230904, 713.50411464032, 728.0426239495047, 4333.133373325348, 4383.232934236496, 4538.931916021263, 4562.156001139733, 4624.427694583857, 71850.64074679594, 72446.0, 73498.63250683712, 73550.0, 73699.63150184214, 47017.29474057892, 60792.08811867826, 64541.67729161418, 65044.34955650478, 68426.315736843, 58575.0, 59004.704976474844, 59155.40844591585, 60425.39574604286, 60896.39103608996, 8540.308033855885, 8565.743027709179, 8629.09394513567, 8699.478031318142, 8766.736997890073, 40189.0, 40248.396274055325, 40781.79609101936, 41007.58992410157, 41132.58867411407, 51057.489425105276, 54328.45671543234, 55059.72470137624, 55756.72121639366, 56143.0, 11154.888203011296, 11245.943770281423, 11283.210175287979, 11585.536578536765, 11779.646610601696, 12697.4286157125, 12741.8088728671, 12890.806637900252, 13297.069205155547, 13407.530736424178, 12779.04157188196, 13126.934365328494, 13208.603741887759, 13228.867711323148, 13822.93088534551, 12861.164024338388, 13213.867861321649, 13287.335633218107, 13633.659158520719, 13692.726145477234, 13033.283169425393, 13144.518877288649, 13166.535264118998, 13181.406836692564, 13362.331883405985, 10451.372917624967, 10580.4709764513, 10662.697540606981, 10673.519691613741, 11156.274842135235, 10160.898391015995, 10500.369977801356, 11162.553497859995, 11201.121902460156, 11501.712457188638], "value": 6929.470992677174, "unit": "score"}], "name": "dromaeo_css", "value": 7109.846832363151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 111.0, 111.0, 111.0, 109.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 126.0, 181.0, 126.0, 126.0, 151.0, 124.0, 167.0, 124.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 160.0, 159.0, 160.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 116.0, 75.0, 75.0, 75.0, 74.0, 116.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 84.0, 83.0, 83.0, 126.0, 82.0, 83.0, 131.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 65.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 86.0, 79.0, 80.0, 80.0, 80.0, 81.0, 109.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 126.0, 125.0, 128.0, 127.0, 120.0, 124.0, 129.0, 123.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 158.0, 158.0, 159.0, 164.0, 158.0, 159.0, 157.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 67.0, 63.0, 64.0, 65.0, 63.0, 62.0, 63.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1497.2, "alertThreshold": 2.0}]} 02:42:50 INFO - Return code: 0 02:42:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:42:50 ERROR - # TBPL SUCCESS # 02:42:50 INFO - Running post-action listener: _resource_record_post_action 02:42:50 INFO - ##### 02:42:50 INFO - ##### Finished run-tests step (success) 02:42:50 INFO - ##### 02:42:50 INFO - Running post-run listener: _resource_record_post_run 02:42:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538177536; Read time: 16; Write time: 401604 02:42:50 INFO - TinderboxPrint: CPU usage
13.1% 02:42:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:42:50 INFO - TinderboxPrint: I/O write bytes / time
538,177,536 / 401,604 02:42:50 INFO - TinderboxPrint: CPU idle
8,269.9 (86.8%) 02:42:50 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 02:42:50 INFO - TinderboxPrint: Swap in / out
0 / 0 02:42:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247451648; Read time: 0; Write time: 238804 02:42:50 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290725888; Read time: 16; Write time: 162800 02:42:51 INFO - Running post-run listener: _upload_blobber_files 02:42:51 INFO - Blob upload gear active. 02:42:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:51 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 02:42:51 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:51 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:42:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:52 INFO - (blobuploader) - INFO - Done attempting. 02:42:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:55 INFO - (blobuploader) - INFO - Done attempting. 02:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:56 INFO - (blobuploader) - INFO - Done attempting. 02:42:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:42:56 INFO - Return code: 0 02:42:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:42:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:42:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d65cf5b251a4a181c73870133ac7c5e696d1a9cfe44eea5e0d5ce3357935e8c4f4f8037c6dbc99b667a3217f087de3e24dd84af52b91368cb7d2729e0dcacfb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b8a85e4d4d610ef787c61784b5662f1486117bc431139aad8f1016797fbe5143a6dadc3280e26949d32d48468b148a7c11dba2edec36faa436f2b69d359bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/261c282b9dbf607f7acc948402400b7a29c48e74417250a13ecc73facfa975b2b9ff1adda981de8fc54a66ccb8ac2d4942c36b8d53c6701d7f4990d04d928429"} 02:42:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:42:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:42:56 INFO - Contents: 02:42:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d65cf5b251a4a181c73870133ac7c5e696d1a9cfe44eea5e0d5ce3357935e8c4f4f8037c6dbc99b667a3217f087de3e24dd84af52b91368cb7d2729e0dcacfb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b8a85e4d4d610ef787c61784b5662f1486117bc431139aad8f1016797fbe5143a6dadc3280e26949d32d48468b148a7c11dba2edec36faa436f2b69d359bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/261c282b9dbf607f7acc948402400b7a29c48e74417250a13ecc73facfa975b2b9ff1adda981de8fc54a66ccb8ac2d4942c36b8d53c6701d7f4990d04d928429"} 02:42:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:42:56 INFO - Copying logs to upload dir... 02:42:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:42:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.167176 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-31 02:42:55.994086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:42:55.997892) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 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/sha512/d65cf5b251a4a181c73870133ac7c5e696d1a9cfe44eea5e0d5ce3357935e8c4f4f8037c6dbc99b667a3217f087de3e24dd84af52b91368cb7d2729e0dcacfb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b8a85e4d4d610ef787c61784b5662f1486117bc431139aad8f1016797fbe5143a6dadc3280e26949d32d48468b148a7c11dba2edec36faa436f2b69d359bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/261c282b9dbf607f7acc948402400b7a29c48e74417250a13ecc73facfa975b2b9ff1adda981de8fc54a66ccb8ac2d4942c36b8d53c6701d7f4990d04d928429"} build_url:https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/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/sha512/d65cf5b251a4a181c73870133ac7c5e696d1a9cfe44eea5e0d5ce3357935e8c4f4f8037c6dbc99b667a3217f087de3e24dd84af52b91368cb7d2729e0dcacfb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b8a85e4d4d610ef787c61784b5662f1486117bc431139aad8f1016797fbe5143a6dadc3280e26949d32d48468b148a7c11dba2edec36faa436f2b69d359bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/261c282b9dbf607f7acc948402400b7a29c48e74417250a13ecc73facfa975b2b9ff1adda981de8fc54a66ccb8ac2d4942c36b8d53c6701d7f4990d04d928429"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:42:56.024056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:42:56.024399) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464683477.385467-1611402388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:42:56.108536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:42:56.108859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:42:56.109150) ========= ========= Total master_lag: 0.18 =========