builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1464687648.87 results: success (0) buildid: 20160530234442 builduid: 4587975f5a5b44a8a822f4e4397f23c9 revision: dc4d7f68030e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:48.872771) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:48.873288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:48.873627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:48.900160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:48.900465) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 02:40:49-- 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% 40.7M=0s 2016-05-31 02:40:49 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108337 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.040368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.040710) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015016 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.100029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.100384) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 02:40:49,349 Setting DEBUG logging. 2016-05-31 02:40:49,349 attempt 1/10 2016-05-31 02:40:49,349 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:40:49,636 unpacking tar archive at: fx-team-dc4d7f68030e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637529 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.751488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.751841) ========= script_repo_revision: dc4d7f68030e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.752278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.752597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:40:49.763614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-31 02:40:49.764010) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:40:50 INFO - MultiFileLogger online at 20160531 02:40:50 in /builds/slave/test 02:40:50 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:40:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:40:50 INFO - {'append_to_log': False, 02:40:50 INFO - 'base_work_dir': '/builds/slave/test', 02:40:50 INFO - 'blob_upload_branch': 'Fx-Team', 02:40:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:40:50 INFO - 'branch': 'Fx-Team', 02:40:50 INFO - 'buildbot_json_path': 'buildprops.json', 02:40:50 INFO - 'config_files': ('talos/linux_config.py',), 02:40:50 INFO - 'default_actions': ('clobber', 02:40:50 INFO - 'read-buildbot-config', 02:40:50 INFO - 'download-and-extract', 02:40:50 INFO - 'populate-webroot', 02:40:50 INFO - 'create-virtualenv', 02:40:50 INFO - 'install', 02:40:50 INFO - 'run-tests'), 02:40:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:40:50 INFO - 'download_minidump_stackwalk': True, 02:40:50 INFO - 'download_symbols': 'ondemand', 02:40:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:40:50 INFO - 'tooltool.py': '/tools/tooltool.py', 02:40:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:40:50 INFO - '/tools/misc-python/virtualenv.py')}, 02:40:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:40:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:40:50 INFO - 'installer_path': 'installer.exe', 02:40:50 INFO - 'log_level': 'info', 02:40:50 INFO - 'log_name': 'talos', 02:40:50 INFO - 'log_to_console': True, 02:40:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:40:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:40:50 INFO - 'opt_config_files': (), 02:40:50 INFO - 'pip_index': False, 02:40:50 INFO - 'sps_profile': False, 02:40:50 INFO - 'sps_profile_interval': 0, 02:40:50 INFO - 'suite': 'dromaeojs', 02:40:50 INFO - 'system_bits': '32', 02:40:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:40:50 INFO - 'title': 'talos-linux64-ix-042', 02:40:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:40:50 INFO - 'use_talos_json': True, 02:40:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:40:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:40:50 INFO - 'work_dir': 'build'} 02:40:50 INFO - ##### 02:40:50 INFO - ##### Running clobber step. 02:40:50 INFO - ##### 02:40:50 INFO - Running pre-action listener: _resource_record_pre_action 02:40:50 INFO - Running main action method: clobber 02:40:50 INFO - rmtree: /builds/slave/test/build 02:40:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:40:51 INFO - Running post-action listener: _resource_record_post_action 02:40:51 INFO - ##### 02:40:51 INFO - ##### Finished clobber step (success) 02:40:51 INFO - ##### 02:40:51 INFO - ##### 02:40:51 INFO - ##### Running read-buildbot-config step. 02:40:51 INFO - ##### 02:40:51 INFO - Running pre-action listener: _resource_record_pre_action 02:40:51 INFO - Running main action method: read_buildbot_config 02:40:51 INFO - Using buildbot properties: 02:40:51 INFO - { 02:40:51 INFO - "project": "", 02:40:51 INFO - "product": "firefox", 02:40:51 INFO - "script_repo_revision": "production", 02:40:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:40:51 INFO - "repository": "", 02:40:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:40:51 INFO - "buildid": "20160530234442", 02:40:51 INFO - "pgo_build": "True", 02:40:51 INFO - "basedir": "/builds/slave/test", 02:40:51 INFO - "buildnumber": 1205, 02:40:51 INFO - "slavename": "talos-linux64-ix-042", 02:40:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:40:51 INFO - "platform": "ubuntu64_hw", 02:40:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:40:51 INFO - "branch": "fx-team", 02:40:51 INFO - "repo_path": "integration/fx-team", 02:40:51 INFO - "revision": "dc4d7f68030e", 02:40:51 INFO - "stage_platform": "linux64-pgo", 02:40:51 INFO - "builduid": "4587975f5a5b44a8a822f4e4397f23c9", 02:40:51 INFO - "slavebuilddir": "test" 02:40:51 INFO - } 02:40:51 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:40:51 INFO - Running post-action listener: _resource_record_post_action 02:40:51 INFO - ##### 02:40:51 INFO - ##### Finished read-buildbot-config step (success) 02:40:51 INFO - ##### 02:40:51 INFO - ##### 02:40:51 INFO - ##### Running download-and-extract step. 02:40:51 INFO - ##### 02:40:51 INFO - Running pre-action listener: _resource_record_pre_action 02:40:51 INFO - Running main action method: download_and_extract 02:40:51 INFO - mkdir: /builds/slave/test/build/tests 02:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:51 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:40:51 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:40:51 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:40:51 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:40:51 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:40:54 INFO - Downloaded 1361 bytes. 02:40:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:40:54 INFO - Using the following test package requirements: 02:40:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:40:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:40:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'jsshell-linux-x86_64.zip'], 02:40:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:40:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:40:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:40:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:40:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:40:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:41:01 INFO - Downloaded 24410442 bytes. 02:41:01 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:41:01 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:41:02 INFO - Return code: 0 02:41:02 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:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:03 INFO - Downloaded 24410442 bytes. 02:41:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:41:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:41:05 INFO - Return code: 0 02:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:06 INFO - Downloaded 10834055 bytes. 02:41:06 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:41:06 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:41:06 INFO - Return code: 0 02:41:06 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:41:06 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:41:06 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:41:06 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:41:06 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:41:06 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:41:07 INFO - Downloaded 58942948 bytes. 02:41:07 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:41:07 INFO - mkdir: /builds/slave/test/properties 02:41:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:07 INFO - Contents: 02:41:07 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:41:08 INFO - Running post-action listener: _resource_record_post_action 02:41:08 INFO - Running post-action listener: set_extra_try_arguments 02:41:08 INFO - ##### 02:41:08 INFO - ##### Finished download-and-extract step (success) 02:41:08 INFO - ##### 02:41:08 INFO - ##### 02:41:08 INFO - ##### Running populate-webroot step. 02:41:08 INFO - ##### 02:41:08 INFO - Running pre-action listener: _resource_record_pre_action 02:41:08 INFO - Running main action method: populate_webroot 02:41:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:08 INFO - '--tppagecycles', 02:41:08 INFO - '7'], 02:41:08 INFO - 'tests': ['tsvgm']}}, 02:41:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['damp', 'tps']}, 02:41:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'tests': ['damp', 'tps']}, 02:41:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['dromaeo_dom']}, 02:41:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['a11yr', 02:41:08 INFO - 'ts_paint', 02:41:08 INFO - 'tpaint', 02:41:08 INFO - 'sessionrestore', 02:41:08 INFO - 'sessionrestore_no_auto_restore', 02:41:08 INFO - 'tabpaint']}, 02:41:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['tsvgx', 02:41:08 INFO - 'tsvgr_opacity', 02:41:08 INFO - 'tart', 02:41:08 INFO - 'tscrollx', 02:41:08 INFO - 'cart']}, 02:41:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:08 INFO - 'tsvgr_opacity', 02:41:08 INFO - 'tart', 02:41:08 INFO - 'tscrollx', 02:41:08 INFO - 'cart']}, 02:41:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'talos_options': ['--disable-e10s'], 02:41:08 INFO - 'tests': ['tp5o']}, 02:41:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'tests': ['tp5o']}, 02:41:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'talos_options': ['--disable-e10s', 02:41:08 INFO - '--xperf_path', 02:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:08 INFO - 'tests': ['tp5n']}, 02:41:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:08 INFO - 'talos_options': ['--xperf_path', 02:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:08 INFO - 'tests': ['tp5n']}}, 02:41:08 INFO - 'talos.zip': {'path': '', 02:41:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:08 INFO - Running post-action listener: _resource_record_post_action 02:41:08 INFO - ##### 02:41:08 INFO - ##### Finished populate-webroot step (success) 02:41:08 INFO - ##### 02:41:08 INFO - ##### 02:41:08 INFO - ##### Running create-virtualenv step. 02:41:08 INFO - ##### 02:41:08 INFO - Running pre-action listener: _resource_record_pre_action 02:41:08 INFO - Running main action method: create_virtualenv 02:41:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:08 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:41:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:08 INFO - Using real prefix '/usr' 02:41:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:11 INFO - Installing pip.................done. 02:41:11 INFO - Return code: 0 02:41:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:11 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:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:11 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:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:11 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:11 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:41:11 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:41:11 INFO - Using env: {'DISPLAY': ':0', 02:41:11 INFO - 'HOME': '/home/cltbld', 02:41:11 INFO - 'LANG': 'en_US.UTF-8', 02:41:11 INFO - 'LANGUAGE': 'en_US:en', 02:41:11 INFO - 'LOGNAME': 'cltbld', 02:41:11 INFO - 'MAIL': '/var/mail/cltbld', 02:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:11 INFO - 'MOZ_NO_REMOTE': '1', 02:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:11 INFO - 'NO_EM_RESTART': '1', 02:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:11 INFO - 'PWD': '/builds/slave/test', 02:41:11 INFO - 'SHELL': '/bin/bash', 02:41:11 INFO - 'SHLVL': '1', 02:41:11 INFO - 'TERM': 'linux', 02:41:11 INFO - 'TMOUT': '86400', 02:41:11 INFO - 'USER': 'cltbld', 02:41:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:11 INFO - '_': '/tools/buildbot/bin/python'} 02:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:11 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:41:11 INFO - Cleaning up... 02:41:11 INFO - Return code: 0 02:41:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:11 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:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:11 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:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:11 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:11 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:41:11 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:41:11 INFO - Using env: {'DISPLAY': ':0', 02:41:11 INFO - 'HOME': '/home/cltbld', 02:41:11 INFO - 'LANG': 'en_US.UTF-8', 02:41:11 INFO - 'LANGUAGE': 'en_US:en', 02:41:11 INFO - 'LOGNAME': 'cltbld', 02:41:11 INFO - 'MAIL': '/var/mail/cltbld', 02:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:11 INFO - 'MOZ_NO_REMOTE': '1', 02:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:11 INFO - 'NO_EM_RESTART': '1', 02:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:11 INFO - 'PWD': '/builds/slave/test', 02:41:11 INFO - 'SHELL': '/bin/bash', 02:41:11 INFO - 'SHLVL': '1', 02:41:11 INFO - 'TERM': 'linux', 02:41:11 INFO - 'TMOUT': '86400', 02:41:11 INFO - 'USER': 'cltbld', 02:41:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:11 INFO - '_': '/tools/buildbot/bin/python'} 02:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:11 INFO - Downloading/unpacking psutil>=3.1.1 02:41:11 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:41:11 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:41:11 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:41:11 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:41:11 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:41:11 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:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:13 INFO - Installing collected packages: psutil 02:41:13 INFO - Running setup.py install for psutil 02:41:13 INFO - building 'psutil._psutil_linux' extension 02:41:13 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:41:13 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:41:13 INFO - building 'psutil._psutil_posix' extension 02:41:13 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:41:13 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:41:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:14 INFO - Successfully installed psutil 02:41:14 INFO - Cleaning up... 02:41:14 INFO - Return code: 0 02:41:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:41:14 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:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:14 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:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:14 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:14 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:41:14 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:41:14 INFO - Using env: {'DISPLAY': ':0', 02:41:14 INFO - 'HOME': '/home/cltbld', 02:41:14 INFO - 'LANG': 'en_US.UTF-8', 02:41:14 INFO - 'LANGUAGE': 'en_US:en', 02:41:14 INFO - 'LOGNAME': 'cltbld', 02:41:14 INFO - 'MAIL': '/var/mail/cltbld', 02:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:14 INFO - 'MOZ_NO_REMOTE': '1', 02:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:14 INFO - 'NO_EM_RESTART': '1', 02:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:14 INFO - 'PWD': '/builds/slave/test', 02:41:14 INFO - 'SHELL': '/bin/bash', 02:41:14 INFO - 'SHLVL': '1', 02:41:14 INFO - 'TERM': 'linux', 02:41:14 INFO - 'TMOUT': '86400', 02:41:14 INFO - 'USER': 'cltbld', 02:41:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:14 INFO - '_': '/tools/buildbot/bin/python'} 02:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:41:14 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:41:14 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:41:14 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:41:14 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:41:14 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:41:14 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:41:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:41:16 INFO - Installing collected packages: mozsystemmonitor 02:41:16 INFO - Running setup.py install for mozsystemmonitor 02:41:16 INFO - Successfully installed mozsystemmonitor 02:41:16 INFO - Cleaning up... 02:41:16 INFO - Return code: 0 02:41:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:41:16 INFO - Using env: {'DISPLAY': ':0', 02:41:16 INFO - 'HOME': '/home/cltbld', 02:41:16 INFO - 'LANG': 'en_US.UTF-8', 02:41:16 INFO - 'LANGUAGE': 'en_US:en', 02:41:16 INFO - 'LOGNAME': 'cltbld', 02:41:16 INFO - 'MAIL': '/var/mail/cltbld', 02:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:16 INFO - 'MOZ_NO_REMOTE': '1', 02:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:16 INFO - 'NO_EM_RESTART': '1', 02:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:16 INFO - 'PWD': '/builds/slave/test', 02:41:16 INFO - 'SHELL': '/bin/bash', 02:41:16 INFO - 'SHLVL': '1', 02:41:16 INFO - 'TERM': 'linux', 02:41:16 INFO - 'TMOUT': '86400', 02:41:16 INFO - 'USER': 'cltbld', 02:41:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:16 INFO - '_': '/tools/buildbot/bin/python'} 02:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:19 INFO - Downloading docopt-0.6.1.tar.gz 02:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:19 INFO - Running setup.py install for blobuploader 02:41:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:19 INFO - Running setup.py install for requests 02:41:19 INFO - Running setup.py install for docopt 02:41:19 INFO - Successfully installed blobuploader requests docopt 02:41:19 INFO - Cleaning up... 02:41:19 INFO - Return code: 0 02:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:19 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:19 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:41:19 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:41:19 INFO - Using env: {'DISPLAY': ':0', 02:41:19 INFO - 'HOME': '/home/cltbld', 02:41:19 INFO - 'LANG': 'en_US.UTF-8', 02:41:19 INFO - 'LANGUAGE': 'en_US:en', 02:41:19 INFO - 'LOGNAME': 'cltbld', 02:41:19 INFO - 'MAIL': '/var/mail/cltbld', 02:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:19 INFO - 'MOZ_NO_REMOTE': '1', 02:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:19 INFO - 'NO_EM_RESTART': '1', 02:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:19 INFO - 'PWD': '/builds/slave/test', 02:41:19 INFO - 'SHELL': '/bin/bash', 02:41:19 INFO - 'SHLVL': '1', 02:41:19 INFO - 'TERM': 'linux', 02:41:19 INFO - 'TMOUT': '86400', 02:41:19 INFO - 'USER': 'cltbld', 02:41:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:19 INFO - '_': '/tools/buildbot/bin/python'} 02:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:20 INFO - Running setup.py (path:/tmp/pip-8j2UVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:20 INFO - Running setup.py (path:/tmp/pip-Ks8Grq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:20 INFO - Running setup.py (path:/tmp/pip-OYm8aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:20 INFO - Running setup.py (path:/tmp/pip-8FzCXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:20 INFO - Running setup.py (path:/tmp/pip-i6whqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:20 INFO - Running setup.py (path:/tmp/pip-Wr_8be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:20 INFO - Running setup.py (path:/tmp/pip-z2ZVDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:20 INFO - Running setup.py (path:/tmp/pip-gG5M8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:20 INFO - Running setup.py (path:/tmp/pip-JjhkQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:20 INFO - Running setup.py (path:/tmp/pip-tvG5FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:20 INFO - Running setup.py (path:/tmp/pip-Mhl9I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:20 INFO - Running setup.py (path:/tmp/pip-XMhRi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:20 INFO - Running setup.py (path:/tmp/pip-iDvufc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:21 INFO - Running setup.py (path:/tmp/pip-JiI0DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:21 INFO - Running setup.py (path:/tmp/pip-3TDaHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:21 INFO - Running setup.py (path:/tmp/pip-nhuEjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:21 INFO - Running setup.py (path:/tmp/pip-aJRO2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:21 INFO - Running setup.py install for manifestparser 02:41:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozcrash 02:41:21 INFO - Running setup.py install for mozdebug 02:41:21 INFO - Running setup.py install for mozdevice 02:41:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozfile 02:41:21 INFO - Running setup.py install for mozhttpd 02:41:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozinfo 02:41:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:21 INFO - Running setup.py install for mozInstall 02:41:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Running setup.py install for mozleak 02:41:22 INFO - Running setup.py install for mozlog 02:41:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Running setup.py install for moznetwork 02:41:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Running setup.py install for mozprocess 02:41:22 INFO - Running setup.py install for mozprofile 02:41:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Running setup.py install for mozrunner 02:41:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:22 INFO - Running setup.py install for mozscreenshot 02:41:22 INFO - Running setup.py install for moztest 02:41:22 INFO - Running setup.py install for mozversion 02:41:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:23 INFO - Cleaning up... 02:41:23 INFO - Return code: 0 02:41:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:23 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:23 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:41:23 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:41:23 INFO - Using env: {'DISPLAY': ':0', 02:41:23 INFO - 'HOME': '/home/cltbld', 02:41:23 INFO - 'LANG': 'en_US.UTF-8', 02:41:23 INFO - 'LANGUAGE': 'en_US:en', 02:41:23 INFO - 'LOGNAME': 'cltbld', 02:41:23 INFO - 'MAIL': '/var/mail/cltbld', 02:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:23 INFO - 'MOZ_NO_REMOTE': '1', 02:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:23 INFO - 'NO_EM_RESTART': '1', 02:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:23 INFO - 'PWD': '/builds/slave/test', 02:41:23 INFO - 'SHELL': '/bin/bash', 02:41:23 INFO - 'SHLVL': '1', 02:41:23 INFO - 'TERM': 'linux', 02:41:23 INFO - 'TMOUT': '86400', 02:41:23 INFO - 'USER': 'cltbld', 02:41:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:23 INFO - '_': '/tools/buildbot/bin/python'} 02:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:23 INFO - Running setup.py (path:/tmp/pip-0ua8Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:23 INFO - Running setup.py (path:/tmp/pip-k3dy0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:23 INFO - Running setup.py (path:/tmp/pip-TAvshn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:23 INFO - Running setup.py (path:/tmp/pip-leG7uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:23 INFO - Running setup.py (path:/tmp/pip-d3645l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:23 INFO - Running setup.py (path:/tmp/pip-7LhDo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:23 INFO - Running setup.py (path:/tmp/pip-O77JYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:23 INFO - Running setup.py (path:/tmp/pip-9ym2h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:23 INFO - Running setup.py (path:/tmp/pip-EWZpi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:23 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:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:23 INFO - Running setup.py (path:/tmp/pip-cC3OVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:24 INFO - Running setup.py (path:/tmp/pip-Wu275J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:24 INFO - Running setup.py (path:/tmp/pip-xykT7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:24 INFO - Running setup.py (path:/tmp/pip-O7eqxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:24 INFO - Running setup.py (path:/tmp/pip-MEONhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:24 INFO - Running setup.py (path:/tmp/pip-rQOl2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:24 INFO - Running setup.py (path:/tmp/pip-U6skg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:24 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:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:24 INFO - Running setup.py (path:/tmp/pip-WGtGNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:24 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:41:24 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:41:24 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:41:24 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:41:24 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:41:24 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:41:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:24 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:41:24 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:41:24 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:41:24 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:41:24 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:41:24 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:41:26 INFO - Downloading blessings-1.6.tar.gz 02:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:26 INFO - Installing collected packages: blessings 02:41:26 INFO - Running setup.py install for blessings 02:41:26 INFO - Successfully installed blessings 02:41:26 INFO - Cleaning up... 02:41:26 INFO - Return code: 0 02:41:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:27 INFO - Reading from file tmpfile_stdout 02:41:27 INFO - Current package versions: 02:41:27 INFO - argparse == 1.2.1 02:41:27 INFO - blessings == 1.6 02:41:27 INFO - blobuploader == 1.2.4 02:41:27 INFO - docopt == 0.6.1 02:41:27 INFO - manifestparser == 1.1 02:41:27 INFO - mozInstall == 1.12 02:41:27 INFO - mozcrash == 0.17 02:41:27 INFO - mozdebug == 0.1 02:41:27 INFO - mozdevice == 0.48 02:41:27 INFO - mozfile == 1.2 02:41:27 INFO - mozhttpd == 0.7 02:41:27 INFO - mozinfo == 0.9 02:41:27 INFO - mozleak == 0.1 02:41:27 INFO - mozlog == 3.2 02:41:27 INFO - moznetwork == 0.27 02:41:27 INFO - mozprocess == 0.22 02:41:27 INFO - mozprofile == 0.28 02:41:27 INFO - mozrunner == 6.11 02:41:27 INFO - mozscreenshot == 0.1 02:41:27 INFO - mozsystemmonitor == 0.3 02:41:27 INFO - moztest == 0.7 02:41:27 INFO - mozversion == 1.4 02:41:27 INFO - psutil == 3.1.1 02:41:27 INFO - requests == 1.2.3 02:41:27 INFO - wsgiref == 0.1.2 02:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:27 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:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:27 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:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:27 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:27 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:41:27 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:41:27 INFO - Using env: {'DISPLAY': ':0', 02:41:27 INFO - 'HOME': '/home/cltbld', 02:41:27 INFO - 'LANG': 'en_US.UTF-8', 02:41:27 INFO - 'LANGUAGE': 'en_US:en', 02:41:27 INFO - 'LOGNAME': 'cltbld', 02:41:27 INFO - 'MAIL': '/var/mail/cltbld', 02:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:27 INFO - 'MOZ_NO_REMOTE': '1', 02:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:27 INFO - 'NO_EM_RESTART': '1', 02:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:27 INFO - 'PWD': '/builds/slave/test', 02:41:27 INFO - 'SHELL': '/bin/bash', 02:41:27 INFO - 'SHLVL': '1', 02:41:27 INFO - 'TERM': 'linux', 02:41:27 INFO - 'TMOUT': '86400', 02:41:27 INFO - 'USER': 'cltbld', 02:41:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:27 INFO - '_': '/tools/buildbot/bin/python'} 02:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 INFO - Cleaning up... 02:41:27 INFO - Return code: 0 02:41:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41:27 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:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:27 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:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:27 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 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:27 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:41:27 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:41:27 INFO - Using env: {'DISPLAY': ':0', 02:41:27 INFO - 'HOME': '/home/cltbld', 02:41:27 INFO - 'LANG': 'en_US.UTF-8', 02:41:27 INFO - 'LANGUAGE': 'en_US:en', 02:41:27 INFO - 'LOGNAME': 'cltbld', 02:41:27 INFO - 'MAIL': '/var/mail/cltbld', 02:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:27 INFO - 'MOZ_NO_REMOTE': '1', 02:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:27 INFO - 'NO_EM_RESTART': '1', 02:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:27 INFO - 'PWD': '/builds/slave/test', 02:41:27 INFO - 'SHELL': '/bin/bash', 02:41:27 INFO - 'SHLVL': '1', 02:41:27 INFO - 'TERM': 'linux', 02:41:27 INFO - 'TMOUT': '86400', 02:41:27 INFO - 'USER': 'cltbld', 02:41:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:27 INFO - '_': '/tools/buildbot/bin/python'} 02:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:27 INFO - Downloading/unpacking jsonschema 02:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:27 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:41:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:29 INFO - Downloading/unpacking functools32 (from jsonschema) 02:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:29 INFO - warning: no files found matching '*.txt' 02:41:29 INFO - no previously-included directories found matching 'build' 02:41:29 INFO - no previously-included directories found matching 'dist' 02:41:29 INFO - no previously-included directories found matching '.git*' 02:41:29 INFO - Installing collected packages: jsonschema, functools32 02:41:29 INFO - Running setup.py install for functools32 02:41:29 INFO - warning: no files found matching '*.txt' 02:41:29 INFO - no previously-included directories found matching 'build' 02:41:29 INFO - no previously-included directories found matching 'dist' 02:41:29 INFO - no previously-included directories found matching '.git*' 02:41:29 INFO - Successfully installed jsonschema functools32 02:41:29 INFO - Cleaning up... 02:41:29 INFO - Return code: 0 02:41:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a7759ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', '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:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:41:29 INFO - Using env: {'DISPLAY': ':0', 02:41:29 INFO - 'HOME': '/home/cltbld', 02:41:29 INFO - 'LANG': 'en_US.UTF-8', 02:41:29 INFO - 'LANGUAGE': 'en_US:en', 02:41:29 INFO - 'LOGNAME': 'cltbld', 02:41:29 INFO - 'MAIL': '/var/mail/cltbld', 02:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:29 INFO - 'MOZ_NO_REMOTE': '1', 02:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:29 INFO - 'NO_EM_RESTART': '1', 02:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:29 INFO - 'PWD': '/builds/slave/test', 02:41:29 INFO - 'SHELL': '/bin/bash', 02:41:29 INFO - 'SHLVL': '1', 02:41:29 INFO - 'TERM': 'linux', 02:41:29 INFO - 'TMOUT': '86400', 02:41:29 INFO - 'USER': 'cltbld', 02:41:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:29 INFO - '_': '/tools/buildbot/bin/python'} 02:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:30 INFO - Downloading/unpacking flake8 02:41:30 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:41:30 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:41:30 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:41:30 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:41:30 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:41:30 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:41:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:41:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:41:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:41:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:32 INFO - no previously-included directories found matching 'docs/_build' 02:41:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:41:32 INFO - Running setup.py install for pep8 02:41:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:32 INFO - no previously-included directories found matching 'docs/_build' 02:41:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:41:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:41:32 INFO - Cleaning up... 02:41:32 INFO - Return code: 0 02:41:32 INFO - Running post-action listener: _resource_record_post_action 02:41:32 INFO - Running post-action listener: _start_resource_monitoring 02:41:32 INFO - Starting resource monitoring. 02:41:32 INFO - ##### 02:41:32 INFO - ##### Finished create-virtualenv step (success) 02:41:32 INFO - ##### 02:41:32 INFO - ##### 02:41:32 INFO - ##### Running install step. 02:41:32 INFO - ##### 02:41:32 INFO - Running pre-action listener: _resource_record_pre_action 02:41:32 INFO - Running main action method: install 02:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:33 INFO - Reading from file tmpfile_stdout 02:41:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:33 INFO - Reading from file tmpfile_stdout 02:41:33 INFO - Output received: 02:41:33 INFO - Usage: mozinstall [options] installer 02:41:33 INFO - Options: 02:41:33 INFO - -h, --help show this help message and exit 02:41:33 INFO - -d DEST, --destination=DEST 02:41:33 INFO - Directory to install application into. [default: 02:41:33 INFO - "/builds/slave/test"] 02:41:33 INFO - --app=APP Application being installed. [default: firefox] 02:41:33 INFO - mkdir: /builds/slave/test/build/application 02:41:33 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:41:33 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:41:49 INFO - Reading from file tmpfile_stdout 02:41:49 INFO - Output received: 02:41:49 INFO - /builds/slave/test/build/application/firefox/firefox 02:41:49 INFO - Running post-action listener: _resource_record_post_action 02:41:49 INFO - ##### 02:41:49 INFO - ##### Finished install step (success) 02:41:49 INFO - ##### 02:41:49 INFO - ##### 02:41:49 INFO - ##### Running run-tests step. 02:41:49 INFO - ##### 02:41:49 INFO - Running pre-action listener: _resource_record_pre_action 02:41:49 INFO - Running main action method: run_tests 02:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:41:49 INFO - Python 2.7.3 02:41:49 INFO - Return code: 0 02:41:49 INFO - grabbing minidump binary from tooltool 02:41:49 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:41:49 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 0x26669c0>, '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 0x26678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:41:49 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:41:49 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:41:49 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:41:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:41:50 INFO - Return code: 0 02:41:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:41:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:41:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:41:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:41:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:41:50 INFO - Return code: 0 02:41:50 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-042', '--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:41:50 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-042 --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:41:50 INFO - Using env: {'DISPLAY': ':0', 02:41:50 INFO - 'HOME': '/home/cltbld', 02:41:50 INFO - 'LANG': 'en_US.UTF-8', 02:41:50 INFO - 'LANGUAGE': 'en_US:en', 02:41:50 INFO - 'LOGNAME': 'cltbld', 02:41:50 INFO - 'MAIL': '/var/mail/cltbld', 02:41:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:41:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:50 INFO - 'MOZ_NO_REMOTE': '1', 02:41:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:50 INFO - 'NO_EM_RESTART': '1', 02:41:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:50 INFO - 'PWD': '/builds/slave/test', 02:41:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:41:50 INFO - 'SHELL': '/bin/bash', 02:41:50 INFO - 'SHLVL': '1', 02:41:50 INFO - 'TERM': 'linux', 02:41:50 INFO - 'TMOUT': '86400', 02:41:50 INFO - 'USER': 'cltbld', 02:41:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584', 02:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:50 INFO - '_': '/tools/buildbot/bin/python'} 02:41:50 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-042', '--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:41:51 INFO - mozversion application_buildid: 20160530234442 02:41:51 INFO - mozversion application_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:41:51 INFO - mozversion application_display_name: Nightly 02:41:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:41:51 INFO - mozversion application_name: Firefox 02:41:51 INFO - mozversion application_remotingname: firefox 02:41:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:41:51 INFO - mozversion application_vendor: Mozilla 02:41:51 INFO - mozversion application_version: 49.0a1 02:41:51 INFO - mozversion platform_buildid: 20160530234442 02:41:51 INFO - mozversion platform_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:41:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:41:51 INFO - mozversion platform_version: 49.0a1 02:41:51 INFO - using testdate: 1464687711 02:41:51 INFO - actual date: 1464687711 02:41:51 INFO - starting webserver on 'localhost:38716' 02:41:51 INFO - SUITE-START | Running 2 tests 02:41:51 INFO - TEST-START | dromaeo_css 02:41:51 INFO - operating with platform_type : linux_ 02:41:51 INFO - Initialising browser for dromaeo_css test... 02:41:51 INFO - TEST-INFO | started process 26670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ZguXI/profile http://localhost:38716/getInfo.html) 02:41:55 INFO - PROCESS | 26670 | __metrics Screen width/height:1600/1200 02:41:55 INFO - PROCESS | 26670 | colorDepth:24 02:41:55 INFO - PROCESS | 26670 | Browser inner width/height: 1024/697 02:41:55 INFO - PROCESS | 26670 | __metrics 02:41:57 ERROR - PROCESS | 26670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:41:58 INFO - TEST-INFO | 26670: exit 0 02:41:58 INFO - Browser initialized. 02:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:41:58 INFO - TEST-INFO | started process 26753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ZguXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:09 INFO - PROCESS | 26753 | RSS: Main: 155492352 02:42:09 INFO - PROCESS | 26753 | 02:43:01 INFO - PROCESS | 26753 | 1464687781130 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:45:09 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38716/tests/dromaeo/cssquery-ext.html) 02:45:10 INFO - PROCESS | 26753 | RSS: Main: 244342784 02:45:10 INFO - PROCESS | 26753 | 02:48:12 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-ext.html (next: http://localhost:38716/tests/dromaeo/cssquery-jquery.html) 02:48:13 INFO - PROCESS | 26753 | RSS: Main: 239833088 02:48:13 INFO - PROCESS | 26753 | 02:51:15 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38716/tests/dromaeo/cssquery-mootools.html) 02:51:15 INFO - PROCESS | 26753 | RSS: Main: 241102848 02:51:15 INFO - PROCESS | 26753 | 02:54:17 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38716/tests/dromaeo/cssquery-prototype.html) 02:54:18 INFO - PROCESS | 26753 | RSS: Main: 241143808 02:54:18 INFO - PROCESS | 26753 | 02:57:20 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38716/tests/dromaeo/cssquery-yui.html) 02:57:21 INFO - PROCESS | 26753 | RSS: Main: 212439040 02:57:21 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | Cycle 1(1): loaded http://localhost:38716/tests/dromaeo/cssquery-yui.html (next: http://localhost:38716/tests/dromaeo/cssquery-dojo.html) 03:00:24 INFO - PROCESS | 26753 | RSS: Main: 275214336 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | __start_tp_report 03:00:24 INFO - PROCESS | 26753 | _x_x_mozilla_page_load 03:00:24 INFO - PROCESS | 26753 | _x_x_mozilla_page_load_details 03:00:24 INFO - PROCESS | 26753 | |i|pagename|runs| 03:00:24 INFO - PROCESS | 26753 | |0;dojo.html;3153.274746808234;3161.984190079048;3181.490961446169;3206.8396580171016;3231.547583338333;5342.492463215998;5421.701806400656;5469.316335458067;5478.506934375905;5494.478024587663;5489.1217405215175;5507.228987941691;5539.086050801623;5579.553635709143;5628;4914.2874283229;4958.454569997315;5001.749912504379;5013.523715247064;5098.770555325019;5035.395752509704;5055.292259083732;5084.822031228908;5110.156824124015;5115.53960143587;4888.046830867965;4935.062338155757;4964.776585053663;5001;5030.270610761456;4915.311856340079;4919.704817710913;4922.015596880638;4932.876678083041;4989.101961646902;4886.584640305578;4922.729249891255;4938.876528086791;4946;4966.453690094087;5282.181261904411;5345.438728933484;5346.518813306821;5351.7056561889085;5456.945430545684;5880.117982302646;5918.112283157561;5924.763009479659;5930.347661757203;5937.52499800015;5935.554833387513;5955.642661440327;5961.493273071794;5965.5525835562075;5966.791162309299;5429.484199001088;5552.472515111058;5604.243427137325;5615.241942337773;5681.318241810926;6162.876742465215;6166.445019948226;6169.660668663267;6171.6297022178815;6174.38256174379;5682.857928551819;5918;5923.437273459014;5968.761249550056;5981.820545383645;5885.676287804212;5966.910496342558;5968.403159683997;5997.400259974055;5998.25021872266;5932.7330270137945;5961.791337303173;5970.641761494324;5973.581849270509;5982.4316689914385;5700.857478563069;5847.649141051551;5985;5991.970040149771;5994.190784244159;4499.59503644667;4518.909621807546;4522.88692782683;4559.179347717442;4562.452505699337;4001.1197536541913;4014.458048163519;4026.6577340925764;4037.858674946363;4048.6356227939627;5414.133738601805;5455.427180146107;5628.634138780966;5651.463111004448;5653.689047102366;5894.705264736746;5950.553708471882;5999.820005399845;6057.212562366864;6063.605865618721;5642.830715078554;5648.548116150698;5648.943510564842;5651.4348565143155;5654.151877218368;4967.2549117631925;5054.82308119214;5157.793688252503;5167.4832516748775;5170;6104.481119104837;6154;6155.230596175567;6163.414475624809;6179.073139029181;5976.820695379146;5976.8804623908145;5987.221661184019;6003.549733769897;6009.969950150221;5983.461488466059;6079.452849243412;6082.60463069899;6125.785597504066;6165.876682466236;5821.359650438533;5852.531797456279;5852.795152169653;5858.443447872445;5905.704714764331;5912.940870591411;5955.106733989763;5964.224650795369;5967.46292833647;5975.850603734942;5705.429457054427;5752.194692743103;5789.913151302818;5807.796727114531;5826.126081087701;5817.331006934257;5829.417058294137;5834.970825145847;5840.912386314294;5842.970785146047;5669.773209071756;5670.432956704297;5672.404397538364;5682.147677848356;5686.886262274648;5717.914231286451;5798.94201057984;5864.384239654775;5868.061110222515;5966.522678185822;5728.570357223308;5732.4267573244015;5754.741036653277;5768.682722450306;5806.477417032487 03:00:24 INFO - PROCESS | 26753 | |1;ext.html;567.2427309541762;613.0742578706155;613.9416755408236;617.546103613844;637.6461064109418;30154.849225753867;30807.229819254502;33310.66689333112;33353.49969750453;41764.79117604408;40992.79503602485;45284.320735189;45307.773461132645;45340.319895201515;45346.31980520295;8730.51982140982;8922.821543569125;8924.196822285992;8930;8961.77595560113;8688.218060374566;8860;8860.689875854347;8864.778380540474;8869.068747781486;8927;8982.281417486618;8987.415817971843;8987.64049438025;8990.775230619221;8852.291816654651;8880.333974951873;8900.51047192404;8907.599158037903;8913.153250441197;8815.206631403205;8899.73300800977;8904.332175086894;8904.421212621159;8912.64349426022;41884.37173442401;42120.78939605282;42186;42249.78875105635;42356.15287694229;3185.5221716742676;3350.8827191048194;3581.7313701472494;3705.4441833724886;3786.659200671953;31220.687793122004;31299;31345.686543134503;31541.369172616418;32306.192345191324;4308.82764689412;4320.82716691332;4401.801918913625;4457.910841783146;4503.099380123988;351648;354224;355826;357682;359724;58423.41576584265;58872.7056364724;58931.41068589345;58969.41030589725;59054;60670.393296067356;60918.69540652268;61036.38963610307;61116;61154.38845611576;15815.367385304458;16152.273147708147;16178.514644560682;16187.271572779253;16206.432774852823;12367.752644947052;12578.874211257771;12581.748365032649;12597.11820172579;12610;13591.796123058162;15749.370025199092;15798.68402631941;15838.52484425469;16008.599785005468;5223.13818219997;5898.498627616615;6053.727582258809;6104.694765261719;6131.172291740647;993.6869885985891;1021.9693409197736;1026.8819085805078;1040.9271351005357;1082.285691443659;30898;31015.534766978515;31152.376952460825;31664.841675791933;31942.680573194437;1099.8790133085354;1116.9218154729253;1122.938238396896;1140.914431417647;1214.631468636163;15968.201589920458;16443.01341919465;16496.34014639425;16507.66984660324;16632.085235312174;570270;573029;575296;575493;575740;58219.417805822246;59383.40616593865;59498.70250648806;59508.40491595115;59566;1272.389253158489;1366.4397596985189;1367.8221831162084;1401.8457969623332;1409.041851540962;30595.694043059284;32167.51748723724;32443;32613;32811.50782738213;48123.278150827064;48484.2727359097;48657.5134248653;48669.5133048665;48695.26957095717;402633;405636;406268;406629;406757;33304.33391332208;35282.82358588191;40882;41830.79084604557;44759;47763;47819.76090119527;48180.51819481901;49160.50839491702;49426.25860612166;40331.395029074;41255.7937210312;41604.58395416007;41641.375379369936;42422.36366454444;40230.39654405245;40575.39136913008;40725.389119162646;41583.168336632494;41965.1606967865;40543.79728101341;41250.58749412467;41321.380179296735;41399.58600414078;41870.58129418789;34764;36228;36488.635113648525;36601;37254;27619;27721.722782771914;27831.860840695666;27859.303517412227;27921.860390697915 03:00:24 INFO - PROCESS | 26753 | |2;jquery.html;384.98652547160845;394.99012524686884;399.96800255979525;401.7509144330512;409.4656473302341;14284.78572821406;16785.24466399012;18210.5447363816;19708.704369434436;19765.901170494144;15292.923535382308;15475.226238688048;15822.446214382499;18754.71867921979;18788.71816922744;5454.4545545445535;5462.344518657756;5599.692016939067;5628.409017053212;5654.038813401711;4088.8568900088503;5552.222688823568;5561.888762224753;5653.180288858113;5664.895345407647;6025.367336429677;6297.968510157443;6302.527310451712;6414.615123092606;6422;6294.496440284789;6362.713677884483;6363.395477429637;6364.077208804743;6383.585066970655;5482.753276102585;5589.580781441408;5599.580031497654;5601.187827764951;5628.155776633497;21961;22064.33806985793;22133.446663833372;22329.441763955867;22666;2226.3988723044686;2272.9545409091893;2275.108368049175;2584.134315004476;2715.2261605442354;13534;14023;14089.788653170212;14492.34784434703;14494.275286235646;1766.726157445598;1814.3649722597117;1814.6442185514602;1817.3366721146817;1844.1516902224857;73261.6336918312;75958.62020689917;76414.23585764127;76540;80773.59613201897;10223.897761022443;10489.895101049044;10854.67435976922;10985.505652245669;11015.559377624806;13372.531961381304;15365.769513457308;15376.38494460209;15390;15399.692006159814;7692.307692307719;7822.452428330076;8065.959670201729;8069.072056713436;8209.220124088202;7669.271419215165;7748.535087894745;7783.377329813601;7859.72490962825;7909.05091389037;4677.953220467752;4715.104130215248;4741.431028276629;4778.307145463958;4830.758462076882;1836.3848110882736;1915.367928583564;1930.7972662870197;1958.7180934211483;1959.7648282206226;940.8917974432891;946.8816397950256;988.6935050134481;1051.9368837869752;1108.0858291909208;17898.284068637367;18709.43871683852;18835.905820471085;18838.90580547116;18941.62116757657;980.5734505490135;994.5077186792439;997.4912794474725;1008.6822650864954;1013.5641674080216;10142.645007424704;10620.309679870783;10696.51865666047;10704.30422022566;10778.191635627203;368008;452652;459007;461637;462904;94226;96881;98716.12838716072;100389.49805250927;103372;961.293449314753;1014.9391036537684;1021.8007488539663;1025.9692209233735;1063.3088492479949;16320.18399080065;16688.666226675643;16954.660906781548;16970.915145424195;17468.563285917953;41293.793531032155;42496.15007699767;42499;42765.57234427616;43043.56956430521;59778.70110649419;59848.10227846499;61844;62210;62264;8571.571421428778;8592.957035215033;8612.18184272493;8642.265407440187;8679.392442528962;9431.95284023603;12262.877371226174;12917.160384574972;12967.546135885199;12975.545855894998;8665.696700615448;10656.786864262827;11385.316880987168;11443.542258309575;11500.712482188012;10408.895911040792;11379.146564007899;11438.828417573577;11452.08383329315;11593.59422420245;11451.141164412536;11547.884521154681;11834.82247766267;11853.822192666945;12009.759804804029;8377.078521362524;8435.072142064246;8529.275011624082;8666.393352465268;8729.476231426135;11167.609133680282;11411.60059397917;11429.771404572028;11455.689879108868;11521.135914806591 03:00:24 INFO - PROCESS | 26753 | |3;mootools.html;1293.366250537237;1462.4442711769525;1509.4490510963499;1698.7536807162953;1810.8822926509783;8596.828063438728;9025.458472491648;9037.819243615124;9222.216111630503;9279.768005799859;9082.091790820914;9247.815043699138;9250.67622633208;9254.07459254076;9256.213221876149;2046.2735728816278;2263.343630347197;2337.228714524203;2355.8233132515043;2382.8808559571953;2265.3883451468096;2265.535565209128;2270.648049552322;2270.9772902271015;2273.658951157323;2310.6880571122933;2311.1217737259817;2341.8360714749974;2341.8594884306913;2345.155743932183;1940.1657287366427;2191.561687662474;2241.4396400899777;2248.898799554024;2264.7395549511853;2279.0428020231543;2295.391721193885;2306.8615883046905;2311.0986715181093;2313.7570555091643;9277.860832087525;9280.72157835266;9322.766930826716;9334.71995840126;9335;5147.073526765181;5254.65844720092;5269.604779641542;5299.152135658276;5301.575873930076;3192.680731926812;3374.746893982961;3387.5257463955068;3460.2387474755515;3482.407990641572;1001.8196724589571;1017.069381515912;1025.5590096258607;1091.0889407344876;1104.0394856474838;13238.073334866564;13248.47006119754;13279.136856104225;13279.53521626748;13282.402291896888;4420.204363214652;4523.2988886722615;4570.428696412949;4640.11837750833;4644.349791029259;10977.28647637901;10981.231313807957;10985.450727463594;10987.39569323679;10999.175061870392;5039.571636410873;5113.028524580318;5115.565176959925;5121.743912804345;5121.923171152435;4318.35224716295;4661.417322834645;4801.423829140525;4809.687370320918;4856.247281671346;3983.4224037514978;4018.3168861293652;4096.201240758023;4101.323281658552;4123.36087906375;1285.2738202915323;1295.533607901155;1304.8564657887625;1305.2364366845502;1318.967025824362;847.3602430165186;870.5603670146536;870.8200388473654;876.2945828607905;891.9777005574913;5917.911231331534;5922.7927022554;6028.728707208186;6140.570160088841;6305.14880491137;941.8116376724682;942.9057094290654;951.8905325887473;953.7186529973675;964.5852283518014;3745.1573395985683;3848.3265428550453;3850.268448994682;3894.2990261753157;3910.1397692507603;11131.833022504668;11790;11851.111166662535;11885.28688278706;11894.226875253082;11411;11649.068074554016;11687.065034797195;11695.298282103102;11800.055995520337;8585.65657373698;8664.8700269496;8665.696700615448;8693.956530217181;8717.171868672465;5555.527780138734;5580.079286917776;5598.216249725123;5633.436656334334;5719.5710321726865;10720.410377429316;10799.190060745319;10820.998115348686;10827.24209305341;10852.348859068481;10782.784344312913;10934.45327733626;10980.066694330751;11045.171612128961;11129.276597021168;6996.755113571001;7177.1746249182015;7342.155652100077;7425.777226683208;7533.096028476399;8659.393842430969;8673;8729.476231426135;8758.080401557745;8760.474371537728;7565.43259255547;7779.649915753692;7841.372690184886;7845.882311765214;7912.0505539335645;7491.775246742606;7564.130125035691;7628.199039101037;7684.846303073796;7722.15056343813;6471.417572418505;6532.248791389051;6532.314107018695;6545.738170473128;6558.704858281484;4633.258678611406;4666.533346665306;4720.22116350812;4734.928976065293;4785;4814.398200224972;4827.589654879374;4847.587955023862;4961.7271050092595;5057 03:00:24 INFO - PROCESS | 26753 | |4;prototype.html;320.44402960862897;321.6831421050266;329.4251531078268;329.48271214193727;332.801982820222;5265.7893684252585;5311.601629877765;5327.360716714;5337.332833395825;5370.087085195516;5290.1220066876285;5290.206469029647;5293;5310.946890531093;5316.867078323035;3954.110325176841;4058.5738497457783;4066.9186616267657;4074.309161697892;4094.1197642506854;4135.27632664284;4147.377893316012;4148.481439820022;4151.709380343377;4168.312228482297;4024.3359845625437;4075.8383860599733;4123.711340206187;4131.636559935214;4143.212789569987;4056.067104565937;4088.897777555555;4097.8281510799325;4125.278076336659;4131.421600975851;3646.6353364663587;3649.708023358125;3654.6528079832374;3654.7705899401344;3668.6147954464664;5059.519345662156;5086.694798312076;5097.8215762448135;5101.336826212606;5111.028904508169;4646.210144275447;4703.694259873131;4748.525147485224;4755.430707866431;4773.212419950704;5460.453954604508;5481.260029895953;5508.55931525477;5552.444755524456;5562.749676264578;3977.8607748728655;3984.78464068459;4021.617946295097;4056.6146216109423;4059.8985025374304;5633.60564760467;5764.221830052931;5785.363610002896;5789.594728369016;5792.275965504312;4087.529934057562;4090.8159132839096;4110.938335924963;4129.731567448166;4132;4183.330667093251;4192.769397683157;4204.26425375558;4214.936775948363;4222.493300803923;4429.955700442954;4724.551167639069;4785.138675038526;4805.765319126623;4806.687565308313;5536.197251398525;5560.499555040065;5571.66570005801;5587.469190426903;5604.907043126551;1380.875721185078;1387.5906607550796;1393.9197122230353;1401.9439222431192;1402.9298535073206;888.1828717579842;897.0984160918235;901.7024381953939;902.9006809250977;918.7749001494676;4826.300186472942;5223.712695801692;5327.706976116351;5347.625666203328;5361.463853614685;5616.747246373923;5669.801556945569;5687.118496633028;5698.601097923189;5732.394929419769;5349.839504814861;5383.2194331821665;5387.030334539742;5393.2449457076045;5395.568354531628;2880.495913215179;3047.4362242985117;3059.9847000764853;3063.2801291696433;3098.7675924305768;5898.793542226002;5904.350521442638;6006.6485040865455;6016.729247183887;6026.6986650667295;5509.531689806331;5834.891370639565;5849.61977471463;5886.676232807151;5896.911546326808;5883.352831188651;5893.44012318829;5919.911201331897;5935.821925342247;6001.849953751103;5521.69630670317;5716.5998380113;5768.3078030634915;5827.912581311199;5861.32952108647;5654.529822246328;5674.829755107354;5687.146927960839;5695.658260504383;5710.942890571041;5912.881742365214;5958.880822383615;5977.701114944322;5997.280326360865;6002.069679199731;4021.1957608479006;4081.89795255121;4108.856190033334;4118.814653340547;4142.171565686815;5758.128608202267;5802.361740208658;5814.703192239126;5817.214676018683;5821.933213709072;5357.624966252325;5627.127795191752;5635.943640563706;5672.404397538199;5676.7445464955;5361.919571206513;5610.551155907436;5622.943770562242;5630.324361076697;5658.274226361;5397.649152805055;5429.647072940246;5435.315052333789;5438.510534051954;5444.537214336826;5450.672959622435;5607.794324220149;5631.605787594829;5634.352049514195;5638.971805140948;5494.955958367897;5524.14375771756;5535.418781027934;5544.584156188383;5550.113940750868 03:00:24 INFO - PROCESS | 26753 | |5;yui.html;686.2177118085381;730.8684436801377;747.9864783218738;767.9347255483284;782.1708988472217;13308.667283317922;14823.036502627321;14999.85000149998;15163.848361516382;15188.088714677127;14064.296785160752;14080.788788168185;14091.929540352285;14116.788248176259;14126.57620271391;794.13835987953;797.6609940775177;798.1380109481775;798.4969469234403;806.2783808491397;791.4024911192071;791.6872835230081;791.711025475703;791.956442395668;792.3067316098413;699.1016543741268;719.7768691705588;720.4488566246825;821.8356328734247;837.5812093953024;824.8226631274244;833.1918039501674;841.2807049972308;843.4559708987699;845.5898889038842;626.0140279060453;626.1296797451546;626.3141859663662;627.6485168305763;629.6285191736852;13329.666758331023;13415.731685366238;13416.86583134166;13427.731445371135;13442.596722098255;11842.822357664641;13756.380962856696;13769.105008174536;14326.71346573073;14482.565523034325;11010.724731881686;11047.613333533369;11056.11551075912;11110.333379997146;11349.20555561111;3650.707943364551;3695.334839728848;3706.2772759311947;3726.6832319252626;3950.683945284399;56270.71864640692;56622;56742;56815.14777278386;56983.71508142474;10445.582176712845;10495.790084198426;10683.198760092868;10702.732431689114;11153.275037122561;19853;19873.60252794965;19981.300654477025;20003.899980500297;20018.299359522345;8174.223448772357;8289;8331.041930177986;8357.916420835836;8478.364122690822;4573.817047318136;4709.505501922317;4746.5490778376;4784.354112194878;4955.504449555087;3396.1679388549965;3485.337785820686;3486.5467489226744;3487.05849420655;3488.389531831919;578.2453897663589;589.4694774702716;599.0744300056423;601.1964404408743;608.6165715599233;594.9405059494015;618.2704408797572;622.6046460497527;623.479394705417;632.5793347424003;8944.597493112826;9142.680006199884;9148.817023659489;9162.587683554257;9202.35583509148;566.077294010768;596.3023262782555;613.8680183760513;619.575590720358;689.582802404548;3957.940630890539;3964.6035396460125;4007.458993035903;4009.4386785850006;4119.8970025749595;64427;65569;65687.67156164284;68084.3191568078;68215.65892170607;60704.392956070755;60983.08525372123;61059.38940610626;61386.69306653438;62815;55236;55811.44188558144;56179;56742;57570.712146439;8332.50004999702;8579.785505362415;8587.742367728979;8591.957040214758;8738.388312818042;37447;38287.42568861525;38387;38568.80715596404;39037.21925561416;47357;49731;50164;50576;50804.237936431724;11419.771604568028;11460.255083419552;11544.88455115438;11584.929993551885;11712.472938717608;12250;12320.968239591624;12450.564230251897;12756.043296752967;13015.804762928374;11588.304701717587;11637.872975170796;11781.234219775688;11920;12623.747525049632;10970.670879873298;10989.670309890716;11444.542218311175;11546;11621.070314375;10697.251192416456;10800.567977280822;10863.348199108079;11227.101831853268;11294.265872718248;9899.663545421565;9952.203823693942;10142.137918277029;10498.527566259689;10530.157587393143;9666.709998700051;10156.289059765746;10160.745981350525;10196.745081372728;10221.693349199535 03:00:24 INFO - PROCESS | 26753 | __end_tp_report 03:00:24 INFO - PROCESS | 26753 | __start_cc_report 03:00:24 INFO - PROCESS | 26753 | _x_x_mozilla_cycle_collect,1025 03:00:24 INFO - PROCESS | 26753 | __end_cc_report 03:00:24 INFO - PROCESS | 26753 | __startTimestamp1464688824458__endTimestamp 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | ------- Summary: start ------- 03:00:24 INFO - PROCESS | 26753 | Number of tests: 6 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#0] dojo.html Cycles:165 Average:5502.57 Median:5705.43 stddev:646.15 (11.3%) stddev-sans-first:621.30 03:00:24 INFO - PROCESS | 26753 | Values: 3153.3 3162.0 3181.5 3206.8 3231.5 5342.5 5421.7 5469.3 5478.5 5494.5 5489.1 5507.2 5539.1 5579.6 5628.0 4914.3 4958.5 5001.7 5013.5 5098.8 5035.4 5055.3 5084.8 5110.2 5115.5 4888.0 4935.1 4964.8 5001.0 5030.3 4915.3 4919.7 4922.0 4932.9 4989.1 4886.6 4922.7 4938.9 4946.0 4966.5 5282.2 5345.4 5346.5 5351.7 5456.9 5880.1 5918.1 5924.8 5930.3 5937.5 5935.6 5955.6 5961.5 5965.6 5966.8 5429.5 5552.5 5604.2 5615.2 5681.3 6162.9 6166.4 6169.7 6171.6 6174.4 5682.9 5918.0 5923.4 5968.8 5981.8 5885.7 5966.9 5968.4 5997.4 5998.3 5932.7 5961.8 5970.6 5973.6 5982.4 5700.9 5847.6 5985.0 5992.0 5994.2 4499.6 4518.9 4522.9 4559.2 4562.5 4001.1 4014.5 4026.7 4037.9 4048.6 5414.1 5455.4 5628.6 5651.5 5653.7 5894.7 5950.6 5999.8 6057.2 6063.6 5642.8 5648.5 5648.9 5651.4 5654.2 4967.3 5054.8 5157.8 5167.5 5170.0 6104.5 6154.0 6155.2 6163.4 6179.1 5976.8 5976.9 5987.2 6003.5 6010.0 5983.5 6079.5 6082.6 6125.8 6165.9 5821.4 5852.5 5852.8 5858.4 5905.7 5912.9 5955.1 5964.2 5967.5 5975.9 5705.4 5752.2 5789.9 5807.8 5826.1 5817.3 5829.4 5835.0 5840.9 5843.0 5669.8 5670.4 5672.4 5682.1 5686.9 5717.9 5798.9 5864.4 5868.1 5966.5 5728.6 5732.4 5754.7 5768.7 5806.5 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#1] ext.html Cycles:180 Average:60467.40 Median:41491.38 stddev:120797.92 (291.1%) stddev-sans-first:121053.07 03:00:24 INFO - PROCESS | 26753 | Values: 567.2 613.1 613.9 617.5 637.6 30154.8 30807.2 33310.7 33353.5 41764.8 40992.8 45284.3 45307.8 45340.3 45346.3 8730.5 8922.8 8924.2 8930.0 8961.8 8688.2 8860.0 8860.7 8864.8 8869.1 8927.0 8982.3 8987.4 8987.6 8990.8 8852.3 8880.3 8900.5 8907.6 8913.2 8815.2 8899.7 8904.3 8904.4 8912.6 41884.4 42120.8 42186.0 42249.8 42356.2 3185.5 3350.9 3581.7 3705.4 3786.7 31220.7 31299.0 31345.7 31541.4 32306.2 4308.8 4320.8 4401.8 4457.9 4503.1 351648.0 354224.0 355826.0 357682.0 359724.0 58423.4 58872.7 58931.4 58969.4 59054.0 60670.4 60918.7 61036.4 61116.0 61154.4 15815.4 16152.3 16178.5 16187.3 16206.4 12367.8 12578.9 12581.7 12597.1 12610.0 13591.8 15749.4 15798.7 15838.5 16008.6 5223.1 5898.5 6053.7 6104.7 6131.2 993.7 1022.0 1026.9 1040.9 1082.3 30898.0 31015.5 31152.4 31664.8 31942.7 1099.9 1116.9 1122.9 1140.9 1214.6 15968.2 16443.0 16496.3 16507.7 16632.1 570270.0 573029.0 575296.0 575493.0 575740.0 58219.4 59383.4 59498.7 59508.4 59566.0 1272.4 1366.4 1367.8 1401.8 1409.0 30595.7 32167.5 32443.0 32613.0 32811.5 48123.3 48484.3 48657.5 48669.5 48695.3 402633.0 405636.0 406268.0 406629.0 406757.0 33304.3 35282.8 40882.0 41830.8 44759.0 47763.0 47819.8 48180.5 49160.5 49426.3 40331.4 41255.8 41604.6 41641.4 42422.4 40230.4 40575.4 40725.4 41583.2 41965.2 40543.8 41250.6 41321.4 41399.6 41870.6 34764.0 36228.0 36488.6 36601.0 37254.0 27619.0 27721.7 27831.9 27859.3 27921.9 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#2] jquery.html Cycles:180 Average:27668.71 Median:2429.62 stddev:73388.80 (3020.6%) stddev-sans-first:73566.08 03:00:24 INFO - PROCESS | 26753 | Values: 385.0 395.0 400.0 401.8 409.5 14284.8 16785.2 18210.5 19708.7 19765.9 15292.9 15475.2 15822.4 18754.7 18788.7 5454.5 5462.3 5599.7 5628.4 5654.0 4088.9 5552.2 5561.9 5653.2 5664.9 6025.4 6298.0 6302.5 6414.6 6422.0 6294.5 6362.7 6363.4 6364.1 6383.6 5482.8 5589.6 5599.6 5601.2 5628.2 21961.0 22064.3 22133.4 22329.4 22666.0 2226.4 2273.0 2275.1 2584.1 2715.2 13534.0 14023.0 14089.8 14492.3 14494.3 1766.7 1814.4 1814.6 1817.3 1844.2 73261.6 75958.6 76414.2 76540.0 80773.6 10223.9 10489.9 10854.7 10985.5 11015.6 13372.5 15365.8 15376.4 15390.0 15399.7 7692.3 7822.5 8066.0 8069.1 8209.2 7669.3 7748.5 7783.4 7859.7 7909.1 4678.0 4715.1 4741.4 4778.3 4830.8 1836.4 1915.4 1930.8 1958.7 1959.8 940.9 946.9 988.7 1051.9 1108.1 17898.3 18709.4 18835.9 18838.9 18941.6 980.6 994.5 997.5 1008.7 1013.6 10142.6 10620.3 10696.5 10704.3 10778.2 368008.0 452652.0 459007.0 461637.0 462904.0 94226.0 96881.0 98716.1 100389.5 103372.0 961.3 1014.9 1021.8 1026.0 1063.3 16320.2 16688.7 16954.7 16970.9 17468.6 41293.8 42496.2 42499.0 42765.6 43043.6 59778.7 59848.1 61844.0 62210.0 62264.0 8571.6 8593.0 8612.2 8642.3 8679.4 9432.0 12262.9 12917.2 12967.5 12975.5 8665.7 10656.8 11385.3 11443.5 11500.7 10408.9 11379.1 11438.8 11452.1 11593.6 11451.1 11547.9 11834.8 11853.8 12009.8 8377.1 8435.1 8529.3 8666.4 8729.5 11167.6 11411.6 11429.8 11455.7 11521.1 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#3] mootools.html Cycles:180 Average:5912.04 Median:4642.23 stddev:3561.08 (76.7%) stddev-sans-first:3554.15 03:00:24 INFO - PROCESS | 26753 | Values: 1293.4 1462.4 1509.4 1698.8 1810.9 8596.8 9025.5 9037.8 9222.2 9279.8 9082.1 9247.8 9250.7 9254.1 9256.2 2046.3 2263.3 2337.2 2355.8 2382.9 2265.4 2265.5 2270.6 2271.0 2273.7 2310.7 2311.1 2341.8 2341.9 2345.2 1940.2 2191.6 2241.4 2248.9 2264.7 2279.0 2295.4 2306.9 2311.1 2313.8 9277.9 9280.7 9322.8 9334.7 9335.0 5147.1 5254.7 5269.6 5299.2 5301.6 3192.7 3374.7 3387.5 3460.2 3482.4 1001.8 1017.1 1025.6 1091.1 1104.0 13238.1 13248.5 13279.1 13279.5 13282.4 4420.2 4523.3 4570.4 4640.1 4644.3 10977.3 10981.2 10985.5 10987.4 10999.2 5039.6 5113.0 5115.6 5121.7 5121.9 4318.4 4661.4 4801.4 4809.7 4856.2 3983.4 4018.3 4096.2 4101.3 4123.4 1285.3 1295.5 1304.9 1305.2 1319.0 847.4 870.6 870.8 876.3 892.0 5917.9 5922.8 6028.7 6140.6 6305.1 941.8 942.9 951.9 953.7 964.6 3745.2 3848.3 3850.3 3894.3 3910.1 11131.8 11790.0 11851.1 11885.3 11894.2 11411.0 11649.1 11687.1 11695.3 11800.1 8585.7 8664.9 8665.7 8694.0 8717.2 5555.5 5580.1 5598.2 5633.4 5719.6 10720.4 10799.2 10821.0 10827.2 10852.3 10782.8 10934.5 10980.1 11045.2 11129.3 6996.8 7177.2 7342.2 7425.8 7533.1 8659.4 8673.0 8729.5 8758.1 8760.5 7565.4 7779.6 7841.4 7845.9 7912.1 7491.8 7564.1 7628.2 7684.8 7722.2 6471.4 6532.2 6532.3 6545.7 6558.7 4633.3 4666.5 4720.2 4734.9 4785.0 4814.4 4827.6 4847.6 4961.7 5057.0 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#4] prototype.html Cycles:180 Average:4694.86 Median:5361.69 stddev:1391.37 (26.0%) stddev-sans-first:1355.98 03:00:24 INFO - PROCESS | 26753 | Values: 320.4 321.7 329.4 329.5 332.8 5265.8 5311.6 5327.4 5337.3 5370.1 5290.1 5290.2 5293.0 5310.9 5316.9 3954.1 4058.6 4066.9 4074.3 4094.1 4135.3 4147.4 4148.5 4151.7 4168.3 4024.3 4075.8 4123.7 4131.6 4143.2 4056.1 4088.9 4097.8 4125.3 4131.4 3646.6 3649.7 3654.7 3654.8 3668.6 5059.5 5086.7 5097.8 5101.3 5111.0 4646.2 4703.7 4748.5 4755.4 4773.2 5460.5 5481.3 5508.6 5552.4 5562.7 3977.9 3984.8 4021.6 4056.6 4059.9 5633.6 5764.2 5785.4 5789.6 5792.3 4087.5 4090.8 4110.9 4129.7 4132.0 4183.3 4192.8 4204.3 4214.9 4222.5 4430.0 4724.6 4785.1 4805.8 4806.7 5536.2 5560.5 5571.7 5587.5 5604.9 1380.9 1387.6 1393.9 1401.9 1402.9 888.2 897.1 901.7 902.9 918.8 4826.3 5223.7 5327.7 5347.6 5361.5 5616.7 5669.8 5687.1 5698.6 5732.4 5349.8 5383.2 5387.0 5393.2 5395.6 2880.5 3047.4 3060.0 3063.3 3098.8 5898.8 5904.4 6006.6 6016.7 6026.7 5509.5 5834.9 5849.6 5886.7 5896.9 5883.4 5893.4 5919.9 5935.8 6001.8 5521.7 5716.6 5768.3 5827.9 5861.3 5654.5 5674.8 5687.1 5695.7 5710.9 5912.9 5958.9 5977.7 5997.3 6002.1 4021.2 4081.9 4108.9 4118.8 4142.2 5758.1 5802.4 5814.7 5817.2 5821.9 5357.6 5627.1 5635.9 5672.4 5676.7 5361.9 5610.6 5622.9 5630.3 5658.3 5397.6 5429.6 5435.3 5438.5 5444.5 5450.7 5607.8 5631.6 5634.4 5639.0 5495.0 5524.1 5535.4 5544.6 5550.1 03:00:24 INFO - PROCESS | 26753 | 03:00:24 INFO - PROCESS | 26753 | [#5] yui.html Cycles:180 Average:15372.66 Median:4765.45 stddev:18762.42 (393.7%) stddev-sans-first:18782.64 03:00:24 INFO - PROCESS | 26753 | Values: 686.2 730.9 748.0 767.9 782.2 13308.7 14823.0 14999.9 15163.8 15188.1 14064.3 14080.8 14091.9 14116.8 14126.6 794.1 797.7 798.1 798.5 806.3 791.4 791.7 791.7 792.0 792.3 699.1 719.8 720.4 821.8 837.6 824.8 833.2 841.3 843.5 845.6 626.0 626.1 626.3 627.6 629.6 13329.7 13415.7 13416.9 13427.7 13442.6 11842.8 13756.4 13769.1 14326.7 14482.6 11010.7 11047.6 11056.1 11110.3 11349.2 3650.7 3695.3 3706.3 3726.7 3950.7 56270.7 56622.0 56742.0 56815.1 56983.7 10445.6 10495.8 10683.2 10702.7 11153.3 19853.0 19873.6 19981.3 20003.9 20018.3 8174.2 8289.0 8331.0 8357.9 8478.4 4573.8 4709.5 4746.5 4784.4 4955.5 3396.2 3485.3 3486.5 3487.1 3488.4 578.2 589.5 599.1 601.2 608.6 594.9 618.3 622.6 623.5 632.6 8944.6 9142.7 9148.8 9162.6 9202.4 566.1 596.3 613.9 619.6 689.6 3957.9 3964.6 4007.5 4009.4 4119.9 64427.0 65569.0 65687.7 68084.3 68215.7 60704.4 60983.1 61059.4 61386.7 62815.0 55236.0 55811.4 56179.0 56742.0 57570.7 8332.5 8579.8 8587.7 8592.0 8738.4 37447.0 38287.4 38387.0 38568.8 39037.2 47357.0 49731.0 50164.0 50576.0 50804.2 11419.8 11460.3 11544.9 11584.9 11712.5 12250.0 12321.0 12450.6 12756.0 13015.8 11588.3 11637.9 11781.2 11920.0 12623.7 10970.7 10989.7 11444.5 11546.0 11621.1 10697.3 10800.6 10863.3 11227.1 11294.3 9899.7 9952.2 10142.1 10498.5 10530.2 9666.7 10156.3 10160.7 10196.7 10221.7 03:00:24 INFO - PROCESS | 26753 | -------- Summary: end -------- 03:00:24 INFO - PROCESS | 26753 | 03:00:25 INFO - TEST-INFO | 26753: exit 0 03:00:25 INFO - TEST-OK | dromaeo_css | took 1113949ms 03:00:25 INFO - TEST-START | kraken 03:00:25 INFO - operating with platform_type : linux_ 03:00:25 INFO - Initialising browser for kraken test... 03:00:25 INFO - TEST-INFO | started process 26932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9lHWd/profile http://localhost:38716/getInfo.html) 03:00:29 INFO - PROCESS | 26932 | __metrics Screen width/height:1600/1200 03:00:29 INFO - PROCESS | 26932 | colorDepth:24 03:00:29 INFO - PROCESS | 26932 | Browser inner width/height: 1024/697 03:00:29 INFO - PROCESS | 26932 | __metrics 03:00:30 ERROR - PROCESS | 26932 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:00:31 INFO - TEST-INFO | 26932: exit 0 03:00:31 INFO - Browser initialized. 03:00:31 INFO - Running cycle 1/1 for kraken test... 03:00:31 INFO - TEST-INFO | started process 27012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9lHWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:43 INFO - PROCESS | 27012 | RSS: Main: 155369472 03:00:43 INFO - PROCESS | 27012 | 03:00:45 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38716/tests/kraken/driver.html?testName=audio-beat-detection) 03:00:46 INFO - PROCESS | 27012 | RSS: Main: 214351872 03:00:46 INFO - PROCESS | 27012 | 03:00:49 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38716/tests/kraken/driver.html?testName=audio-dft) 03:00:49 INFO - PROCESS | 27012 | RSS: Main: 198754304 03:00:49 INFO - PROCESS | 27012 | 03:00:52 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38716/tests/kraken/driver.html?testName=audio-fft) 03:00:53 INFO - PROCESS | 27012 | RSS: Main: 268935168 03:00:53 INFO - PROCESS | 27012 | 03:00:55 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38716/tests/kraken/driver.html?testName=audio-oscillator) 03:00:56 INFO - PROCESS | 27012 | RSS: Main: 179720192 03:00:56 INFO - PROCESS | 27012 | 03:00:58 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38716/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:00:58 INFO - PROCESS | 27012 | RSS: Main: 184143872 03:00:58 INFO - PROCESS | 27012 | 03:01:01 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38716/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:02 INFO - PROCESS | 27012 | RSS: Main: 217743360 03:01:02 INFO - PROCESS | 27012 | 03:01:05 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38716/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:06 INFO - PROCESS | 27012 | RSS: Main: 220786688 03:01:06 INFO - PROCESS | 27012 | 03:01:09 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38716/tests/kraken/driver.html?testName=json-parse-financial) 03:01:09 INFO - PROCESS | 27012 | RSS: Main: 220381184 03:01:09 INFO - PROCESS | 27012 | 03:01:11 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38716/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:12 INFO - PROCESS | 27012 | RSS: Main: 209154048 03:01:12 INFO - PROCESS | 27012 | 03:01:13 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:14 INFO - PROCESS | 27012 | RSS: Main: 211353600 03:01:14 INFO - PROCESS | 27012 | 03:01:16 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:17 INFO - PROCESS | 27012 | RSS: Main: 217923584 03:01:17 INFO - PROCESS | 27012 | 03:01:19 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:20 INFO - PROCESS | 27012 | RSS: Main: 222732288 03:01:20 INFO - PROCESS | 27012 | 03:01:23 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:23 INFO - PROCESS | 27012 | RSS: Main: 223318016 03:01:23 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | Cycle 1(1): loaded http://localhost:38716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38716/tests/kraken/driver.html?testName=ai-astar) 03:01:25 INFO - PROCESS | 27012 | RSS: Main: 265478144 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | __start_tp_report 03:01:25 INFO - PROCESS | 27012 | _x_x_mozilla_page_load 03:01:25 INFO - PROCESS | 27012 | _x_x_mozilla_page_load_details 03:01:25 INFO - PROCESS | 27012 | |i|pagename|runs| 03:01:25 INFO - PROCESS | 27012 | |0;ai-astar;112;106;111;109;110;110;112;111;109;109 03:01:25 INFO - PROCESS | 27012 | |1;audio-beat-detection;151;132;127;180;128;129;153;128;174;126 03:01:25 INFO - PROCESS | 27012 | |2;audio-dft;161;160;161;159;160;160;159;160;160;161 03:01:25 INFO - PROCESS | 27012 | |3;audio-fft;74;74;74;119;74;75;73;75;97;76 03:01:25 INFO - PROCESS | 27012 | |4;audio-oscillator;83;83;115;84;84;83;117;83;83;120 03:01:25 INFO - PROCESS | 27012 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;116;116 03:01:25 INFO - PROCESS | 27012 | |6;imaging-darkroom;145;145;146;147;147;149;145;145;146;146 03:01:25 INFO - PROCESS | 27012 | |7;imaging-desaturate;94;94;95;95;95;96;95;95;96;95 03:01:25 INFO - PROCESS | 27012 | |8;json-parse-financial;54;54;53;54;53;54;56;54;54;54 03:01:25 INFO - PROCESS | 27012 | |9;json-stringify-tinderbox;62;62;62;63;63;63;62;62;68;63 03:01:25 INFO - PROCESS | 27012 | |10;stanford-crypto-aes;80;80;82;79;79;81;81;82;115;80 03:01:25 INFO - PROCESS | 27012 | |11;stanford-crypto-ccm;123;136;124;120;118;122;119;122;125;148 03:01:25 INFO - PROCESS | 27012 | |12;stanford-crypto-pbkdf2;163;159;159;166;162;159;160;159;158;163 03:01:25 INFO - PROCESS | 27012 | |13;stanford-crypto-sha256-iterative;64;64;62;62;62;62;62;63;65;67 03:01:25 INFO - PROCESS | 27012 | __end_tp_report 03:01:25 INFO - PROCESS | 27012 | __start_cc_report 03:01:25 INFO - PROCESS | 27012 | _x_x_mozilla_cycle_collect,1627 03:01:25 INFO - PROCESS | 27012 | __end_cc_report 03:01:25 INFO - PROCESS | 27012 | __startTimestamp1464688885597__endTimestamp 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | ------- Summary: start ------- 03:01:25 INFO - PROCESS | 27012 | Number of tests: 14 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.79 (1.6%) stddev-sans-first:1.73 03:01:25 INFO - PROCESS | 27012 | Values: 112.0 106.0 111.0 109.0 110.0 110.0 112.0 111.0 109.0 109.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:141.50 stddev:20.56 (14.5%) stddev-sans-first:21.60 03:01:25 INFO - PROCESS | 27012 | Values: 151.0 132.0 127.0 180.0 128.0 129.0 153.0 128.0 174.0 126.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 03:01:25 INFO - PROCESS | 27012 | Values: 161.0 160.0 161.0 159.0 160.0 160.0 159.0 160.0 160.0 161.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:15.12 (20.3%) stddev-sans-first:15.81 03:01:25 INFO - PROCESS | 27012 | Values: 74.0 74.0 74.0 119.0 74.0 75.0 73.0 75.0 97.0 76.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:16.49 (19.9%) stddev-sans-first:17.05 03:01:25 INFO - PROCESS | 27012 | Values: 83.0 83.0 115.0 84.0 84.0 83.0 117.0 83.0 83.0 120.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:01:25 INFO - PROCESS | 27012 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.29 (0.9%) stddev-sans-first:1.30 03:01:25 INFO - PROCESS | 27012 | Values: 145.0 145.0 146.0 147.0 147.0 149.0 145.0 145.0 146.0 146.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 03:01:25 INFO - PROCESS | 27012 | Values: 94.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 03:01:25 INFO - PROCESS | 27012 | Values: 54.0 54.0 53.0 54.0 53.0 54.0 56.0 54.0 54.0 54.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.90 03:01:25 INFO - PROCESS | 27012 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 62.0 62.0 68.0 63.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.50 stddev:10.98 (13.6%) stddev-sans-first:11.55 03:01:25 INFO - PROCESS | 27012 | Values: 80.0 80.0 82.0 79.0 79.0 81.0 81.0 82.0 115.0 80.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:123.50 stddev:9.30 (7.5%) stddev-sans-first:9.81 03:01:25 INFO - PROCESS | 27012 | Values: 123.0 136.0 124.0 120.0 118.0 122.0 119.0 122.0 125.0 148.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.57 (1.6%) stddev-sans-first:2.60 03:01:25 INFO - PROCESS | 27012 | Values: 163.0 159.0 159.0 166.0 162.0 159.0 160.0 159.0 158.0 163.0 03:01:25 INFO - PROCESS | 27012 | 03:01:25 INFO - PROCESS | 27012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.70 (2.7%) stddev-sans-first:1.79 03:01:25 INFO - PROCESS | 27012 | Values: 64.0 64.0 62.0 62.0 62.0 62.0 62.0 63.0 65.0 67.0 03:01:25 INFO - PROCESS | 27012 | -------- Summary: end -------- 03:01:25 INFO - PROCESS | 27012 | 03:01:26 INFO - TEST-INFO | 27012: exit 0 03:01:26 INFO - TEST-OK | kraken | took 61475ms 03:01:26 INFO - SUITE-END | took 1175s 03:01:26 INFO - Completed test suite (00:19:35) 03:01:26 INFO - javascript benchmark 03:01:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.274746808234, 3161.984190079048, 3181.490961446169, 3206.8396580171016, 3231.547583338333, 5342.492463215998, 5421.701806400656, 5469.316335458067, 5478.506934375905, 5494.478024587663, 5489.1217405215175, 5507.228987941691, 5539.086050801623, 5579.553635709143, 5628.0, 4914.2874283229, 4958.454569997315, 5001.749912504379, 5013.523715247064, 5098.770555325019, 5035.395752509704, 5055.292259083732, 5084.822031228908, 5110.156824124015, 5115.53960143587, 4888.046830867965, 4935.062338155757, 4964.776585053663, 5001.0, 5030.270610761456, 4915.311856340079, 4919.704817710913, 4922.015596880638, 4932.876678083041, 4989.101961646902, 4886.584640305578, 4922.729249891255, 4938.876528086791, 4946.0, 4966.453690094087, 5282.181261904411, 5345.438728933484, 5346.518813306821, 5351.7056561889085, 5456.945430545684, 5880.117982302646, 5918.112283157561, 5924.763009479659, 5930.347661757203, 5937.52499800015, 5935.554833387513, 5955.642661440327, 5961.493273071794, 5965.5525835562075, 5966.791162309299, 5429.484199001088, 5552.472515111058, 5604.243427137325, 5615.241942337773, 5681.318241810926, 6162.876742465215, 6166.445019948226, 6169.660668663267, 6171.6297022178815, 6174.38256174379, 5682.857928551819, 5918.0, 5923.437273459014, 5968.761249550056, 5981.820545383645, 5885.676287804212, 5966.910496342558, 5968.403159683997, 5997.400259974055, 5998.25021872266, 5932.7330270137945, 5961.791337303173, 5970.641761494324, 5973.581849270509, 5982.4316689914385, 5700.857478563069, 5847.649141051551, 5985.0, 5991.970040149771, 5994.190784244159, 4499.59503644667, 4518.909621807546, 4522.88692782683, 4559.179347717442, 4562.452505699337, 4001.1197536541913, 4014.458048163519, 4026.6577340925764, 4037.858674946363, 4048.6356227939627, 5414.133738601805, 5455.427180146107, 5628.634138780966, 5651.463111004448, 5653.689047102366, 5894.705264736746, 5950.553708471882, 5999.820005399845, 6057.212562366864, 6063.605865618721, 5642.830715078554, 5648.548116150698, 5648.943510564842, 5651.4348565143155, 5654.151877218368, 4967.2549117631925, 5054.82308119214, 5157.793688252503, 5167.4832516748775, 5170.0, 6104.481119104837, 6154.0, 6155.230596175567, 6163.414475624809, 6179.073139029181, 5976.820695379146, 5976.8804623908145, 5987.221661184019, 6003.549733769897, 6009.969950150221, 5983.461488466059, 6079.452849243412, 6082.60463069899, 6125.785597504066, 6165.876682466236, 5821.359650438533, 5852.531797456279, 5852.795152169653, 5858.443447872445, 5905.704714764331, 5912.940870591411, 5955.106733989763, 5964.224650795369, 5967.46292833647, 5975.850603734942, 5705.429457054427, 5752.194692743103, 5789.913151302818, 5807.796727114531, 5826.126081087701, 5817.331006934257, 5829.417058294137, 5834.970825145847, 5840.912386314294, 5842.970785146047, 5669.773209071756, 5670.432956704297, 5672.404397538364, 5682.147677848356, 5686.886262274648, 5717.914231286451, 5798.94201057984, 5864.384239654775, 5868.061110222515, 5966.522678185822, 5728.570357223308, 5732.4267573244015, 5754.741036653277, 5768.682722450306, 5806.477417032487], "value": 5457.73177245037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2427309541762, 613.0742578706155, 613.9416755408236, 617.546103613844, 637.6461064109418, 30154.849225753867, 30807.229819254502, 33310.66689333112, 33353.49969750453, 41764.79117604408, 40992.79503602485, 45284.320735189, 45307.773461132645, 45340.319895201515, 45346.31980520295, 8730.51982140982, 8922.821543569125, 8924.196822285992, 8930.0, 8961.77595560113, 8688.218060374566, 8860.0, 8860.689875854347, 8864.778380540474, 8869.068747781486, 8927.0, 8982.281417486618, 8987.415817971843, 8987.64049438025, 8990.775230619221, 8852.291816654651, 8880.333974951873, 8900.51047192404, 8907.599158037903, 8913.153250441197, 8815.206631403205, 8899.73300800977, 8904.332175086894, 8904.421212621159, 8912.64349426022, 41884.37173442401, 42120.78939605282, 42186.0, 42249.78875105635, 42356.15287694229, 3185.5221716742676, 3350.8827191048194, 3581.7313701472494, 3705.4441833724886, 3786.659200671953, 31220.687793122004, 31299.0, 31345.686543134503, 31541.369172616418, 32306.192345191324, 4308.82764689412, 4320.82716691332, 4401.801918913625, 4457.910841783146, 4503.099380123988, 351648.0, 354224.0, 355826.0, 357682.0, 359724.0, 58423.41576584265, 58872.7056364724, 58931.41068589345, 58969.41030589725, 59054.0, 60670.393296067356, 60918.69540652268, 61036.38963610307, 61116.0, 61154.38845611576, 15815.367385304458, 16152.273147708147, 16178.514644560682, 16187.271572779253, 16206.432774852823, 12367.752644947052, 12578.874211257771, 12581.748365032649, 12597.11820172579, 12610.0, 13591.796123058162, 15749.370025199092, 15798.68402631941, 15838.52484425469, 16008.599785005468, 5223.13818219997, 5898.498627616615, 6053.727582258809, 6104.694765261719, 6131.172291740647, 993.6869885985891, 1021.9693409197736, 1026.8819085805078, 1040.9271351005357, 1082.285691443659, 30898.0, 31015.534766978515, 31152.376952460825, 31664.841675791933, 31942.680573194437, 1099.8790133085354, 1116.9218154729253, 1122.938238396896, 1140.914431417647, 1214.631468636163, 15968.201589920458, 16443.01341919465, 16496.34014639425, 16507.66984660324, 16632.085235312174, 570270.0, 573029.0, 575296.0, 575493.0, 575740.0, 58219.417805822246, 59383.40616593865, 59498.70250648806, 59508.40491595115, 59566.0, 1272.389253158489, 1366.4397596985189, 1367.8221831162084, 1401.8457969623332, 1409.041851540962, 30595.694043059284, 32167.51748723724, 32443.0, 32613.0, 32811.50782738213, 48123.278150827064, 48484.2727359097, 48657.5134248653, 48669.5133048665, 48695.26957095717, 402633.0, 405636.0, 406268.0, 406629.0, 406757.0, 33304.33391332208, 35282.82358588191, 40882.0, 41830.79084604557, 44759.0, 47763.0, 47819.76090119527, 48180.51819481901, 49160.50839491702, 49426.25860612166, 40331.395029074, 41255.7937210312, 41604.58395416007, 41641.375379369936, 42422.36366454444, 40230.39654405245, 40575.39136913008, 40725.389119162646, 41583.168336632494, 41965.1606967865, 40543.79728101341, 41250.58749412467, 41321.380179296735, 41399.58600414078, 41870.58129418789, 34764.0, 36228.0, 36488.635113648525, 36601.0, 37254.0, 27619.0, 27721.722782771914, 27831.860840695666, 27859.303517412227, 27921.860390697915], "value": 19915.257024600913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.98652547160845, 394.99012524686884, 399.96800255979525, 401.7509144330512, 409.4656473302341, 14284.78572821406, 16785.24466399012, 18210.5447363816, 19708.704369434436, 19765.901170494144, 15292.923535382308, 15475.226238688048, 15822.446214382499, 18754.71867921979, 18788.71816922744, 5454.4545545445535, 5462.344518657756, 5599.692016939067, 5628.409017053212, 5654.038813401711, 4088.8568900088503, 5552.222688823568, 5561.888762224753, 5653.180288858113, 5664.895345407647, 6025.367336429677, 6297.968510157443, 6302.527310451712, 6414.615123092606, 6422.0, 6294.496440284789, 6362.713677884483, 6363.395477429637, 6364.077208804743, 6383.585066970655, 5482.753276102585, 5589.580781441408, 5599.580031497654, 5601.187827764951, 5628.155776633497, 21961.0, 22064.33806985793, 22133.446663833372, 22329.441763955867, 22666.0, 2226.3988723044686, 2272.9545409091893, 2275.108368049175, 2584.134315004476, 2715.2261605442354, 13534.0, 14023.0, 14089.788653170212, 14492.34784434703, 14494.275286235646, 1766.726157445598, 1814.3649722597117, 1814.6442185514602, 1817.3366721146817, 1844.1516902224857, 73261.6336918312, 75958.62020689917, 76414.23585764127, 76540.0, 80773.59613201897, 10223.897761022443, 10489.895101049044, 10854.67435976922, 10985.505652245669, 11015.559377624806, 13372.531961381304, 15365.769513457308, 15376.38494460209, 15390.0, 15399.692006159814, 7692.307692307719, 7822.452428330076, 8065.959670201729, 8069.072056713436, 8209.220124088202, 7669.271419215165, 7748.535087894745, 7783.377329813601, 7859.72490962825, 7909.05091389037, 4677.953220467752, 4715.104130215248, 4741.431028276629, 4778.307145463958, 4830.758462076882, 1836.3848110882736, 1915.367928583564, 1930.7972662870197, 1958.7180934211483, 1959.7648282206226, 940.8917974432891, 946.8816397950256, 988.6935050134481, 1051.9368837869752, 1108.0858291909208, 17898.284068637367, 18709.43871683852, 18835.905820471085, 18838.90580547116, 18941.62116757657, 980.5734505490135, 994.5077186792439, 997.4912794474725, 1008.6822650864954, 1013.5641674080216, 10142.645007424704, 10620.309679870783, 10696.51865666047, 10704.30422022566, 10778.191635627203, 368008.0, 452652.0, 459007.0, 461637.0, 462904.0, 94226.0, 96881.0, 98716.12838716072, 100389.49805250927, 103372.0, 961.293449314753, 1014.9391036537684, 1021.8007488539663, 1025.9692209233735, 1063.3088492479949, 16320.18399080065, 16688.666226675643, 16954.660906781548, 16970.915145424195, 17468.563285917953, 41293.793531032155, 42496.15007699767, 42499.0, 42765.57234427616, 43043.56956430521, 59778.70110649419, 59848.10227846499, 61844.0, 62210.0, 62264.0, 8571.571421428778, 8592.957035215033, 8612.18184272493, 8642.265407440187, 8679.392442528962, 9431.95284023603, 12262.877371226174, 12917.160384574972, 12967.546135885199, 12975.545855894998, 8665.696700615448, 10656.786864262827, 11385.316880987168, 11443.542258309575, 11500.712482188012, 10408.895911040792, 11379.146564007899, 11438.828417573577, 11452.08383329315, 11593.59422420245, 11451.141164412536, 11547.884521154681, 11834.82247766267, 11853.822192666945, 12009.759804804029, 8377.078521362524, 8435.072142064246, 8529.275011624082, 8666.393352465268, 8729.476231426135, 11167.609133680282, 11411.60059397917, 11429.771404572028, 11455.689879108868, 11521.135914806591], "value": 9156.124886639729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.366250537237, 1462.4442711769525, 1509.4490510963499, 1698.7536807162953, 1810.8822926509783, 8596.828063438728, 9025.458472491648, 9037.819243615124, 9222.216111630503, 9279.768005799859, 9082.091790820914, 9247.815043699138, 9250.67622633208, 9254.07459254076, 9256.213221876149, 2046.2735728816278, 2263.343630347197, 2337.228714524203, 2355.8233132515043, 2382.8808559571953, 2265.3883451468096, 2265.535565209128, 2270.648049552322, 2270.9772902271015, 2273.658951157323, 2310.6880571122933, 2311.1217737259817, 2341.8360714749974, 2341.8594884306913, 2345.155743932183, 1940.1657287366427, 2191.561687662474, 2241.4396400899777, 2248.898799554024, 2264.7395549511853, 2279.0428020231543, 2295.391721193885, 2306.8615883046905, 2311.0986715181093, 2313.7570555091643, 9277.860832087525, 9280.72157835266, 9322.766930826716, 9334.71995840126, 9335.0, 5147.073526765181, 5254.65844720092, 5269.604779641542, 5299.152135658276, 5301.575873930076, 3192.680731926812, 3374.746893982961, 3387.5257463955068, 3460.2387474755515, 3482.407990641572, 1001.8196724589571, 1017.069381515912, 1025.5590096258607, 1091.0889407344876, 1104.0394856474838, 13238.073334866564, 13248.47006119754, 13279.136856104225, 13279.53521626748, 13282.402291896888, 4420.204363214652, 4523.2988886722615, 4570.428696412949, 4640.11837750833, 4644.349791029259, 10977.28647637901, 10981.231313807957, 10985.450727463594, 10987.39569323679, 10999.175061870392, 5039.571636410873, 5113.028524580318, 5115.565176959925, 5121.743912804345, 5121.923171152435, 4318.35224716295, 4661.417322834645, 4801.423829140525, 4809.687370320918, 4856.247281671346, 3983.4224037514978, 4018.3168861293652, 4096.201240758023, 4101.323281658552, 4123.36087906375, 1285.2738202915323, 1295.533607901155, 1304.8564657887625, 1305.2364366845502, 1318.967025824362, 847.3602430165186, 870.5603670146536, 870.8200388473654, 876.2945828607905, 891.9777005574913, 5917.911231331534, 5922.7927022554, 6028.728707208186, 6140.570160088841, 6305.14880491137, 941.8116376724682, 942.9057094290654, 951.8905325887473, 953.7186529973675, 964.5852283518014, 3745.1573395985683, 3848.3265428550453, 3850.268448994682, 3894.2990261753157, 3910.1397692507603, 11131.833022504668, 11790.0, 11851.111166662535, 11885.28688278706, 11894.226875253082, 11411.0, 11649.068074554016, 11687.065034797195, 11695.298282103102, 11800.055995520337, 8585.65657373698, 8664.8700269496, 8665.696700615448, 8693.956530217181, 8717.171868672465, 5555.527780138734, 5580.079286917776, 5598.216249725123, 5633.436656334334, 5719.5710321726865, 10720.410377429316, 10799.190060745319, 10820.998115348686, 10827.24209305341, 10852.348859068481, 10782.784344312913, 10934.45327733626, 10980.066694330751, 11045.171612128961, 11129.276597021168, 6996.755113571001, 7177.1746249182015, 7342.155652100077, 7425.777226683208, 7533.096028476399, 8659.393842430969, 8673.0, 8729.476231426135, 8758.080401557745, 8760.474371537728, 7565.43259255547, 7779.649915753692, 7841.372690184886, 7845.882311765214, 7912.0505539335645, 7491.775246742606, 7564.130125035691, 7628.199039101037, 7684.846303073796, 7722.15056343813, 6471.417572418505, 6532.248791389051, 6532.314107018695, 6545.738170473128, 6558.704858281484, 4633.258678611406, 4666.533346665306, 4720.22116350812, 4734.928976065293, 4785.0, 4814.398200224972, 4827.589654879374, 4847.587955023862, 4961.7271050092595, 5057.0], "value": 4640.0941063925975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.44402960862897, 321.6831421050266, 329.4251531078268, 329.48271214193727, 332.801982820222, 5265.7893684252585, 5311.601629877765, 5327.360716714, 5337.332833395825, 5370.087085195516, 5290.1220066876285, 5290.206469029647, 5293.0, 5310.946890531093, 5316.867078323035, 3954.110325176841, 4058.5738497457783, 4066.9186616267657, 4074.309161697892, 4094.1197642506854, 4135.27632664284, 4147.377893316012, 4148.481439820022, 4151.709380343377, 4168.312228482297, 4024.3359845625437, 4075.8383860599733, 4123.711340206187, 4131.636559935214, 4143.212789569987, 4056.067104565937, 4088.897777555555, 4097.8281510799325, 4125.278076336659, 4131.421600975851, 3646.6353364663587, 3649.708023358125, 3654.6528079832374, 3654.7705899401344, 3668.6147954464664, 5059.519345662156, 5086.694798312076, 5097.8215762448135, 5101.336826212606, 5111.028904508169, 4646.210144275447, 4703.694259873131, 4748.525147485224, 4755.430707866431, 4773.212419950704, 5460.453954604508, 5481.260029895953, 5508.55931525477, 5552.444755524456, 5562.749676264578, 3977.8607748728655, 3984.78464068459, 4021.617946295097, 4056.6146216109423, 4059.8985025374304, 5633.60564760467, 5764.221830052931, 5785.363610002896, 5789.594728369016, 5792.275965504312, 4087.529934057562, 4090.8159132839096, 4110.938335924963, 4129.731567448166, 4132.0, 4183.330667093251, 4192.769397683157, 4204.26425375558, 4214.936775948363, 4222.493300803923, 4429.955700442954, 4724.551167639069, 4785.138675038526, 4805.765319126623, 4806.687565308313, 5536.197251398525, 5560.499555040065, 5571.66570005801, 5587.469190426903, 5604.907043126551, 1380.875721185078, 1387.5906607550796, 1393.9197122230353, 1401.9439222431192, 1402.9298535073206, 888.1828717579842, 897.0984160918235, 901.7024381953939, 902.9006809250977, 918.7749001494676, 4826.300186472942, 5223.712695801692, 5327.706976116351, 5347.625666203328, 5361.463853614685, 5616.747246373923, 5669.801556945569, 5687.118496633028, 5698.601097923189, 5732.394929419769, 5349.839504814861, 5383.2194331821665, 5387.030334539742, 5393.2449457076045, 5395.568354531628, 2880.495913215179, 3047.4362242985117, 3059.9847000764853, 3063.2801291696433, 3098.7675924305768, 5898.793542226002, 5904.350521442638, 6006.6485040865455, 6016.729247183887, 6026.6986650667295, 5509.531689806331, 5834.891370639565, 5849.61977471463, 5886.676232807151, 5896.911546326808, 5883.352831188651, 5893.44012318829, 5919.911201331897, 5935.821925342247, 6001.849953751103, 5521.69630670317, 5716.5998380113, 5768.3078030634915, 5827.912581311199, 5861.32952108647, 5654.529822246328, 5674.829755107354, 5687.146927960839, 5695.658260504383, 5710.942890571041, 5912.881742365214, 5958.880822383615, 5977.701114944322, 5997.280326360865, 6002.069679199731, 4021.1957608479006, 4081.89795255121, 4108.856190033334, 4118.814653340547, 4142.171565686815, 5758.128608202267, 5802.361740208658, 5814.703192239126, 5817.214676018683, 5821.933213709072, 5357.624966252325, 5627.127795191752, 5635.943640563706, 5672.404397538199, 5676.7445464955, 5361.919571206513, 5610.551155907436, 5622.943770562242, 5630.324361076697, 5658.274226361, 5397.649152805055, 5429.647072940246, 5435.315052333789, 5438.510534051954, 5444.537214336826, 5450.672959622435, 5607.794324220149, 5631.605787594829, 5634.352049514195, 5638.971805140948, 5494.955958367897, 5524.14375771756, 5535.418781027934, 5544.584156188383, 5550.113940750868], "value": 4244.874509632958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.2177118085381, 730.8684436801377, 747.9864783218738, 767.9347255483284, 782.1708988472217, 13308.667283317922, 14823.036502627321, 14999.85000149998, 15163.848361516382, 15188.088714677127, 14064.296785160752, 14080.788788168185, 14091.929540352285, 14116.788248176259, 14126.57620271391, 794.13835987953, 797.6609940775177, 798.1380109481775, 798.4969469234403, 806.2783808491397, 791.4024911192071, 791.6872835230081, 791.711025475703, 791.956442395668, 792.3067316098413, 699.1016543741268, 719.7768691705588, 720.4488566246825, 821.8356328734247, 837.5812093953024, 824.8226631274244, 833.1918039501674, 841.2807049972308, 843.4559708987699, 845.5898889038842, 626.0140279060453, 626.1296797451546, 626.3141859663662, 627.6485168305763, 629.6285191736852, 13329.666758331023, 13415.731685366238, 13416.86583134166, 13427.731445371135, 13442.596722098255, 11842.822357664641, 13756.380962856696, 13769.105008174536, 14326.71346573073, 14482.565523034325, 11010.724731881686, 11047.613333533369, 11056.11551075912, 11110.333379997146, 11349.20555561111, 3650.707943364551, 3695.334839728848, 3706.2772759311947, 3726.6832319252626, 3950.683945284399, 56270.71864640692, 56622.0, 56742.0, 56815.14777278386, 56983.71508142474, 10445.582176712845, 10495.790084198426, 10683.198760092868, 10702.732431689114, 11153.275037122561, 19853.0, 19873.60252794965, 19981.300654477025, 20003.899980500297, 20018.299359522345, 8174.223448772357, 8289.0, 8331.041930177986, 8357.916420835836, 8478.364122690822, 4573.817047318136, 4709.505501922317, 4746.5490778376, 4784.354112194878, 4955.504449555087, 3396.1679388549965, 3485.337785820686, 3486.5467489226744, 3487.05849420655, 3488.389531831919, 578.2453897663589, 589.4694774702716, 599.0744300056423, 601.1964404408743, 608.6165715599233, 594.9405059494015, 618.2704408797572, 622.6046460497527, 623.479394705417, 632.5793347424003, 8944.597493112826, 9142.680006199884, 9148.817023659489, 9162.587683554257, 9202.35583509148, 566.077294010768, 596.3023262782555, 613.8680183760513, 619.575590720358, 689.582802404548, 3957.940630890539, 3964.6035396460125, 4007.458993035903, 4009.4386785850006, 4119.8970025749595, 64427.0, 65569.0, 65687.67156164284, 68084.3191568078, 68215.65892170607, 60704.392956070755, 60983.08525372123, 61059.38940610626, 61386.69306653438, 62815.0, 55236.0, 55811.44188558144, 56179.0, 56742.0, 57570.712146439, 8332.50004999702, 8579.785505362415, 8587.742367728979, 8591.957040214758, 8738.388312818042, 37447.0, 38287.42568861525, 38387.0, 38568.80715596404, 39037.21925561416, 47357.0, 49731.0, 50164.0, 50576.0, 50804.237936431724, 11419.771604568028, 11460.255083419552, 11544.88455115438, 11584.929993551885, 11712.472938717608, 12250.0, 12320.968239591624, 12450.564230251897, 12756.043296752967, 13015.804762928374, 11588.304701717587, 11637.872975170796, 11781.234219775688, 11920.0, 12623.747525049632, 10970.670879873298, 10989.670309890716, 11444.542218311175, 11546.0, 11621.070314375, 10697.251192416456, 10800.567977280822, 10863.348199108079, 11227.101831853268, 11294.265872718248, 9899.663545421565, 9952.203823693942, 10142.137918277029, 10498.527566259689, 10530.157587393143, 9666.709998700051, 10156.289059765746, 10160.745981350525, 10196.745081372728, 10221.693349199535], "value": 6612.352265868332, "unit": "score"}], "name": "dromaeo_css", "value": 7114.050166906258, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 109.0, 110.0, 110.0, 112.0, 111.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 132.0, 127.0, 180.0, 128.0, 129.0, 153.0, 128.0, 174.0, 126.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 160.0, 160.0, 159.0, 160.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 119.0, 74.0, 75.0, 73.0, 75.0, 97.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 84.0, 84.0, 83.0, 117.0, 83.0, 83.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 147.0, 149.0, 145.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 56.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 68.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 79.0, 79.0, 81.0, 81.0, 82.0, 115.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 136.0, 124.0, 120.0, 118.0, 122.0, 119.0, 122.0, 125.0, 148.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 159.0, 166.0, 162.0, 159.0, 160.0, 159.0, 158.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 65.0, 67.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1495.8, "alertThreshold": 2.0}]} 03:01:26 INFO - Return code: 0 03:01:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:01:26 ERROR - # TBPL SUCCESS # 03:01:26 INFO - Running post-action listener: _resource_record_post_action 03:01:26 INFO - ##### 03:01:26 INFO - ##### Finished run-tests step (success) 03:01:26 INFO - ##### 03:01:26 INFO - Running post-run listener: _resource_record_post_run 03:01:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538804224; Read time: 208; Write time: 623988 03:01:26 INFO - TinderboxPrint: CPU usage
13.1% 03:01:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 03:01:26 INFO - TinderboxPrint: I/O write bytes / time
538,804,224 / 623,988 03:01:26 INFO - TinderboxPrint: CPU idle
8,270.2 (86.9%) 03:01:26 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 03:01:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:01:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247365632; Read time: 0; Write time: 359520 03:01:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291438592; Read time: 208; Write time: 264468 03:01:27 INFO - Running post-run listener: _upload_blobber_files 03:01:27 INFO - Blob upload gear active. 03:01:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:27 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 03:01:27 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'] 03:01:27 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 03:01:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:01:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:28 INFO - (blobuploader) - INFO - Done attempting. 03:01:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:01:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:01:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:29 INFO - (blobuploader) - INFO - Done attempting. 03:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:33 INFO - (blobuploader) - INFO - Done attempting. 03:01:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:33 INFO - Return code: 0 03:01:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee05d8e2c12f8e06da5678e432bb6a558e9525bb2f8b731e123eb7fc649af46f7f8631850f42f7dd1c425807d5706549447f7e65b86cca6cc7aadd649efa8c56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55eb4aea9b66978a7371e858e2103ce7389ec793d4651f75a4044d81a194b25f91c401b1642a380228234f3c357b1d1e077b35bb602e7326ba7f0c6772ad2786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c9b2b3f3097bd47dd06fdf40f8b30131ffc2c4f6e8101d238fc0c11017005ee94c88fa9b4ded98f066ac5d6edabab35833a564cb0ce009445005b5f0e3a4c9"} 03:01:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:33 INFO - Contents: 03:01:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee05d8e2c12f8e06da5678e432bb6a558e9525bb2f8b731e123eb7fc649af46f7f8631850f42f7dd1c425807d5706549447f7e65b86cca6cc7aadd649efa8c56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55eb4aea9b66978a7371e858e2103ce7389ec793d4651f75a4044d81a194b25f91c401b1642a380228234f3c357b1d1e077b35bb602e7326ba7f0c6772ad2786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c9b2b3f3097bd47dd06fdf40f8b30131ffc2c4f6e8101d238fc0c11017005ee94c88fa9b4ded98f066ac5d6edabab35833a564cb0ce009445005b5f0e3a4c9"} 03:01:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:33 INFO - Copying logs to upload dir... 03:01:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.343313 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-31 03:01:33.122829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 03:01:33.128262) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 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/ee05d8e2c12f8e06da5678e432bb6a558e9525bb2f8b731e123eb7fc649af46f7f8631850f42f7dd1c425807d5706549447f7e65b86cca6cc7aadd649efa8c56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55eb4aea9b66978a7371e858e2103ce7389ec793d4651f75a4044d81a194b25f91c401b1642a380228234f3c357b1d1e077b35bb602e7326ba7f0c6772ad2786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c9b2b3f3097bd47dd06fdf40f8b30131ffc2c4f6e8101d238fc0c11017005ee94c88fa9b4ded98f066ac5d6edabab35833a564cb0ce009445005b5f0e3a4c9"} 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.011386 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/ee05d8e2c12f8e06da5678e432bb6a558e9525bb2f8b731e123eb7fc649af46f7f8631850f42f7dd1c425807d5706549447f7e65b86cca6cc7aadd649efa8c56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55eb4aea9b66978a7371e858e2103ce7389ec793d4651f75a4044d81a194b25f91c401b1642a380228234f3c357b1d1e077b35bb602e7326ba7f0c6772ad2786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6c9b2b3f3097bd47dd06fdf40f8b30131ffc2c4f6e8101d238fc0c11017005ee94c88fa9b4ded98f066ac5d6edabab35833a564cb0ce009445005b5f0e3a4c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 03:01:33.158111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:01:33.158452) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464683628.351037-1499398584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:01:33.244981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 03:01:33.245735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 03:01:33.246409) ========= ========= Total master_lag: 0.21 =========