builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1450369953.8 results: success (0) buildid: 20151217073731 builduid: 9c3d458476f84970909d6116176dfa21 revision: 797cbaa987ef4679a43e0987505f9a8e38877860 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.801812) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.802314) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.802642) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006213 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.827103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.827416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.840888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.841327) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.890229) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.890662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.891147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:33.891442) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 08:32:34-- 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% 38.0M=0s 2015-12-17 08:32:34 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.097349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.097682) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014728 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.147359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.147727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 797cbaa987ef4679a43e0987505f9a8e38877860 --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 797cbaa987ef4679a43e0987505f9a8e38877860 --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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 08:32:34,553 truncating revision to first 12 chars 2015-12-17 08:32:34,553 Setting DEBUG logging. 2015-12-17 08:32:34,553 attempt 1/10 2015-12-17 08:32:34,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/797cbaa987ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 08:32:34,793 unpacking tar archive at: fx-team-797cbaa987ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.723066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.723395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.730945) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.731231) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:32:34.731646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 08:32:34.731926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:35 INFO - MultiFileLogger online at 20151217 08:32:35 in /builds/slave/test 08:32:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:32:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:35 INFO - {'append_to_log': False, 08:32:35 INFO - 'base_work_dir': '/builds/slave/test', 08:32:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:32:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:35 INFO - 'branch': 'Fx-Team-Non-PGO', 08:32:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:35 INFO - 'config_files': ('talos/linux_config.py',), 08:32:35 INFO - 'default_actions': ('clobber', 08:32:35 INFO - 'read-buildbot-config', 08:32:35 INFO - 'download-and-extract', 08:32:35 INFO - 'populate-webroot', 08:32:35 INFO - 'create-virtualenv', 08:32:35 INFO - 'install', 08:32:35 INFO - 'run-tests'), 08:32:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:35 INFO - 'download_minidump_stackwalk': True, 08:32:35 INFO - 'download_symbols': 'ondemand', 08:32:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:35 INFO - 'installer_path': 'installer.exe', 08:32:35 INFO - 'log_level': 'info', 08:32:35 INFO - 'log_name': 'talos', 08:32:35 INFO - 'log_to_console': True, 08:32:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:35 INFO - 'opt_config_files': (), 08:32:35 INFO - 'pip_index': False, 08:32:35 INFO - 'sps_profile': False, 08:32:35 INFO - 'sps_profile_interval': 0, 08:32:35 INFO - 'suite': 'dromaeojs', 08:32:35 INFO - 'system_bits': '64', 08:32:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:35 INFO - 'title': 'talos-linux64-ix-022', 08:32:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:35 INFO - 'use_talos_json': True, 08:32:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:35 INFO - 'work_dir': 'build'} 08:32:35 INFO - ##### 08:32:35 INFO - ##### Running clobber step. 08:32:35 INFO - ##### 08:32:35 INFO - Running pre-action listener: _resource_record_pre_action 08:32:35 INFO - Running main action method: clobber 08:32:35 INFO - rmtree: /builds/slave/test/build 08:32:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:35 INFO - Running post-action listener: _resource_record_post_action 08:32:35 INFO - ##### 08:32:35 INFO - ##### Running read-buildbot-config step. 08:32:35 INFO - ##### 08:32:35 INFO - Running pre-action listener: _resource_record_pre_action 08:32:35 INFO - Running main action method: read_buildbot_config 08:32:35 INFO - Using buildbot properties: 08:32:35 INFO - { 08:32:35 INFO - "project": "", 08:32:35 INFO - "product": "firefox", 08:32:35 INFO - "script_repo_revision": "production", 08:32:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:32:35 INFO - "repository": "", 08:32:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:32:35 INFO - "buildid": "20151217073731", 08:32:35 INFO - "pgo_build": "False", 08:32:35 INFO - "basedir": "/builds/slave/test", 08:32:35 INFO - "buildnumber": 1024, 08:32:35 INFO - "slavename": "talos-linux64-ix-022", 08:32:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:32:35 INFO - "platform": "ubuntu64_hw", 08:32:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:32:35 INFO - "branch": "fx-team", 08:32:35 INFO - "repo_path": "integration/fx-team", 08:32:35 INFO - "revision": "797cbaa987ef4679a43e0987505f9a8e38877860", 08:32:35 INFO - "stage_platform": "linux64", 08:32:35 INFO - "builduid": "9c3d458476f84970909d6116176dfa21", 08:32:35 INFO - "slavebuilddir": "test" 08:32:35 INFO - } 08:32:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:32:35 INFO - Running post-action listener: _resource_record_post_action 08:32:35 INFO - ##### 08:32:35 INFO - ##### Running download-and-extract step. 08:32:35 INFO - ##### 08:32:35 INFO - Running pre-action listener: _resource_record_pre_action 08:32:35 INFO - Running main action method: download_and_extract 08:32:35 INFO - mkdir: /builds/slave/test/build/tests 08:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:35 INFO - https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/test_packages.json 08:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/test_packages.json 08:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:32:37 INFO - Downloaded 1302 bytes. 08:32:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:32:37 INFO - Using the following test package requirements: 08:32:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:32:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'jsshell-linux-x86_64.zip'], 08:32:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:32:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:32:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:32:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:32:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:32:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:37 INFO - https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:38 INFO - Downloaded 21870957 bytes. 08:32:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:32:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:32:39 INFO - Return code: 0 08:32:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:39 INFO - https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:43 INFO - Downloaded 21870957 bytes. 08:32:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:32:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:32:44 INFO - Return code: 0 08:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:44 INFO - https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:32:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:32:45 INFO - Downloaded 11132039 bytes. 08:32:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:32:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:32:45 INFO - Return code: 0 08:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:45 INFO - https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:32:46 INFO - Downloaded 53020265 bytes. 08:32:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:46 INFO - mkdir: /builds/slave/test/properties 08:32:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:46 INFO - Contents: 08:32:46 INFO - build_url:https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:46 INFO - Running post-action listener: _resource_record_post_action 08:32:46 INFO - Running post-action listener: set_extra_try_arguments 08:32:46 INFO - ##### 08:32:46 INFO - ##### Running populate-webroot step. 08:32:46 INFO - ##### 08:32:46 INFO - Running pre-action listener: _resource_record_pre_action 08:32:46 INFO - Running main action method: populate_webroot 08:32:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:46 INFO - '--tppagecycles', 08:32:46 INFO - '7'], 08:32:46 INFO - 'tests': ['tsvgm']}}, 08:32:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:32:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'tests': ['damp', 'tps']}, 08:32:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['damp', 'tps']}, 08:32:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:32:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:46 INFO - 'other': {'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'other_l64': {'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'other_nol64': {'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_no_auto_restore']}, 08:32:46 INFO - 'svgr': {'tests': ['tsvgx', 08:32:46 INFO - 'tsvgr_opacity', 08:32:46 INFO - 'tart', 08:32:46 INFO - 'tscrollx', 08:32:46 INFO - 'cart']}, 08:32:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['tsvgx', 08:32:46 INFO - 'tsvgr_opacity', 08:32:46 INFO - 'tart', 08:32:46 INFO - 'tscrollx', 08:32:46 INFO - 'cart']}, 08:32:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'tests': ['tp5o']}, 08:32:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'talos_options': ['--e10s'], 08:32:46 INFO - 'tests': ['tp5o']}, 08:32:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'talos_options': ['--xperf_path', 08:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:46 INFO - 'tests': ['tp5n']}, 08:32:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:46 INFO - 'talos_options': ['--e10s', 08:32:46 INFO - '--xperf_path', 08:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:46 INFO - 'tests': ['tp5n']}}, 08:32:46 INFO - 'talos.zip': {'path': '', 08:32:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:46 INFO - Running post-action listener: _resource_record_post_action 08:32:46 INFO - ##### 08:32:46 INFO - ##### Running create-virtualenv step. 08:32:46 INFO - ##### 08:32:46 INFO - Running pre-action listener: _resource_record_pre_action 08:32:46 INFO - Running main action method: create_virtualenv 08:32:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:32:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:47 INFO - Using real prefix '/usr' 08:32:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:49 INFO - Installing pip.................done. 08:32:49 INFO - Return code: 0 08:32:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:49 INFO - Using env: {'DISPLAY': ':0', 08:32:49 INFO - 'HOME': '/home/cltbld', 08:32:49 INFO - 'LANG': 'en_US.UTF-8', 08:32:49 INFO - 'LANGUAGE': 'en_US:en', 08:32:49 INFO - 'LOGNAME': 'cltbld', 08:32:49 INFO - 'MAIL': '/var/mail/cltbld', 08:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:49 INFO - 'MOZ_NO_REMOTE': '1', 08:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:49 INFO - 'NO_EM_RESTART': '1', 08:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:49 INFO - 'PWD': '/builds/slave/test', 08:32:49 INFO - 'SHELL': '/bin/bash', 08:32:49 INFO - 'SHLVL': '1', 08:32:49 INFO - 'TERM': 'linux', 08:32:49 INFO - 'TMOUT': '86400', 08:32:49 INFO - 'USER': 'cltbld', 08:32:49 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:49 INFO - '_': '/tools/buildbot/bin/python'} 08:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:32:49 INFO - Cleaning up... 08:32:49 INFO - Return code: 0 08:32:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 08:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 08:32:49 INFO - Using env: {'DISPLAY': ':0', 08:32:49 INFO - 'HOME': '/home/cltbld', 08:32:49 INFO - 'LANG': 'en_US.UTF-8', 08:32:49 INFO - 'LANGUAGE': 'en_US:en', 08:32:49 INFO - 'LOGNAME': 'cltbld', 08:32:49 INFO - 'MAIL': '/var/mail/cltbld', 08:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:49 INFO - 'MOZ_NO_REMOTE': '1', 08:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:49 INFO - 'NO_EM_RESTART': '1', 08:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:49 INFO - 'PWD': '/builds/slave/test', 08:32:49 INFO - 'SHELL': '/bin/bash', 08:32:49 INFO - 'SHLVL': '1', 08:32:49 INFO - 'TERM': 'linux', 08:32:49 INFO - 'TMOUT': '86400', 08:32:49 INFO - 'USER': 'cltbld', 08:32:49 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:49 INFO - '_': '/tools/buildbot/bin/python'} 08:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:49 INFO - Downloading/unpacking psutil>=0.7.1 08:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:32:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:51 INFO - Installing collected packages: psutil 08:32:51 INFO - Running setup.py install for psutil 08:32:51 INFO - building 'psutil._psutil_linux' extension 08:32:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:32:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:32:52 INFO - building 'psutil._psutil_posix' extension 08:32:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:32:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:32:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:52 INFO - Successfully installed psutil 08:32:52 INFO - Cleaning up... 08:32:52 INFO - Return code: 0 08:32:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 08:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 08:32:52 INFO - Using env: {'DISPLAY': ':0', 08:32:52 INFO - 'HOME': '/home/cltbld', 08:32:52 INFO - 'LANG': 'en_US.UTF-8', 08:32:52 INFO - 'LANGUAGE': 'en_US:en', 08:32:52 INFO - 'LOGNAME': 'cltbld', 08:32:52 INFO - 'MAIL': '/var/mail/cltbld', 08:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:52 INFO - 'MOZ_NO_REMOTE': '1', 08:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:52 INFO - 'NO_EM_RESTART': '1', 08:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:52 INFO - 'PWD': '/builds/slave/test', 08:32:52 INFO - 'SHELL': '/bin/bash', 08:32:52 INFO - 'SHLVL': '1', 08:32:52 INFO - 'TERM': 'linux', 08:32:52 INFO - 'TMOUT': '86400', 08:32:52 INFO - 'USER': 'cltbld', 08:32:52 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:52 INFO - '_': '/tools/buildbot/bin/python'} 08:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:54 INFO - Installing collected packages: mozsystemmonitor 08:32:54 INFO - Running setup.py install for mozsystemmonitor 08:32:54 INFO - Successfully installed mozsystemmonitor 08:32:54 INFO - Cleaning up... 08:32:54 INFO - Return code: 0 08:32:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:32:54 INFO - Using env: {'DISPLAY': ':0', 08:32:54 INFO - 'HOME': '/home/cltbld', 08:32:54 INFO - 'LANG': 'en_US.UTF-8', 08:32:54 INFO - 'LANGUAGE': 'en_US:en', 08:32:54 INFO - 'LOGNAME': 'cltbld', 08:32:54 INFO - 'MAIL': '/var/mail/cltbld', 08:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:54 INFO - 'MOZ_NO_REMOTE': '1', 08:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:54 INFO - 'NO_EM_RESTART': '1', 08:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:54 INFO - 'PWD': '/builds/slave/test', 08:32:54 INFO - 'SHELL': '/bin/bash', 08:32:54 INFO - 'SHLVL': '1', 08:32:54 INFO - 'TERM': 'linux', 08:32:54 INFO - 'TMOUT': '86400', 08:32:54 INFO - 'USER': 'cltbld', 08:32:54 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:54 INFO - '_': '/tools/buildbot/bin/python'} 08:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - Downloading docopt-0.6.1.tar.gz 08:32:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:57 INFO - Running setup.py install for blobuploader 08:32:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:57 INFO - Running setup.py install for requests 08:32:57 INFO - Running setup.py install for docopt 08:32:57 INFO - Successfully installed blobuploader requests docopt 08:32:57 INFO - Cleaning up... 08:32:57 INFO - Return code: 0 08:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:57 INFO - Using env: {'DISPLAY': ':0', 08:32:57 INFO - 'HOME': '/home/cltbld', 08:32:57 INFO - 'LANG': 'en_US.UTF-8', 08:32:57 INFO - 'LANGUAGE': 'en_US:en', 08:32:57 INFO - 'LOGNAME': 'cltbld', 08:32:57 INFO - 'MAIL': '/var/mail/cltbld', 08:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:57 INFO - 'MOZ_NO_REMOTE': '1', 08:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:57 INFO - 'NO_EM_RESTART': '1', 08:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:57 INFO - 'PWD': '/builds/slave/test', 08:32:57 INFO - 'SHELL': '/bin/bash', 08:32:57 INFO - 'SHLVL': '1', 08:32:57 INFO - 'TERM': 'linux', 08:32:57 INFO - 'TMOUT': '86400', 08:32:57 INFO - 'USER': 'cltbld', 08:32:57 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:57 INFO - '_': '/tools/buildbot/bin/python'} 08:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:57 INFO - Running setup.py (path:/tmp/pip-hynS3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:57 INFO - Running setup.py (path:/tmp/pip-hePBLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:57 INFO - Running setup.py (path:/tmp/pip-pYLeNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:58 INFO - Running setup.py (path:/tmp/pip-8nSGyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:58 INFO - Running setup.py (path:/tmp/pip-boaqNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:58 INFO - Running setup.py (path:/tmp/pip-WlhPYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:58 INFO - Running setup.py (path:/tmp/pip-EuEjQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:58 INFO - Running setup.py (path:/tmp/pip-yTXb4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:58 INFO - Running setup.py (path:/tmp/pip-6zLb57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:58 INFO - Running setup.py (path:/tmp/pip-hNe94k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:58 INFO - Running setup.py (path:/tmp/pip-wWSy0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:58 INFO - Running setup.py (path:/tmp/pip-5r_ngM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:58 INFO - Running setup.py (path:/tmp/pip-cakBzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:58 INFO - Running setup.py (path:/tmp/pip-U9ZUXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:58 INFO - Running setup.py (path:/tmp/pip-HnC_l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:58 INFO - Running setup.py (path:/tmp/pip-qcX1Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:58 INFO - Running setup.py (path:/tmp/pip-Dgkpmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:59 INFO - Running setup.py install for manifestparser 08:32:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Running setup.py install for mozcrash 08:32:59 INFO - Running setup.py install for mozdebug 08:32:59 INFO - Running setup.py install for mozdevice 08:32:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Running setup.py install for mozfile 08:32:59 INFO - Running setup.py install for mozhttpd 08:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Running setup.py install for mozinfo 08:32:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Running setup.py install for mozInstall 08:32:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:59 INFO - Running setup.py install for mozleak 08:32:59 INFO - Running setup.py install for mozlog 08:33:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for moznetwork 08:33:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for mozprocess 08:33:00 INFO - Running setup.py install for mozprofile 08:33:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for mozrunner 08:33:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for mozscreenshot 08:33:00 INFO - Running setup.py install for moztest 08:33:00 INFO - Running setup.py install for mozversion 08:33:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:00 INFO - Cleaning up... 08:33:00 INFO - Return code: 0 08:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:00 INFO - Using env: {'DISPLAY': ':0', 08:33:00 INFO - 'HOME': '/home/cltbld', 08:33:00 INFO - 'LANG': 'en_US.UTF-8', 08:33:00 INFO - 'LANGUAGE': 'en_US:en', 08:33:00 INFO - 'LOGNAME': 'cltbld', 08:33:00 INFO - 'MAIL': '/var/mail/cltbld', 08:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:00 INFO - 'MOZ_NO_REMOTE': '1', 08:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:00 INFO - 'NO_EM_RESTART': '1', 08:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:00 INFO - 'PWD': '/builds/slave/test', 08:33:00 INFO - 'SHELL': '/bin/bash', 08:33:00 INFO - 'SHLVL': '1', 08:33:00 INFO - 'TERM': 'linux', 08:33:00 INFO - 'TMOUT': '86400', 08:33:00 INFO - 'USER': 'cltbld', 08:33:00 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:00 INFO - '_': '/tools/buildbot/bin/python'} 08:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:01 INFO - Running setup.py (path:/tmp/pip-iMztCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:01 INFO - Running setup.py (path:/tmp/pip-KBawbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:01 INFO - Running setup.py (path:/tmp/pip-nOcINH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:01 INFO - Running setup.py (path:/tmp/pip-X0gn_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:01 INFO - Running setup.py (path:/tmp/pip-dyzYnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:01 INFO - Running setup.py (path:/tmp/pip-w7Bkso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:01 INFO - Running setup.py (path:/tmp/pip-pnFOvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:01 INFO - Running setup.py (path:/tmp/pip-OkSVjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:01 INFO - Running setup.py (path:/tmp/pip-1BvgNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:01 INFO - Running setup.py (path:/tmp/pip-yGV83F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:01 INFO - Running setup.py (path:/tmp/pip-n98DZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:01 INFO - Running setup.py (path:/tmp/pip-TvGL0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:01 INFO - Running setup.py (path:/tmp/pip-K1Wbvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:02 INFO - Running setup.py (path:/tmp/pip-s97WxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:02 INFO - Running setup.py (path:/tmp/pip-1ry8M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:02 INFO - Running setup.py (path:/tmp/pip-C7SeR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:02 INFO - Running setup.py (path:/tmp/pip-H8eqNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:33:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - Downloading blessings-1.5.1.tar.gz 08:33:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:04 INFO - Installing collected packages: blessings 08:33:04 INFO - Running setup.py install for blessings 08:33:04 INFO - Successfully installed blessings 08:33:04 INFO - Cleaning up... 08:33:04 INFO - Return code: 0 08:33:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:04 INFO - Reading from file tmpfile_stdout 08:33:04 INFO - Current package versions: 08:33:04 INFO - argparse == 1.2.1 08:33:04 INFO - blessings == 1.5.1 08:33:04 INFO - blobuploader == 1.2.4 08:33:04 INFO - docopt == 0.6.1 08:33:04 INFO - manifestparser == 1.1 08:33:04 INFO - mozInstall == 1.12 08:33:04 INFO - mozcrash == 0.16 08:33:04 INFO - mozdebug == 0.1 08:33:04 INFO - mozdevice == 0.47 08:33:04 INFO - mozfile == 1.2 08:33:04 INFO - mozhttpd == 0.7 08:33:04 INFO - mozinfo == 0.9 08:33:04 INFO - mozleak == 0.1 08:33:04 INFO - mozlog == 3.1 08:33:04 INFO - moznetwork == 0.27 08:33:04 INFO - mozprocess == 0.22 08:33:04 INFO - mozprofile == 0.27 08:33:04 INFO - mozrunner == 6.11 08:33:04 INFO - mozscreenshot == 0.1 08:33:04 INFO - mozsystemmonitor == 0.0 08:33:04 INFO - moztest == 0.7 08:33:04 INFO - mozversion == 1.4 08:33:04 INFO - psutil == 3.1.1 08:33:04 INFO - requests == 1.2.3 08:33:04 INFO - wsgiref == 0.1.2 08:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:04 INFO - Using env: {'DISPLAY': ':0', 08:33:04 INFO - 'HOME': '/home/cltbld', 08:33:04 INFO - 'LANG': 'en_US.UTF-8', 08:33:04 INFO - 'LANGUAGE': 'en_US:en', 08:33:04 INFO - 'LOGNAME': 'cltbld', 08:33:04 INFO - 'MAIL': '/var/mail/cltbld', 08:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:04 INFO - 'MOZ_NO_REMOTE': '1', 08:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:04 INFO - 'NO_EM_RESTART': '1', 08:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:04 INFO - 'PWD': '/builds/slave/test', 08:33:04 INFO - 'SHELL': '/bin/bash', 08:33:04 INFO - 'SHLVL': '1', 08:33:04 INFO - 'TERM': 'linux', 08:33:04 INFO - 'TMOUT': '86400', 08:33:04 INFO - 'USER': 'cltbld', 08:33:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:04 INFO - '_': '/tools/buildbot/bin/python'} 08:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:04 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 1)) 08:33:04 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 2)) 08:33:04 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 3)) 08:33:04 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 4)) 08:33:04 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 5)) 08:33:04 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 6)) 08:33:04 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 7)) 08:33:04 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 8)) 08:33:04 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:04 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 3)) 08:33:04 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:04 INFO - Cleaning up... 08:33:04 INFO - Return code: 0 08:33:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:04 INFO - Using env: {'DISPLAY': ':0', 08:33:04 INFO - 'HOME': '/home/cltbld', 08:33:04 INFO - 'LANG': 'en_US.UTF-8', 08:33:04 INFO - 'LANGUAGE': 'en_US:en', 08:33:04 INFO - 'LOGNAME': 'cltbld', 08:33:04 INFO - 'MAIL': '/var/mail/cltbld', 08:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:04 INFO - 'MOZ_NO_REMOTE': '1', 08:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:04 INFO - 'NO_EM_RESTART': '1', 08:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:04 INFO - 'PWD': '/builds/slave/test', 08:33:04 INFO - 'SHELL': '/bin/bash', 08:33:04 INFO - 'SHLVL': '1', 08:33:04 INFO - 'TERM': 'linux', 08:33:04 INFO - 'TMOUT': '86400', 08:33:04 INFO - 'USER': 'cltbld', 08:33:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:04 INFO - '_': '/tools/buildbot/bin/python'} 08:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:04 INFO - Downloading/unpacking jsonschema 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:33:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:06 INFO - warning: no files found matching '*.txt' 08:33:06 INFO - no previously-included directories found matching 'build' 08:33:06 INFO - no previously-included directories found matching 'dist' 08:33:06 INFO - no previously-included directories found matching '.git*' 08:33:06 INFO - Installing collected packages: jsonschema, functools32 08:33:06 INFO - Running setup.py install for functools32 08:33:07 INFO - warning: no files found matching '*.txt' 08:33:07 INFO - no previously-included directories found matching 'build' 08:33:07 INFO - no previously-included directories found matching 'dist' 08:33:07 INFO - no previously-included directories found matching '.git*' 08:33:07 INFO - Successfully installed jsonschema functools32 08:33:07 INFO - Cleaning up... 08:33:07 INFO - Return code: 0 08:33:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0d3a2a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:33:07 INFO - Using env: {'DISPLAY': ':0', 08:33:07 INFO - 'HOME': '/home/cltbld', 08:33:07 INFO - 'LANG': 'en_US.UTF-8', 08:33:07 INFO - 'LANGUAGE': 'en_US:en', 08:33:07 INFO - 'LOGNAME': 'cltbld', 08:33:07 INFO - 'MAIL': '/var/mail/cltbld', 08:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:07 INFO - 'MOZ_NO_REMOTE': '1', 08:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:07 INFO - 'NO_EM_RESTART': '1', 08:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:07 INFO - 'PWD': '/builds/slave/test', 08:33:07 INFO - 'SHELL': '/bin/bash', 08:33:07 INFO - 'SHLVL': '1', 08:33:07 INFO - 'TERM': 'linux', 08:33:07 INFO - 'TMOUT': '86400', 08:33:07 INFO - 'USER': 'cltbld', 08:33:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:07 INFO - '_': '/tools/buildbot/bin/python'} 08:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:07 INFO - Downloading/unpacking flake8 08:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:33:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:33:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:33:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:09 INFO - no previously-included directories found matching 'docs/_build' 08:33:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:09 INFO - Running setup.py install for pep8 08:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:09 INFO - no previously-included directories found matching 'docs/_build' 08:33:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:09 INFO - Cleaning up... 08:33:09 INFO - Return code: 0 08:33:09 INFO - Running post-action listener: _resource_record_post_action 08:33:09 INFO - Running post-action listener: _start_resource_monitoring 08:33:09 INFO - Starting resource monitoring. 08:33:09 INFO - ##### 08:33:09 INFO - ##### Running install step. 08:33:09 INFO - ##### 08:33:09 INFO - Running pre-action listener: _resource_record_pre_action 08:33:09 INFO - Running main action method: install 08:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:10 INFO - Reading from file tmpfile_stdout 08:33:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:10 INFO - Reading from file tmpfile_stdout 08:33:10 INFO - Output received: 08:33:10 INFO - Usage: mozinstall [options] installer 08:33:10 INFO - Options: 08:33:10 INFO - -h, --help show this help message and exit 08:33:10 INFO - -d DEST, --destination=DEST 08:33:10 INFO - Directory to install application into. [default: 08:33:10 INFO - "/builds/slave/test"] 08:33:10 INFO - --app=APP Application being installed. [default: firefox] 08:33:10 INFO - mkdir: /builds/slave/test/build/application 08:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:33:25 INFO - Reading from file tmpfile_stdout 08:33:25 INFO - Output received: 08:33:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:25 INFO - Running post-action listener: _resource_record_post_action 08:33:25 INFO - ##### 08:33:25 INFO - ##### Running run-tests step. 08:33:25 INFO - ##### 08:33:25 INFO - Running pre-action listener: _resource_record_pre_action 08:33:25 INFO - Running main action method: run_tests 08:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:25 INFO - Python 2.7.3 08:33:25 INFO - Return code: 0 08:33:25 INFO - grabbing minidump binary from tooltool 08:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:25 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15270b0>, '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 0x1527fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1528440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:33:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:33:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:25 INFO - Return code: 0 08:33:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:33:26 INFO - Return code: 0 08:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 08:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 08:33:26 INFO - Using env: {'DISPLAY': ':0', 08:33:26 INFO - 'HOME': '/home/cltbld', 08:33:26 INFO - 'LANG': 'en_US.UTF-8', 08:33:26 INFO - 'LANGUAGE': 'en_US:en', 08:33:26 INFO - 'LOGNAME': 'cltbld', 08:33:26 INFO - 'MAIL': '/var/mail/cltbld', 08:33:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:26 INFO - 'MOZ_NO_REMOTE': '1', 08:33:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:26 INFO - 'NO_EM_RESTART': '1', 08:33:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:26 INFO - 'PWD': '/builds/slave/test', 08:33:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:26 INFO - 'SHELL': '/bin/bash', 08:33:26 INFO - 'SHLVL': '1', 08:33:26 INFO - 'TERM': 'linux', 08:33:26 INFO - 'TMOUT': '86400', 08:33:26 INFO - 'USER': 'cltbld', 08:33:26 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641', 08:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:26 INFO - '_': '/tools/buildbot/bin/python'} 08:33:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 08:33:26 INFO - mozversion INFO | application_buildid: 20151217073731 08:33:26 INFO - mozversion INFO | application_changeset: 797cbaa987ef4679a43e0987505f9a8e38877860 08:33:26 INFO - mozversion INFO | application_display_name: Nightly 08:33:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:26 INFO - mozversion INFO | application_name: Firefox 08:33:26 INFO - mozversion INFO | application_remotingname: firefox 08:33:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:33:26 INFO - mozversion INFO | application_vendor: Mozilla 08:33:26 INFO - mozversion INFO | application_version: 46.0a1 08:33:26 INFO - mozversion INFO | platform_buildid: 20151217073731 08:33:26 INFO - mozversion INFO | platform_changeset: 797cbaa987ef4679a43e0987505f9a8e38877860 08:33:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:33:26 INFO - mozversion INFO | platform_version: 46.0a1 08:33:26 INFO - 2015-12-17 08:33:26,876 DEBUG : using testdate: 1450370006 08:33:26 INFO - 2015-12-17 08:33:26,877 DEBUG : actual date: 1450370006 08:33:26 INFO - 2015-12-17 08:33:26,888 INFO : starting webserver on 'localhost:36871' 08:33:26 INFO - 2015-12-17 08:33:26,889 INFO : Starting test suite talos-linux64-ix-022 08:33:26 INFO - 2015-12-17 08:33:26,889 INFO : Starting test dromaeo_css 08:33:26 INFO - 2015-12-17 08:33:26,889 DEBUG : operating with platform_type : linux_ 08:33:26 INFO - 2015-12-17 08:33:26,890 INFO : Initialising browser for dromaeo_css test... 08:33:26 INFO - 2015-12-17 08:33:26,905 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkyWeV/profile http://localhost:36871/getInfo.html 08:33:31 INFO - 2015-12-17 08:33:31,761 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:33:31 INFO - 2015-12-17 08:33:31,762 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:33:31 INFO - 2015-12-17 08:33:31,762 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:33:31 INFO - 2015-12-17 08:33:31,762 DEBUG : BROWSER_OUTPUT: __metrics 08:33:31 INFO - 2015-12-17 08:33:31,944 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:33:32 INFO - 2015-12-17 08:33:32,020 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:32 INFO - 2015-12-17 08:33:32,876 INFO : Browser initialized. 08:33:32 INFO - 2015-12-17 08:33:32,876 INFO : Running cycle 1/1 for dromaeo_css test... 08:33:32 INFO - 2015-12-17 08:33:32,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkyWeV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:33:44 INFO - 2015-12-17 08:33:44,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 150409216 08:33:44 INFO - 2015-12-17 08:33:44,913 DEBUG : BROWSER_OUTPUT: 08:34:36 INFO - 2015-12-17 08:34:36,262 DEBUG : BROWSER_OUTPUT: 1450370076261 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:36:48 INFO - 2015-12-17 08:36:48,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36871/tests/dromaeo/cssquery-ext.html) 08:36:49 INFO - 2015-12-17 08:36:49,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 251588608 08:36:49 INFO - 2015-12-17 08:36:49,494 DEBUG : BROWSER_OUTPUT: 08:39:52 INFO - 2015-12-17 08:39:52,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-ext.html (next: http://localhost:36871/tests/dromaeo/cssquery-jquery.html) 08:39:52 INFO - 2015-12-17 08:39:52,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 232472576 08:39:52 INFO - 2015-12-17 08:39:52,597 DEBUG : BROWSER_OUTPUT: 08:42:54 INFO - 2015-12-17 08:42:54,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36871/tests/dromaeo/cssquery-mootools.html) 08:42:55 INFO - 2015-12-17 08:42:55,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 223412224 08:42:55 INFO - 2015-12-17 08:42:55,229 DEBUG : BROWSER_OUTPUT: 08:45:57 INFO - 2015-12-17 08:45:57,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36871/tests/dromaeo/cssquery-prototype.html) 08:45:57 INFO - 2015-12-17 08:45:57,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 209313792 08:45:57 INFO - 2015-12-17 08:45:57,751 DEBUG : BROWSER_OUTPUT: 08:49:00 INFO - 2015-12-17 08:49:00,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36871/tests/dromaeo/cssquery-yui.html) 08:49:01 INFO - 2015-12-17 08:49:01,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 212615168 08:49:01 INFO - 2015-12-17 08:49:01,163 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-yui.html (next: http://localhost:36871/tests/dromaeo/cssquery-dojo.html) 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 256045056 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:03 INFO - 2015-12-17 08:52:03,761 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:03 INFO - 2015-12-17 08:52:03,763 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.152675380501;2702.8243164194328;2704.2022603332016;2721.8230814997037;2722.8638568071597;4541.931871021929;4611.677182597219;4661.813527458902;4694.929576056357;4703.553162449571;4605.861824145281;4612.930806037912;4704.223803072489;4741.431028276612;4750.809967601292;4206.747595144286;4320.783960801948;4335.458067741532;4339.327404252338;4461.553844615545;4431.556844315575;4448.644108471331;4452.376667266585;4468.553144685522;4499.032707967786;4151.771652559108;4226.4716910386205;4242.766647834368;4329.7618630975285;4394.077243778795;4366.759828209447;4393.538678438782;4394.868153955386;4395.7142785718825;4432.157890000922;4295.226859165349;4326.848560300406;4333.804978775963;4335.84824531143;4384.473863136413;4398.934015989763;4496;4499.887502812423;4688.507706690816;4728.69263497875;4945.53017463344;5014.498550144956;5026.447090820006;5030.220315851049;5070.08738427083;5074.949250507485;5144.794208231666;5151.974240128776;5196.298499702568;5206.297149884755;4533.478649955231;4655.580997710223;4664.65015123867;4750.406199225097;4750.881227969294;5067.87330316745;5139.306193663808;5155.2782610433815;5205.6356055075785;5209.062368773657;4996.725180115056;5009.624278179152;5020.7740651670765;5022.773975171126;5044.041632089965;4802.327674125625;4895;4898.167311557044;5089.51649593288;5141.562967147835;4909.386326709161;5022.296878437021;5031.069252188284;5072.51811077947;5073.746312684351;4970.751462426864;4979.30289759434;4983.27742477346;4984.27727979441;5030.673006254582;4017.276890159799;4193.874183774492;4200.390943313264;4201.012762000927;4244.04508985482;3598.460230965376;3610.98194509031;3665.3585622516484;3671.81640917953;3713.424419215026;4339.848105316299;4344.630706389992;4346.673999450054;4365.80353884076;4381.605655491021;4786.736729479912;5061.9493805061475;5077.289179514871;5084.872878178076;5088.084144853962;4225.112726327506;4260.680448966278;4272.08150247692;4307.246231909466;4350.129974005212;4480.081583275421;4498.752568608693;4506.143832671782;4515.14212299662;4531.56950089741;4533.297338912474;4819.277108433763;4822.42130944289;4824.95175048245;4862.149123903303;4907.190313598217;4922.212446008764;4934.975325123495;5006.49935006511;5006.524380183877;4738.739369334582;4755.358026666494;4760.143174228534;4766.070616229802;4812.302216178705;4788.808447662193;4943.728094954812;4945.010997800382;4956.355673762388;4998.625103117353;4956.3804524434445;4960.454350021422;5000.049990501793;5115.820946267012;5161.896762064813;4895.290182923527;4897.2654101885;4898.363212782316;4899.853004409873;4937.629677774109;4891.730954797378;4892.951070489392;4895.485973972682;4895.853124406273;4941.975290123526;4642.350070990132;4669.696469729457;4724.1732696777235;4767.618590512681;4789.808407663654;4980.726060066586;4982.925256121089;4996.6002719783055;5028.421731500925;5051.898962020812;4879.829205977774;4886.706797592155;4888.902221955612;4893.461719210955;4922.138625740553 08:52:03 INFO - 2015-12-17 08:52:03,763 DEBUG : BROWSER_OUTPUT: |1;ext.html;537.057464150416;544.2706772924281;544.4745820283425;565.2820917434856;570.2188002436662;27071;35309.2938141237;35994;36091.458628120534;36104;40638.18723625526;41261;41278.38082428766;41297.58702412975;41372.172556548925;6864.519483636147;7044.718211271543;7921.20787921209;8018.158093400197;8028.277455029046;10160.187185025181;10442.477876106203;10445.73885652861;10463.73840653986;10464.843027354596;10011.899881001169;10113.544890479909;10123.341982771133;10140.138088262507;10143.492825358739;7176.892346614831;7319.780406587811;7352.19125896151;7359.448041396863;10018.549165287543;7022.08712867324;10198.235132365027;10522.21083418739;10526.9473652632;10527;37377.06557336088;37839.43240851362;37894.81052594747;37942.43086353707;37955.62044379549;2795;2810.241234866595;2878.784091193169;3084.4602194615854;3340.398728228942;28779;28871.278218044507;29063;29085.563716544268;29507.55738663922;3493.283876805249;3520.9119772005647;3533.469979503069;3604.6936010439144;3639.253952939641;228868;229396;229872;231031;231427;52206.21690674643;52811.471885280655;55634.21828908539;55995;56070.71964640151;66623.66688166528;68484.3151568488;68489.65755171292;68656.6567167171;68710.65644671845;13216.273104979318;13427.932860335635;13436.529721459701;13437.395317210749;13447.462101516025;9834.360766550151;9839.80320393588;9841.704748857546;9850.753731156778;9875.456849873326;19123.51388365144;19268.614627707648;19428.90285548563;19708.507287317643;19712.802871971384;6853.314668533107;7073.858522829618;7173.210946795848;7243.855122897513;7288.453365997571;864.4510735682886;918.5590916360185;933.2906990687127;935.6912218967724;1020.5203554329453;26143.60784588233;26638.866805666235;27413.725862741518;27717.861410692818;27727;948.0661548374845;963.8265112279717;973.6640858903667;978.8042391521724;980.843065109579;12915.870841291655;12958;13665.111767735065;13714.588562343146;13721.656958576115;272493;275643;277054;277089;278440;45656;45825.312620310724;45849.312260316125;45877.54122458799;45883;1229.1273196030918;1242.0932719115096;1259.7732408166619;1266.2149467330314;1266.8099785032502;25033.623150726886;25711.20021598545;26113.73886261113;26168.73831261663;26333.473330533667;40658.79670601746;40954;41096;41107.383389249786;41159.58840411557;243125;298708;303010;303028;314443;28452.43095138127;28484.715152849036;28508.714912851436;28853.7114628851;28880.85559572189;39024.80487597544;39969.60030399775;40799.18401631891;40824.183516328914;40850.387244190766;27098.45803083888;32325.35349293048;33569.83215083909;33875.66124338824;34246.828765857004;27687.8564032442;31263.53104703386;32105;32431.351372971938;32662.346753064332;32240.516392254605;32772.83613581917;33001.33997319992;33029;33058.83470582728;27949.301267468476;28680.856595716887;29516;29606.259843504085;30958.84520577383;21427.892860535598;23533.411664708517;23690.72195868062;24094.63858042166;24105.879470602536 08:52:03 INFO - 2015-12-17 08:52:03,764 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.70954721656074;319.89923174200123;326.225215114104;327.69196954862423;330.77342020715827;14850.405983760651;15178.39286428543;15302.234888255598;15660.530184094467;15712.685746285068;15210.695786084272;15489.225538723047;16323.020618762883;16349.509514714578;16359.83640163598;4900.068986892488;5034.370703662043;5035.748212589356;5036.597072234231;5038.521340472649;4135.689823263252;5009.874753131165;5041;5043.319151914499;5053.898922021557;4984.87537811554;4989.101961646902;4990.625703072266;4996.7501624918605;4998.10034193845;4819.879503012417;5012.573931215851;5015.7492125393765;5018.723970181657;5021.874453138665;4405.7797110144365;4415.801288941973;4416.315471101984;4424.734515929054;4428.933565996513;18943.62112757751;19045.333413330605;19104.904475477535;19154.71267930982;19312.32406865767;1831.0570056420954;1902.3627084926566;1911.7323574699553;1986.2452268138015;2160.2115227941845;12157.878421215763;12421.503139874394;12573.37133143339;12761.298128602923;12769.936150319281;1714.2457318779698;1724.8016478105053;1726.1714377098938;1739.0956702514748;1759.7008508553577;38832.41751373732;39857.40213896765;41067.794661026506;51862;53168;8052.516848989079;9228.49243291612;9262.861057084148;9329.346945713734;9427.057294270655;10501.579936802595;10817.18871084656;10827.133829293638;10861.782764344827;11290.322580645188;6364.236291645032;6423.935760642334;6462.224533056064;6491.837704057342;6492.772752953719;6076.787312444132;6098.817035488943;6134.2332208473945;6184.783532576338;6236.345183755731;5503.807366742225;5504.6421982571;5512.118061110284;5547.057000309957;5574.414686457944;1578.6132397562671;1583.6674298397465;1583.9049657020616;1599.616092137902;1612.85484306413;889.2570561699142;937.3110763588757;939.3236869453982;959.3572306554626;1043.8016776812533;15032.323545440482;15628;16230;16479.917600412162;16610.6677866442;852;859.3039637893202;876.7413612984185;935.2004036548789;966.1739212972948;7501.174870764212;8931.73204803857;9157.633694652139;9358.064193580587;9466.810663786824;301212;301466;302985;308080;308354;52793.2081018785;56961.43038569561;58006.129908051415;59440.405595943485;62254.37745622486;1001.8597396364515;1029.4904022508906;1040.6149724601946;1044.0238377117269;1044.060345688871;13319.66700832487;13587.728245434839;13602.659933501742;13609.455621775018;13920.930395347958;18466.446006619823;29533.26166845846;29832.85083574568;31441.842790786814;32485.512717308786;43164.136717266105;43183.78408107939;43291.78354108209;43718.78140609276;44639.330410044524;8468.491890486344;8497.130631261112;8756.124387561447;8951.552422378985;8957.507337096522;15205.847941520886;15649.452269170524;15929.920350398173;15973.440929567409;16197.75703364427;13122.278274694601;13235;13361.799573006607;13483.797743034058;13830.861691382957;13166.210027398387;13208.27354495512;13256.07207495466;13593.86406135926;13860.514881979083;12982.221066736027;13361.599152025456;13366;13686.65783355424;13936.58190254294;7400.777976660709;7682.961585192262;8476.23713865755;8589.65641374338;8948.463092214488;9007.77480562965;9078.409903356262;9981.45102019396;13193.20840749558;13337.53318633843 08:52:03 INFO - 2015-12-17 08:52:03,768 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1403.073971179022;1640.475047984645;1720.4838548435466;1721.4405318271556;1748.0298434368929;5790.565707571933;6879.071325371074;6934.549254298479;6994.510384273103;7005.614691191982;6968.895466567993;7144.249853765357;7156.964215178917;7160.570365778057;7163.10461192351;1686.5783554111472;1729.0835856995811;1730.1176400036009;2054.9178032878704;2105.0632468551503;1723;1728.110023337982;2032.634125857345;2067.524469372045;2071.461420030788;2046.3758553641132;2052.8768273903615;2058.0121541660014;2058.7838276980924;2060.7836177201402;1957.3345062678686;2007.8594498385119;2008.7388639476846;2009.5277609761695;2010.1758279105497;2017.979820201794;2023.929162479321;2031.989840050805;2034.1863254698092;2039.4493486758493;7107.538010029331;7181;7181.102362204724;7189.676464559107;7190.388816950565;4204.369344598304;4254.234237837188;4269.6370808481315;4290.69965102443;4292.871213863589;2591.883365248568;2644.180304105714;2674.2378422149786;2681.570948648207;2683;827.5324441690426;858.433433933607;877.7761670773975;877.8332116897769;885.5306687455659;9511.762205944906;9578.329516933818;9583;9702.466364349957;9704.61181552737;3614.403623402162;3631.3100510902846;3673.2102597941034;3690.464882592009;3847.5575308839284;8506.234438900528;8517.36119791018;8522.70170544028;8524.147585241426;8543.530105844238;4288.549702281278;4323.48118225815;4323.546027667113;4324.243257429937;4329.415528903558;3924.7252692311263;3939.03493644059;3940.4483372327895;3943.033956680574;3943.369060950234;3395.1342407685884;3422.0760394693293;3426.434638284655;3475.1138459692615;3476.4263896457305;959.3476436023572;996.1035068438318;1083.967480975572;1130.2766229613055;1152.619635520293;899.4783025844994;930.5812384427035;930.8976012638605;944.6740874398322;1147.1052578988401;6597.86804263912;6620.735170593219;6634.502412318999;6637;6640.9667951660895;515.7524388293565;518.2951186386512;521.1739393062039;564.8136115082013;720.1070672366228;5339.092354299778;5393.325834270716;5442.319710036246;5454.318210223722;5468.343798744176;8559.871601925975;8855.247303979106;8871.778205544784;8877.378583499221;8888.200061994323;8643.524606146597;8691.391602587759;8726.95636521826;8739.21347078766;8742.169493898069;6602.7028783704845;6640.634765087966;6643.435307998874;6654.500912431587;6656.4009239167735;6598.637074960923;6620.106285651568;6620.3710647488415;6628.038934354395;6638.502112341497;7530.134034586093;7871.48835325702;7874.763757087297;7877.566733829694;7923.484973476706;7817.648205830637;8010.479318844256;8152.470089444168;8157.959210203911;8171.346292296483;5955.344912059583;5984.670843103671;5999.970000149971;6144.078388241621;6164.075388691553;5827;6800.421964133104;6834.589924604539;6851.862962740817;6854.9657251713425;5673.77304907799;6644.76743314001;6692.6319052450635;6696.129503164558;6778.966105169443;6534.967325163344;6615.4046135848;6625.966870165618;6633.2040155181685;6696;6613.272540020497;6640.501962352746;6684.4652427804685;6708.563943343667;6713.731450742111;6188.1027251049245;6231.844203894939;6238.407351301619;6255.593386429868;6261.123442717932;5922.644641321534;6063.787767428295;6099.146119543178;6101.145839582551;6102.816915492543 08:52:03 INFO - 2015-12-17 08:52:03,769 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.852582234705;304.1226062808797;306.9033254524826;308.50484971620534;310.0744278329188;5229.398619158798;5241.606879484039;5301.3108295921575;5304.151335786275;5344.0915044442445;5196.454372290912;5213.635045546814;5215.426303106655;5216.3218781558435;5230.34620672416;4123.031087694404;4123.917521649565;4126.174765046988;4126.649234815037;4128.112455821998;3853.1523064925814;3965.365541513344;4120.3201471757275;4122.835086596532;4135.4623898893105;3816.9045773855596;3947.3486874665646;3964.266610677034;3965.6430921217084;4032.294348489003;3956.2483128205695;4037.95013296545;4043.5956404359476;4064.512258528966;4087;3601.045722883438;3602.35157671619;3603.7837729736298;3604.9098772530633;3606.9278614427562;4871.975640121812;5023.8492845214705;5027.145385284511;5075.137226671474;5076.543111120017;4627.791749371287;4642.373279607244;4650.627949764011;4653.115907977473;4655.324977878188;5548.278723765925;5556.638818476786;5560.165975103726;5562.276904002454;5568.192612071268;3675.7794532328144;3778.301014312361;3804.8478060877533;3868.207017561393;3869.052082239841;5777.537796976274;5803;5816.563757718188;5819.592628515963;5827.650340979555;3970.8610198643487;3974.741641793274;3975.92048159041;3977.1846771411792;3981.960180398217;4035.051762835731;4036.737612055207;4037.7577345359373;4038.2327357801923;4046.3728122141115;4531.637469002472;4614.630829533629;4657.697249678828;4667.019925815549;4675.579197872208;5518.889622207534;5524.226608274845;5527.834164975057;5529.391766905637;5531.9723401382735;1428.8640530777848;1428.9142651440948;1430.1133297355707;1430.8926830487546;1431.191376872064;1005.1305620638095;1012.5696578953915;1015.3956748337608;1023.181454836143;1033.1992705653179;4838.080764654775;4843.588294994965;4843.878903027453;4848.515148485123;4862.246351815475;5719.370869204384;5734.827955161351;5738.167965644958;5740.885182296414;5744.109663002241;4826.879328016757;4828.37231159947;4838.2016967200725;4843.4430040545085;4846.5638092571835;3037.5747395364665;3067.1718635968164;3089.135042188146;3105.0374383941053;3141.1361875483967;5522.723863806874;5529.30883639545;5530.640508366943;5531.419200983919;5535.778568857281;5945.34601193877;5966.105084237399;5970.402959704082;5973.074173503114;5974.312954010257;5470.890582188334;5493.917591236214;5508.228847961289;5520.972395137998;5527.44725527444;5688.371814571644;5820.417958204146;5833.854153646023;5839.795607153729;5841.269841269841;5405.972970135124;5519.972400137974;5523.585731070266;5688.77244910199;5700.771969121189;5329.840104796862;5367.704776237344;5416.350037995466;5418.512333889968;5492.258545096361;3971.1660551284554;3996.0809013926378;4005.719599627998;4011.458453108793;4012.7993600319282;5794.478496935296;5797.8550536236935;5806.274215723035;5807.577143599845;5811.94188058114;5429.837104886859;5582.246396736388;5582.888342233214;5584.664920104807;5599.216109744558;5579.414161512983;5579.581531385081;5586.720663966867;5592.328920529562;5595.5523558116065;5471.480209380103;5471.50756431923;5476.863078423071;5478.342598888159;5478.698671573102;5427.402985671652;5611.831645050655;5617.8033768817895;5623.650323922311;5642;5485.451454854483;5492.038893193755;5500.4224556420995;5505.944940550704;5507.284053073075 08:52:03 INFO - 2015-12-17 08:52:03,771 DEBUG : BROWSER_OUTPUT: |5;yui.html;722.3931897206347;741.3513175971025;749.3238716720839;750.3716934252668;753.788939097053;9857.654982075628;10041.297109202358;10048.547815348309;10076.042775936292;10090.243231757611;11432.828507572392;11527.884721152786;11532.96203341699;11543.307401555912;11546.884531154707;624.6221036273046;633.3255083336232;793.2464159048898;803.6504120707482;804.8511025460308;789.3961119743401;795.1491903663083;800.087899794235;800.8598495263335;801.1867954026668;821.8191997760483;834.3783881008657;836.0552575589576;836.8577341851869;837.2841220756258;810.5136917849302;818.7993941484315;819.0294501016315;821.9506829590243;822.9588520574007;615.5875563372506;617.3949529461153;617.7683368736724;618.227215980025;618.8143556932902;10855.67432977012;10980.725481862937;10991.285566438235;10995.945020274927;10996.06533444658;10907.563697452093;11279.617559309621;11302.773944521063;11463.197576169672;11628.24416412939;9414.764630884214;9549.761255968588;9561;9563.90436095644;9633.277504187214;3188.5536024956523;3192.74458043356;3236.2718388362664;3243.172990887332;3248.30161515273;37489;37615.43576846322;37821.81089094564;37850.242995140215;37871.81064094662;8263.834723305501;8684.56577171139;8708.91291087081;8727;8753.824923501494;16455.25951332193;16481.25834337458;16529.752053719203;16534.586635333973;16548.172591370385;6256.937430625636;6266.091416744546;6407.070974708734;6420;6423.807285781434;3512.8594856205464;3577.4633804929467;3586.874459393961;3629.6551827576336;3655.177585043344;2499.1003238834005;2545.27459673992;2545.3127655532903;2546.7071286801884;2548.439343344461;455.7652808803469;461.67913300256;470.618798772995;471.7900534262289;477.75873184041836;403.6165642639504;544.4827413956757;545.2938444714025;551.6662419236385;567.1775924908899;6942.271061538567;6973.163220413583;7543;7827.804304892309;7972.402069844785;493.7802677808341;515.8632962265003;525.8264772625024;563.2649392542771;577.7544543568966;3326.751630467305;3448.2413868948793;3451.430513965218;3475.5308033415167;3536.1866770642896;45419.31871021937;45464;45774.31338529925;45795;46279.768601157455;37272;41459;41881;42055.57944420516;44927;37416.25167496635;38212.617873820906;38364.42453363202;38484.42273365902;39278.607213928066;6987.650617469208;7382.5570465772225;7450.329470347695;7456.328930396074;7617.314441700052;29690.406191876475;30197.245068872577;30228.395432091675;30359.241018974702;30473.23816904595;33798.49302260517;34204.657953420145;35159.82420087883;36879;37048;9555.14003739639;9600.711978640651;9618.567164477476;9769.413835169627;10123.291369604058;10502.947485262524;10559.313644613076;11013.2841365311;11143.387113708824;11186.32882027081;9689.916667916432;9721.70834874955;9791.412515248823;9866.161376283097;10044.397336159855;9111.952125505386;9429.104235097655;9551.42691438516;9620.278479113955;9638.807223855343;9542.379745316532;9733.318667693193;10106.292559521056;10109.14072303833;10492.685219443123;8447.155284471504;8462.153784621734;8629.827403452022;8880.600372983103;8889.111088891059;8278.917210827814;8464.57677116154;8476.49141051539;8599.484030958163;8633.223009929137 08:52:03 INFO - 2015-12-17 08:52:03,772 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:03 INFO - 2015-12-17 08:52:03,772 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:52:03 INFO - 2015-12-17 08:52:03,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,868 08:52:03 INFO - 2015-12-17 08:52:03,773 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:52:03 INFO - 2015-12-17 08:52:03,773 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371123760__endTimestamp 08:52:03 INFO - 2015-12-17 08:52:03,774 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:03 INFO - 2015-12-17 08:52:03,774 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:52:03 INFO - 2015-12-17 08:52:03,774 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,775 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4643.83 Median:4766.07 stddev:488.59 (10.3%) stddev-sans-first:463.23 08:52:03 INFO - 2015-12-17 08:52:03,775 DEBUG : BROWSER_OUTPUT: Values: 2607.2 2702.8 2704.2 2721.8 2722.9 4541.9 4611.7 4661.8 4694.9 4703.6 4605.9 4612.9 4704.2 4741.4 4750.8 4206.7 4320.8 4335.5 4339.3 4461.6 4431.6 4448.6 4452.4 4468.6 4499.0 4151.8 4226.5 4242.8 4329.8 4394.1 4366.8 4393.5 4394.9 4395.7 4432.2 4295.2 4326.8 4333.8 4335.8 4384.5 4398.9 4496.0 4499.9 4688.5 4728.7 4945.5 5014.5 5026.4 5030.2 5070.1 5074.9 5144.8 5152.0 5196.3 5206.3 4533.5 4655.6 4664.7 4750.4 4750.9 5067.9 5139.3 5155.3 5205.6 5209.1 4996.7 5009.6 5020.8 5022.8 5044.0 4802.3 4895.0 4898.2 5089.5 5141.6 4909.4 5022.3 5031.1 5072.5 5073.7 4970.8 4979.3 4983.3 4984.3 5030.7 4017.3 4193.9 4200.4 4201.0 4244.0 3598.5 3611.0 3665.4 3671.8 3713.4 4339.8 4344.6 4346.7 4365.8 4381.6 4786.7 5061.9 5077.3 5084.9 5088.1 4225.1 4260.7 4272.1 4307.2 4350.1 4480.1 4498.8 4506.1 4515.1 4531.6 4533.3 4819.3 4822.4 4825.0 4862.1 4907.2 4922.2 4935.0 5006.5 5006.5 4738.7 4755.4 4760.1 4766.1 4812.3 4788.8 4943.7 4945.0 4956.4 4998.6 4956.4 4960.5 5000.0 5115.8 5161.9 4895.3 4897.3 4898.4 4899.9 4937.6 4891.7 4893.0 4895.5 4895.9 4942.0 4642.4 4669.7 4724.2 4767.6 4789.8 4980.7 4982.9 4996.6 5028.4 5051.9 4879.8 4886.7 4888.9 4893.5 4922.1 08:52:03 INFO - 2015-12-17 08:52:03,775 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,775 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42791.13 Median:32282.93 stddev:70059.57 (217.0%) stddev-sans-first:70184.27 08:52:03 INFO - 2015-12-17 08:52:03,776 DEBUG : BROWSER_OUTPUT: Values: 537.1 544.3 544.5 565.3 570.2 27071.0 35309.3 35994.0 36091.5 36104.0 40638.2 41261.0 41278.4 41297.6 41372.2 6864.5 7044.7 7921.2 8018.2 8028.3 10160.2 10442.5 10445.7 10463.7 10464.8 10011.9 10113.5 10123.3 10140.1 10143.5 7176.9 7319.8 7352.2 7359.4 10018.5 7022.1 10198.2 10522.2 10526.9 10527.0 37377.1 37839.4 37894.8 37942.4 37955.6 2795.0 2810.2 2878.8 3084.5 3340.4 28779.0 28871.3 29063.0 29085.6 29507.6 3493.3 3520.9 3533.5 3604.7 3639.3 228868.0 229396.0 229872.0 231031.0 231427.0 52206.2 52811.5 55634.2 55995.0 56070.7 66623.7 68484.3 68489.7 68656.7 68710.7 13216.3 13427.9 13436.5 13437.4 13447.5 9834.4 9839.8 9841.7 9850.8 9875.5 19123.5 19268.6 19428.9 19708.5 19712.8 6853.3 7073.9 7173.2 7243.9 7288.5 864.5 918.6 933.3 935.7 1020.5 26143.6 26638.9 27413.7 27717.9 27727.0 948.1 963.8 973.7 978.8 980.8 12915.9 12958.0 13665.1 13714.6 13721.7 272493.0 275643.0 277054.0 277089.0 278440.0 45656.0 45825.3 45849.3 45877.5 45883.0 1229.1 1242.1 1259.8 1266.2 1266.8 25033.6 25711.2 26113.7 26168.7 26333.5 40658.8 40954.0 41096.0 41107.4 41159.6 243125.0 298708.0 303010.0 303028.0 314443.0 28452.4 28484.7 28508.7 28853.7 28880.9 39024.8 39969.6 40799.2 40824.2 40850.4 27098.5 32325.4 33569.8 33875.7 34246.8 27687.9 31263.5 32105.0 32431.4 32662.3 32240.5 32772.8 33001.3 33029.0 33058.8 27949.3 28680.9 29516.0 29606.3 30958.8 21427.9 23533.4 23690.7 24094.6 24105.9 08:52:03 INFO - 2015-12-17 08:52:03,777 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,777 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20427.11 Median:326.96 stddev:49816.15 (15236.2%) stddev-sans-first:49933.01 08:52:03 INFO - 2015-12-17 08:52:03,777 DEBUG : BROWSER_OUTPUT: Values: 315.7 319.9 326.2 327.7 330.8 14850.4 15178.4 15302.2 15660.5 15712.7 15210.7 15489.2 16323.0 16349.5 16359.8 4900.1 5034.4 5035.7 5036.6 5038.5 4135.7 5009.9 5041.0 5043.3 5053.9 4984.9 4989.1 4990.6 4996.8 4998.1 4819.9 5012.6 5015.7 5018.7 5021.9 4405.8 4415.8 4416.3 4424.7 4428.9 18943.6 19045.3 19104.9 19154.7 19312.3 1831.1 1902.4 1911.7 1986.2 2160.2 12157.9 12421.5 12573.4 12761.3 12769.9 1714.2 1724.8 1726.2 1739.1 1759.7 38832.4 39857.4 41067.8 51862.0 53168.0 8052.5 9228.5 9262.9 9329.3 9427.1 10501.6 10817.2 10827.1 10861.8 11290.3 6364.2 6423.9 6462.2 6491.8 6492.8 6076.8 6098.8 6134.2 6184.8 6236.3 5503.8 5504.6 5512.1 5547.1 5574.4 1578.6 1583.7 1583.9 1599.6 1612.9 889.3 937.3 939.3 959.4 1043.8 15032.3 15628.0 16230.0 16479.9 16610.7 852.0 859.3 876.7 935.2 966.2 7501.2 8931.7 9157.6 9358.1 9466.8 301212.0 301466.0 302985.0 308080.0 308354.0 52793.2 56961.4 58006.1 59440.4 62254.4 1001.9 1029.5 1040.6 1044.0 1044.1 13319.7 13587.7 13602.7 13609.5 13920.9 18466.4 29533.3 29832.9 31441.8 32485.5 43164.1 43183.8 43291.8 43718.8 44639.3 8468.5 8497.1 8756.1 8951.6 8957.5 15205.8 15649.5 15929.9 15973.4 16197.8 13122.3 13235.0 13361.8 13483.8 13830.9 13166.2 13208.3 13256.1 13593.9 13860.5 12982.2 13361.6 13366.0 13686.7 13936.6 7400.8 7683.0 8476.2 8589.7 8948.5 9007.8 9078.4 9981.5 13193.2 13337.5 08:52:03 INFO - 2015-12-17 08:52:03,778 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,778 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4997.40 Median:6398.05 stddev:2651.68 (41.4%) stddev-sans-first:2645.36 08:52:03 INFO - 2015-12-17 08:52:03,778 DEBUG : BROWSER_OUTPUT: Values: 1403.1 1640.5 1720.5 1721.4 1748.0 5790.6 6879.1 6934.5 6994.5 7005.6 6968.9 7144.2 7157.0 7160.6 7163.1 1686.6 1729.1 1730.1 2054.9 2105.1 1723.0 1728.1 2032.6 2067.5 2071.5 2046.4 2052.9 2058.0 2058.8 2060.8 1957.3 2007.9 2008.7 2009.5 2010.2 2018.0 2023.9 2032.0 2034.2 2039.4 7107.5 7181.0 7181.1 7189.7 7190.4 4204.4 4254.2 4269.6 4290.7 4292.9 2591.9 2644.2 2674.2 2681.6 2683.0 827.5 858.4 877.8 877.8 885.5 9511.8 9578.3 9583.0 9702.5 9704.6 3614.4 3631.3 3673.2 3690.5 3847.6 8506.2 8517.4 8522.7 8524.1 8543.5 4288.5 4323.5 4323.5 4324.2 4329.4 3924.7 3939.0 3940.4 3943.0 3943.4 3395.1 3422.1 3426.4 3475.1 3476.4 959.3 996.1 1084.0 1130.3 1152.6 899.5 930.6 930.9 944.7 1147.1 6597.9 6620.7 6634.5 6637.0 6641.0 515.8 518.3 521.2 564.8 720.1 5339.1 5393.3 5442.3 5454.3 5468.3 8559.9 8855.2 8871.8 8877.4 8888.2 8643.5 8691.4 8727.0 8739.2 8742.2 6602.7 6640.6 6643.4 6654.5 6656.4 6598.6 6620.1 6620.4 6628.0 6638.5 7530.1 7871.5 7874.8 7877.6 7923.5 7817.6 8010.5 8152.5 8158.0 8171.3 5955.3 5984.7 6000.0 6144.1 6164.1 5827.0 6800.4 6834.6 6851.9 6855.0 5673.8 6644.8 6692.6 6696.1 6779.0 6535.0 6615.4 6626.0 6633.2 6696.0 6613.3 6640.5 6684.5 6708.6 6713.7 6188.1 6231.8 6238.4 6255.6 6261.1 5922.6 6063.8 6099.1 6101.1 6102.8 08:52:03 INFO - 2015-12-17 08:52:03,778 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,780 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4605.33 Median:5205.04 stddev:1355.54 (26.0%) stddev-sans-first:1320.28 08:52:03 INFO - 2015-12-17 08:52:03,781 DEBUG : BROWSER_OUTPUT: Values: 300.9 304.1 306.9 308.5 310.1 5229.4 5241.6 5301.3 5304.2 5344.1 5196.5 5213.6 5215.4 5216.3 5230.3 4123.0 4123.9 4126.2 4126.6 4128.1 3853.2 3965.4 4120.3 4122.8 4135.5 3816.9 3947.3 3964.3 3965.6 4032.3 3956.2 4038.0 4043.6 4064.5 4087.0 3601.0 3602.4 3603.8 3604.9 3606.9 4872.0 5023.8 5027.1 5075.1 5076.5 4627.8 4642.4 4650.6 4653.1 4655.3 5548.3 5556.6 5560.2 5562.3 5568.2 3675.8 3778.3 3804.8 3868.2 3869.1 5777.5 5803.0 5816.6 5819.6 5827.7 3970.9 3974.7 3975.9 3977.2 3982.0 4035.1 4036.7 4037.8 4038.2 4046.4 4531.6 4614.6 4657.7 4667.0 4675.6 5518.9 5524.2 5527.8 5529.4 5532.0 1428.9 1428.9 1430.1 1430.9 1431.2 1005.1 1012.6 1015.4 1023.2 1033.2 4838.1 4843.6 4843.9 4848.5 4862.2 5719.4 5734.8 5738.2 5740.9 5744.1 4826.9 4828.4 4838.2 4843.4 4846.6 3037.6 3067.2 3089.1 3105.0 3141.1 5522.7 5529.3 5530.6 5531.4 5535.8 5945.3 5966.1 5970.4 5973.1 5974.3 5470.9 5493.9 5508.2 5521.0 5527.4 5688.4 5820.4 5833.9 5839.8 5841.3 5406.0 5520.0 5523.6 5688.8 5700.8 5329.8 5367.7 5416.4 5418.5 5492.3 3971.2 3996.1 4005.7 4011.5 4012.8 5794.5 5797.9 5806.3 5807.6 5811.9 5429.8 5582.2 5582.9 5584.7 5599.2 5579.4 5579.6 5586.7 5592.3 5595.6 5471.5 5471.5 5476.9 5478.3 5478.7 5427.4 5611.8 5617.8 5623.7 5642.0 5485.5 5492.0 5500.4 5505.9 5507.3 08:52:03 INFO - 2015-12-17 08:52:03,781 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-12-17 08:52:03,782 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11515.67 Median:504.82 stddev:12809.17 (2537.4%) stddev-sans-first:12819.45 08:52:03 INFO - 2015-12-17 08:52:03,783 DEBUG : BROWSER_OUTPUT: Values: 722.4 741.4 749.3 750.4 753.8 9857.7 10041.3 10048.5 10076.0 10090.2 11432.8 11527.9 11533.0 11543.3 11546.9 624.6 633.3 793.2 803.7 804.9 789.4 795.1 800.1 800.9 801.2 821.8 834.4 836.1 836.9 837.3 810.5 818.8 819.0 822.0 823.0 615.6 617.4 617.8 618.2 618.8 10855.7 10980.7 10991.3 10995.9 10996.1 10907.6 11279.6 11302.8 11463.2 11628.2 9414.8 9549.8 9561.0 9563.9 9633.3 3188.6 3192.7 3236.3 3243.2 3248.3 37489.0 37615.4 37821.8 37850.2 37871.8 8263.8 8684.6 8708.9 8727.0 8753.8 16455.3 16481.3 16529.8 16534.6 16548.2 6256.9 6266.1 6407.1 6420.0 6423.8 3512.9 3577.5 3586.9 3629.7 3655.2 2499.1 2545.3 2545.3 2546.7 2548.4 455.8 461.7 470.6 471.8 477.8 403.6 544.5 545.3 551.7 567.2 6942.3 6973.2 7543.0 7827.8 7972.4 493.8 515.9 525.8 563.3 577.8 3326.8 3448.2 3451.4 3475.5 3536.2 45419.3 45464.0 45774.3 45795.0 46279.8 37272.0 41459.0 41881.0 42055.6 44927.0 37416.3 38212.6 38364.4 38484.4 39278.6 6987.7 7382.6 7450.3 7456.3 7617.3 29690.4 30197.2 30228.4 30359.2 30473.2 33798.5 34204.7 35159.8 36879.0 37048.0 9555.1 9600.7 9618.6 9769.4 10123.3 10502.9 10559.3 11013.3 11143.4 11186.3 9689.9 9721.7 9791.4 9866.2 10044.4 9112.0 9429.1 9551.4 9620.3 9638.8 9542.4 9733.3 10106.3 10109.1 10492.7 8447.2 8462.2 8629.8 8880.6 8889.1 8278.9 8464.6 8476.5 8599.5 8633.2 08:52:03 INFO - 2015-12-17 08:52:03,783 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:03 INFO - 2015-12-17 08:52:03,784 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-12-17 08:52:04,511 INFO : Browser exited with error code: 0 08:52:04 INFO - 2015-12-17 08:52:04,528 INFO : Completed test dromaeo_css (00:18:37) 08:52:04 INFO - 2015-12-17 08:52:04,528 INFO : Starting test kraken 08:52:04 INFO - 2015-12-17 08:52:04,528 DEBUG : operating with platform_type : linux_ 08:52:04 INFO - 2015-12-17 08:52:04,528 INFO : Initialising browser for kraken test... 08:52:04 INFO - 2015-12-17 08:52:04,534 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpflfzjm/profile http://localhost:36871/getInfo.html 08:52:08 INFO - 2015-12-17 08:52:08,912 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:08 INFO - 2015-12-17 08:52:08,912 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:08 INFO - 2015-12-17 08:52:08,912 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:52:08 INFO - 2015-12-17 08:52:08,912 DEBUG : BROWSER_OUTPUT: __metrics 08:52:09 INFO - 2015-12-17 08:52:09,013 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:52:09 INFO - 2015-12-17 08:52:09,094 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:09 INFO - 2015-12-17 08:52:09,437 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:52:10 INFO - 2015-12-17 08:52:10,154 INFO : Browser initialized. 08:52:10 INFO - 2015-12-17 08:52:10,154 INFO : Running cycle 1/1 for kraken test... 08:52:10 INFO - 2015-12-17 08:52:10,155 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpflfzjm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:22 INFO - 2015-12-17 08:52:22,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 148172800 08:52:22 INFO - 2015-12-17 08:52:22,163 DEBUG : BROWSER_OUTPUT: 08:52:24 INFO - 2015-12-17 08:52:24,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:25 INFO - 2015-12-17 08:52:25,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 182231040 08:52:25 INFO - 2015-12-17 08:52:25,352 DEBUG : BROWSER_OUTPUT: 08:52:28 INFO - 2015-12-17 08:52:28,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-dft) 08:52:28 INFO - 2015-12-17 08:52:28,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 171163648 08:52:28 INFO - 2015-12-17 08:52:28,664 DEBUG : BROWSER_OUTPUT: 08:52:31 INFO - 2015-12-17 08:52:31,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-fft) 08:52:32 INFO - 2015-12-17 08:52:32,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 158048256 08:52:32 INFO - 2015-12-17 08:52:32,222 DEBUG : BROWSER_OUTPUT: 08:52:34 INFO - 2015-12-17 08:52:34,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-oscillator) 08:52:34 INFO - 2015-12-17 08:52:34,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 161685504 08:52:34 INFO - 2015-12-17 08:52:34,831 DEBUG : BROWSER_OUTPUT: 08:52:37 INFO - 2015-12-17 08:52:37,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:37 INFO - 2015-12-17 08:52:37,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 161972224 08:52:37 INFO - 2015-12-17 08:52:37,638 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:41 INFO - 2015-12-17 08:52:41,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 162045952 08:52:41 INFO - 2015-12-17 08:52:41,175 DEBUG : BROWSER_OUTPUT: 08:52:44 INFO - 2015-12-17 08:52:44,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:45 INFO - 2015-12-17 08:52:45,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 162828288 08:52:45 INFO - 2015-12-17 08:52:45,174 DEBUG : BROWSER_OUTPUT: 08:52:47 INFO - 2015-12-17 08:52:47,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36871/tests/kraken/driver.html?testName=json-parse-financial) 08:52:48 INFO - 2015-12-17 08:52:48,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 164343808 08:52:48 INFO - 2015-12-17 08:52:48,573 DEBUG : BROWSER_OUTPUT: 08:52:50 INFO - 2015-12-17 08:52:50,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:50 INFO - 2015-12-17 08:52:50,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 171732992 08:52:50 INFO - 2015-12-17 08:52:50,952 DEBUG : BROWSER_OUTPUT: 08:52:52 INFO - 2015-12-17 08:52:52,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:53 INFO - 2015-12-17 08:52:53,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 170647552 08:52:53 INFO - 2015-12-17 08:52:53,449 DEBUG : BROWSER_OUTPUT: 08:52:55 INFO - 2015-12-17 08:52:55,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:56 INFO - 2015-12-17 08:52:56,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 182063104 08:52:56 INFO - 2015-12-17 08:52:56,122 DEBUG : BROWSER_OUTPUT: 08:52:58 INFO - 2015-12-17 08:52:58,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:59 INFO - 2015-12-17 08:52:59,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 188723200 08:52:59 INFO - 2015-12-17 08:52:59,265 DEBUG : BROWSER_OUTPUT: 08:53:01 INFO - 2015-12-17 08:53:01,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:02 INFO - 2015-12-17 08:53:02,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 187359232 08:53:02 INFO - 2015-12-17 08:53:02,434 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36871/tests/kraken/driver.html?testName=ai-astar) 08:53:04 INFO - 2015-12-17 08:53:04,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 245288960 08:53:04 INFO - 2015-12-17 08:53:04,425 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,426 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:04 INFO - 2015-12-17 08:53:04,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:04 INFO - 2015-12-17 08:53:04,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:04 INFO - 2015-12-17 08:53:04,426 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:04 INFO - 2015-12-17 08:53:04,427 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;114;114;100;113;112;105 08:53:04 INFO - 2015-12-17 08:53:04,427 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;156;165;146;163;156;133;174;131 08:53:04 INFO - 2015-12-17 08:53:04,427 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;162;161;162;160;162;161;161;161 08:53:04 INFO - 2015-12-17 08:53:04,427 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;90;93;72;73;72;95;90;72 08:53:04 INFO - 2015-12-17 08:53:04,428 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;135;94;95;95;132;96;95;134 08:53:04 INFO - 2015-12-17 08:53:04,428 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;110;110;109;109 08:53:04 INFO - 2015-12-17 08:53:04,428 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;146;146;147;146;146 08:53:04 INFO - 2015-12-17 08:53:04,428 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 08:53:04 INFO - 2015-12-17 08:53:04,428 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;73;74;71;72;80;71;69 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;68;69;68;69;68 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;82;83;84;82;83;83;83;83;84 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;120;120;116;121;133;137;131;127;132 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;138;154;145;149;135;151;159;143;139 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;69;69;70;71;71;70;70 08:53:04 INFO - 2015-12-17 08:53:04,429 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:04 INFO - 2015-12-17 08:53:04,430 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:53:04 INFO - 2015-12-17 08:53:04,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 08:53:04 INFO - 2015-12-17 08:53:04,430 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:53:04 INFO - 2015-12-17 08:53:04,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371184424__endTimestamp 08:53:04 INFO - 2015-12-17 08:53:04,430 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,434 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:04 INFO - 2015-12-17 08:53:04,434 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:53:04 INFO - 2015-12-17 08:53:04,434 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,434 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:4.63 (4.1%) stddev-sans-first:4.90 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 114.0 114.0 100.0 113.0 112.0 105.0 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:156.50 stddev:15.44 (9.9%) stddev-sans-first:16.23 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 156.0 165.0 146.0 163.0 156.0 133.0 174.0 131.0 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 08:53:04 INFO - 2015-12-17 08:53:04,435 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 162.0 161.0 162.0 160.0 162.0 161.0 161.0 161.0 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:81.50 stddev:10.26 (12.6%) stddev-sans-first:10.55 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 90.0 93.0 72.0 73.0 72.0 95.0 90.0 72.0 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:18.63 (19.6%) stddev-sans-first:19.35 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 135.0 94.0 95.0 95.0 132.0 96.0 95.0 134.0 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:53:04 INFO - 2015-12-17 08:53:04,436 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 08:53:04 INFO - 2015-12-17 08:53:04,437 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,437 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:53:04 INFO - 2015-12-17 08:53:04,437 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 08:53:04 INFO - 2015-12-17 08:53:04,437 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.50 stddev:2.91 (4.0%) stddev-sans-first:3.07 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 74.0 71.0 72.0 80.0 71.0 69.0 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,438 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 68.0 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.31 (2.8%) stddev-sans-first:0.71 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: Values: 90.0 82.0 83.0 84.0 82.0 83.0 83.0 83.0 83.0 84.0 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:129.00 stddev:7.03 (5.5%) stddev-sans-first:7.31 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: Values: 122.0 120.0 120.0 116.0 121.0 133.0 137.0 131.0 127.0 132.0 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:147.00 stddev:8.28 (5.6%) stddev-sans-first:7.99 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: Values: 135.0 138.0 154.0 145.0 149.0 135.0 151.0 159.0 143.0 139.0 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 69.0 70.0 71.0 71.0 70.0 70.0 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:04 INFO - 2015-12-17 08:53:04,439 DEBUG : BROWSER_OUTPUT: 08:53:05 INFO - 2015-12-17 08:53:05,323 INFO : Browser exited with error code: 0 08:53:05 INFO - 2015-12-17 08:53:05,375 INFO : Completed test kraken (00:01:00) 08:53:05 INFO - 2015-12-17 08:53:05,375 INFO : Starting test v8_7 08:53:05 INFO - 2015-12-17 08:53:05,375 DEBUG : operating with platform_type : linux_ 08:53:05 INFO - 2015-12-17 08:53:05,375 INFO : Initialising browser for v8_7 test... 08:53:05 INFO - 2015-12-17 08:53:05,381 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVnlq3/profile http://localhost:36871/getInfo.html 08:53:09 INFO - 2015-12-17 08:53:09,687 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:53:09 INFO - 2015-12-17 08:53:09,687 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:53:09 INFO - 2015-12-17 08:53:09,687 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:53:09 INFO - 2015-12-17 08:53:09,687 DEBUG : BROWSER_OUTPUT: __metrics 08:53:09 INFO - 2015-12-17 08:53:09,803 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:53:09 INFO - 2015-12-17 08:53:09,871 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:53:11 INFO - 2015-12-17 08:53:11,052 INFO : Browser initialized. 08:53:11 INFO - 2015-12-17 08:53:11,052 INFO : Running cycle 1/1 for v8_7 test... 08:53:11 INFO - 2015-12-17 08:53:11,052 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVnlq3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:53:23 INFO - 2015-12-17 08:53:23,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 150110208 08:53:23 INFO - 2015-12-17 08:53:23,073 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36871/tests/v8_7/run.html (next: http://localhost:36871/tests/v8_7/run.html) 08:53:44 INFO - 2015-12-17 08:53:44,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 448991232 08:53:44 INFO - 2015-12-17 08:53:44,692 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,693 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:44 INFO - 2015-12-17 08:53:44,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:44 INFO - 2015-12-17 08:53:44,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.01190476190476 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 08:53:44 INFO - 2015-12-17 08:53:44,694 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: |8;Splay;611.1786148238153 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371224692__endTimestamp 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:44 INFO - 2015-12-17 08:53:44,695 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: Values: 165.6 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: Values: 186.0 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: Values: 277.9 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,696 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,697 DEBUG : BROWSER_OUTPUT: Values: 5186.5 08:53:44 INFO - 2015-12-17 08:53:44,697 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,697 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,697 DEBUG : BROWSER_OUTPUT: Values: 1976.3 08:53:44 INFO - 2015-12-17 08:53:44,697 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: Values: 787.4 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: Values: 12243.9 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,698 DEBUG : BROWSER_OUTPUT: Values: 27216.2 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.18 Median:611.18 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: Values: 611.2 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:44 INFO - 2015-12-17 08:53:44,699 DEBUG : BROWSER_OUTPUT: 08:53:45 INFO - 2015-12-17 08:53:45,564 INFO : Browser exited with error code: 0 08:53:45 INFO - 2015-12-17 08:53:45,583 INFO : Completed test v8_7 (00:00:40) 08:53:45 INFO - 2015-12-17 08:53:45,755 INFO : Completed test suite (00:20:18) 08:53:45 INFO - 2015-12-17 08:53:45,755 DEBUG : Working with test: dromaeo_css 08:53:45 INFO - 2015-12-17 08:53:45,755 DEBUG : Generating results file: dromaeo_css 08:53:45 INFO - 2015-12-17 08:53:45,757 DEBUG : Working with test: kraken 08:53:45 INFO - 2015-12-17 08:53:45,757 DEBUG : Generating results file: kraken 08:53:45 INFO - 2015-12-17 08:53:45,757 INFO : javascript benchmark 08:53:45 INFO - 2015-12-17 08:53:45,757 DEBUG : Working with test: v8_7 08:53:45 INFO - 2015-12-17 08:53:45,757 DEBUG : Generating results file: v8_7 08:53:45 INFO - 2015-12-17 08:53:45,758 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:45 INFO - 2015-12-17 08:53:45,815 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:53:45 INFO - 2015-12-17 08:53:45,815 DEBUG : process_Request line: dromaeo_css 6229.00 graph.html#tests=[[72,132,35]] 08:53:45 INFO - 2015-12-17 08:53:45,815 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:45 INFO - 2015-12-17 08:53:45,844 DEBUG : process_Request line: kraken 1525.90 graph.html#tests=[[232,132,35]] 08:53:45 INFO - 2015-12-17 08:53:45,844 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:45 INFO - 2015-12-17 08:53:45,876 DEBUG : process_Request line: v8_7 19779.27 graph.html#tests=[[230,132,35]] 08:53:45 INFO - 2015-12-17 08:53:45,878 INFO : javascript benchmark 08:53:45 INFO - 2015-12-17 08:53:45,881 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.152675380501, 2702.8243164194328, 2704.2022603332016, 2721.8230814997037, 2722.8638568071597, 4541.931871021929, 4611.677182597219, 4661.813527458902, 4694.929576056357, 4703.553162449571, 4605.861824145281, 4612.930806037912, 4704.223803072489, 4741.431028276612, 4750.809967601292, 4206.747595144286, 4320.783960801948, 4335.458067741532, 4339.327404252338, 4461.553844615545, 4431.556844315575, 4448.644108471331, 4452.376667266585, 4468.553144685522, 4499.032707967786, 4151.771652559108, 4226.4716910386205, 4242.766647834368, 4329.7618630975285, 4394.077243778795, 4366.759828209447, 4393.538678438782, 4394.868153955386, 4395.7142785718825, 4432.157890000922, 4295.226859165349, 4326.848560300406, 4333.804978775963, 4335.84824531143, 4384.473863136413, 4398.934015989763, 4496.0, 4499.887502812423, 4688.507706690816, 4728.69263497875, 4945.53017463344, 5014.498550144956, 5026.447090820006, 5030.220315851049, 5070.08738427083, 5074.949250507485, 5144.794208231666, 5151.974240128776, 5196.298499702568, 5206.297149884755, 4533.478649955231, 4655.580997710223, 4664.65015123867, 4750.406199225097, 4750.881227969294, 5067.87330316745, 5139.306193663808, 5155.2782610433815, 5205.6356055075785, 5209.062368773657, 4996.725180115056, 5009.624278179152, 5020.7740651670765, 5022.773975171126, 5044.041632089965, 4802.327674125625, 4895.0, 4898.167311557044, 5089.51649593288, 5141.562967147835, 4909.386326709161, 5022.296878437021, 5031.069252188284, 5072.51811077947, 5073.746312684351, 4970.751462426864, 4979.30289759434, 4983.27742477346, 4984.27727979441, 5030.673006254582, 4017.276890159799, 4193.874183774492, 4200.390943313264, 4201.012762000927, 4244.04508985482, 3598.460230965376, 3610.98194509031, 3665.3585622516484, 3671.81640917953, 3713.424419215026, 4339.848105316299, 4344.630706389992, 4346.673999450054, 4365.80353884076, 4381.605655491021, 4786.736729479912, 5061.9493805061475, 5077.289179514871, 5084.872878178076, 5088.084144853962, 4225.112726327506, 4260.680448966278, 4272.08150247692, 4307.246231909466, 4350.129974005212, 4480.081583275421, 4498.752568608693, 4506.143832671782, 4515.14212299662, 4531.56950089741, 4533.297338912474, 4819.277108433763, 4822.42130944289, 4824.95175048245, 4862.149123903303, 4907.190313598217, 4922.212446008764, 4934.975325123495, 5006.49935006511, 5006.524380183877, 4738.739369334582, 4755.358026666494, 4760.143174228534, 4766.070616229802, 4812.302216178705, 4788.808447662193, 4943.728094954812, 4945.010997800382, 4956.355673762388, 4998.625103117353, 4956.3804524434445, 4960.454350021422, 5000.049990501793, 5115.820946267012, 5161.896762064813, 4895.290182923527, 4897.2654101885, 4898.363212782316, 4899.853004409873, 4937.629677774109, 4891.730954797378, 4892.951070489392, 4895.485973972682, 4895.853124406273, 4941.975290123526, 4642.350070990132, 4669.696469729457, 4724.1732696777235, 4767.618590512681, 4789.808407663654, 4980.726060066586, 4982.925256121089, 4996.6002719783055, 5028.421731500925, 5051.898962020812, 4879.829205977774, 4886.706797592155, 4888.902221955612, 4893.461719210955, 4922.138625740553], "unit": "score", "name": "dojo.html", "value": 4613.301652605038}, {"lowerIsBetter": false, "replicates": [537.057464150416, 544.2706772924281, 544.4745820283425, 565.2820917434856, 570.2188002436662, 27071.0, 35309.2938141237, 35994.0, 36091.458628120534, 36104.0, 40638.18723625526, 41261.0, 41278.38082428766, 41297.58702412975, 41372.172556548925, 6864.519483636147, 7044.718211271543, 7921.20787921209, 8018.158093400197, 8028.277455029046, 10160.187185025181, 10442.477876106203, 10445.73885652861, 10463.73840653986, 10464.843027354596, 10011.899881001169, 10113.544890479909, 10123.341982771133, 10140.138088262507, 10143.492825358739, 7176.892346614831, 7319.780406587811, 7352.19125896151, 7359.448041396863, 10018.549165287543, 7022.08712867324, 10198.235132365027, 10522.21083418739, 10526.9473652632, 10527.0, 37377.06557336088, 37839.43240851362, 37894.81052594747, 37942.43086353707, 37955.62044379549, 2795.0, 2810.241234866595, 2878.784091193169, 3084.4602194615854, 3340.398728228942, 28779.0, 28871.278218044507, 29063.0, 29085.563716544268, 29507.55738663922, 3493.283876805249, 3520.9119772005647, 3533.469979503069, 3604.6936010439144, 3639.253952939641, 228868.0, 229396.0, 229872.0, 231031.0, 231427.0, 52206.21690674643, 52811.471885280655, 55634.21828908539, 55995.0, 56070.71964640151, 66623.66688166528, 68484.3151568488, 68489.65755171292, 68656.6567167171, 68710.65644671845, 13216.273104979318, 13427.932860335635, 13436.529721459701, 13437.395317210749, 13447.462101516025, 9834.360766550151, 9839.80320393588, 9841.704748857546, 9850.753731156778, 9875.456849873326, 19123.51388365144, 19268.614627707648, 19428.90285548563, 19708.507287317643, 19712.802871971384, 6853.314668533107, 7073.858522829618, 7173.210946795848, 7243.855122897513, 7288.453365997571, 864.4510735682886, 918.5590916360185, 933.2906990687127, 935.6912218967724, 1020.5203554329453, 26143.60784588233, 26638.866805666235, 27413.725862741518, 27717.861410692818, 27727.0, 948.0661548374845, 963.8265112279717, 973.6640858903667, 978.8042391521724, 980.843065109579, 12915.870841291655, 12958.0, 13665.111767735065, 13714.588562343146, 13721.656958576115, 272493.0, 275643.0, 277054.0, 277089.0, 278440.0, 45656.0, 45825.312620310724, 45849.312260316125, 45877.54122458799, 45883.0, 1229.1273196030918, 1242.0932719115096, 1259.7732408166619, 1266.2149467330314, 1266.8099785032502, 25033.623150726886, 25711.20021598545, 26113.73886261113, 26168.73831261663, 26333.473330533667, 40658.79670601746, 40954.0, 41096.0, 41107.383389249786, 41159.58840411557, 243125.0, 298708.0, 303010.0, 303028.0, 314443.0, 28452.43095138127, 28484.715152849036, 28508.714912851436, 28853.7114628851, 28880.85559572189, 39024.80487597544, 39969.60030399775, 40799.18401631891, 40824.183516328914, 40850.387244190766, 27098.45803083888, 32325.35349293048, 33569.83215083909, 33875.66124338824, 34246.828765857004, 27687.8564032442, 31263.53104703386, 32105.0, 32431.351372971938, 32662.346753064332, 32240.516392254605, 32772.83613581917, 33001.33997319992, 33029.0, 33058.83470582728, 27949.301267468476, 28680.856595716887, 29516.0, 29606.259843504085, 30958.84520577383, 21427.892860535598, 23533.411664708517, 23690.72195868062, 24094.63858042166, 24105.879470602536], "unit": "score", "name": "ext.html", "value": 17293.481049764992}, {"lowerIsBetter": false, "replicates": [315.70954721656074, 319.89923174200123, 326.225215114104, 327.69196954862423, 330.77342020715827, 14850.405983760651, 15178.39286428543, 15302.234888255598, 15660.530184094467, 15712.685746285068, 15210.695786084272, 15489.225538723047, 16323.020618762883, 16349.509514714578, 16359.83640163598, 4900.068986892488, 5034.370703662043, 5035.748212589356, 5036.597072234231, 5038.521340472649, 4135.689823263252, 5009.874753131165, 5041.0, 5043.319151914499, 5053.898922021557, 4984.87537811554, 4989.101961646902, 4990.625703072266, 4996.7501624918605, 4998.10034193845, 4819.879503012417, 5012.573931215851, 5015.7492125393765, 5018.723970181657, 5021.874453138665, 4405.7797110144365, 4415.801288941973, 4416.315471101984, 4424.734515929054, 4428.933565996513, 18943.62112757751, 19045.333413330605, 19104.904475477535, 19154.71267930982, 19312.32406865767, 1831.0570056420954, 1902.3627084926566, 1911.7323574699553, 1986.2452268138015, 2160.2115227941845, 12157.878421215763, 12421.503139874394, 12573.37133143339, 12761.298128602923, 12769.936150319281, 1714.2457318779698, 1724.8016478105053, 1726.1714377098938, 1739.0956702514748, 1759.7008508553577, 38832.41751373732, 39857.40213896765, 41067.794661026506, 51862.0, 53168.0, 8052.516848989079, 9228.49243291612, 9262.861057084148, 9329.346945713734, 9427.057294270655, 10501.579936802595, 10817.18871084656, 10827.133829293638, 10861.782764344827, 11290.322580645188, 6364.236291645032, 6423.935760642334, 6462.224533056064, 6491.837704057342, 6492.772752953719, 6076.787312444132, 6098.817035488943, 6134.2332208473945, 6184.783532576338, 6236.345183755731, 5503.807366742225, 5504.6421982571, 5512.118061110284, 5547.057000309957, 5574.414686457944, 1578.6132397562671, 1583.6674298397465, 1583.9049657020616, 1599.616092137902, 1612.85484306413, 889.2570561699142, 937.3110763588757, 939.3236869453982, 959.3572306554626, 1043.8016776812533, 15032.323545440482, 15628.0, 16230.0, 16479.917600412162, 16610.6677866442, 852.0, 859.3039637893202, 876.7413612984185, 935.2004036548789, 966.1739212972948, 7501.174870764212, 8931.73204803857, 9157.633694652139, 9358.064193580587, 9466.810663786824, 301212.0, 301466.0, 302985.0, 308080.0, 308354.0, 52793.2081018785, 56961.43038569561, 58006.129908051415, 59440.405595943485, 62254.37745622486, 1001.8597396364515, 1029.4904022508906, 1040.6149724601946, 1044.0238377117269, 1044.060345688871, 13319.66700832487, 13587.728245434839, 13602.659933501742, 13609.455621775018, 13920.930395347958, 18466.446006619823, 29533.26166845846, 29832.85083574568, 31441.842790786814, 32485.512717308786, 43164.136717266105, 43183.78408107939, 43291.78354108209, 43718.78140609276, 44639.330410044524, 8468.491890486344, 8497.130631261112, 8756.124387561447, 8951.552422378985, 8957.507337096522, 15205.847941520886, 15649.452269170524, 15929.920350398173, 15973.440929567409, 16197.75703364427, 13122.278274694601, 13235.0, 13361.799573006607, 13483.797743034058, 13830.861691382957, 13166.210027398387, 13208.27354495512, 13256.07207495466, 13593.86406135926, 13860.514881979083, 12982.221066736027, 13361.599152025456, 13366.0, 13686.65783355424, 13936.58190254294, 7400.777976660709, 7682.961585192262, 8476.23713865755, 8589.65641374338, 8948.463092214488, 9007.77480562965, 9078.409903356262, 9981.45102019396, 13193.20840749558, 13337.53318633843], "unit": "score", "name": "jquery.html", "value": 7981.124983792627}, {"lowerIsBetter": false, "replicates": [1403.073971179022, 1640.475047984645, 1720.4838548435466, 1721.4405318271556, 1748.0298434368929, 5790.565707571933, 6879.071325371074, 6934.549254298479, 6994.510384273103, 7005.614691191982, 6968.895466567993, 7144.249853765357, 7156.964215178917, 7160.570365778057, 7163.10461192351, 1686.5783554111472, 1729.0835856995811, 1730.1176400036009, 2054.9178032878704, 2105.0632468551503, 1723.0, 1728.110023337982, 2032.634125857345, 2067.524469372045, 2071.461420030788, 2046.3758553641132, 2052.8768273903615, 2058.0121541660014, 2058.7838276980924, 2060.7836177201402, 1957.3345062678686, 2007.8594498385119, 2008.7388639476846, 2009.5277609761695, 2010.1758279105497, 2017.979820201794, 2023.929162479321, 2031.989840050805, 2034.1863254698092, 2039.4493486758493, 7107.538010029331, 7181.0, 7181.102362204724, 7189.676464559107, 7190.388816950565, 4204.369344598304, 4254.234237837188, 4269.6370808481315, 4290.69965102443, 4292.871213863589, 2591.883365248568, 2644.180304105714, 2674.2378422149786, 2681.570948648207, 2683.0, 827.5324441690426, 858.433433933607, 877.7761670773975, 877.8332116897769, 885.5306687455659, 9511.762205944906, 9578.329516933818, 9583.0, 9702.466364349957, 9704.61181552737, 3614.403623402162, 3631.3100510902846, 3673.2102597941034, 3690.464882592009, 3847.5575308839284, 8506.234438900528, 8517.36119791018, 8522.70170544028, 8524.147585241426, 8543.530105844238, 4288.549702281278, 4323.48118225815, 4323.546027667113, 4324.243257429937, 4329.415528903558, 3924.7252692311263, 3939.03493644059, 3940.4483372327895, 3943.033956680574, 3943.369060950234, 3395.1342407685884, 3422.0760394693293, 3426.434638284655, 3475.1138459692615, 3476.4263896457305, 959.3476436023572, 996.1035068438318, 1083.967480975572, 1130.2766229613055, 1152.619635520293, 899.4783025844994, 930.5812384427035, 930.8976012638605, 944.6740874398322, 1147.1052578988401, 6597.86804263912, 6620.735170593219, 6634.502412318999, 6637.0, 6640.9667951660895, 515.7524388293565, 518.2951186386512, 521.1739393062039, 564.8136115082013, 720.1070672366228, 5339.092354299778, 5393.325834270716, 5442.319710036246, 5454.318210223722, 5468.343798744176, 8559.871601925975, 8855.247303979106, 8871.778205544784, 8877.378583499221, 8888.200061994323, 8643.524606146597, 8691.391602587759, 8726.95636521826, 8739.21347078766, 8742.169493898069, 6602.7028783704845, 6640.634765087966, 6643.435307998874, 6654.500912431587, 6656.4009239167735, 6598.637074960923, 6620.106285651568, 6620.3710647488415, 6628.038934354395, 6638.502112341497, 7530.134034586093, 7871.48835325702, 7874.763757087297, 7877.566733829694, 7923.484973476706, 7817.648205830637, 8010.479318844256, 8152.470089444168, 8157.959210203911, 8171.346292296483, 5955.344912059583, 5984.670843103671, 5999.970000149971, 6144.078388241621, 6164.075388691553, 5827.0, 6800.421964133104, 6834.589924604539, 6851.862962740817, 6854.9657251713425, 5673.77304907799, 6644.76743314001, 6692.6319052450635, 6696.129503164558, 6778.966105169443, 6534.967325163344, 6615.4046135848, 6625.966870165618, 6633.2040155181685, 6696.0, 6613.272540020497, 6640.501962352746, 6684.4652427804685, 6708.563943343667, 6713.731450742111, 6188.1027251049245, 6231.844203894939, 6238.407351301619, 6255.593386429868, 6261.123442717932, 5922.644641321534, 6063.787767428295, 6099.146119543178, 6101.145839582551, 6102.816915492543], "unit": "score", "name": "mootools.html", "value": 4021.2750467061046}, {"lowerIsBetter": false, "replicates": [300.852582234705, 304.1226062808797, 306.9033254524826, 308.50484971620534, 310.0744278329188, 5229.398619158798, 5241.606879484039, 5301.3108295921575, 5304.151335786275, 5344.0915044442445, 5196.454372290912, 5213.635045546814, 5215.426303106655, 5216.3218781558435, 5230.34620672416, 4123.031087694404, 4123.917521649565, 4126.174765046988, 4126.649234815037, 4128.112455821998, 3853.1523064925814, 3965.365541513344, 4120.3201471757275, 4122.835086596532, 4135.4623898893105, 3816.9045773855596, 3947.3486874665646, 3964.266610677034, 3965.6430921217084, 4032.294348489003, 3956.2483128205695, 4037.95013296545, 4043.5956404359476, 4064.512258528966, 4087.0, 3601.045722883438, 3602.35157671619, 3603.7837729736298, 3604.9098772530633, 3606.9278614427562, 4871.975640121812, 5023.8492845214705, 5027.145385284511, 5075.137226671474, 5076.543111120017, 4627.791749371287, 4642.373279607244, 4650.627949764011, 4653.115907977473, 4655.324977878188, 5548.278723765925, 5556.638818476786, 5560.165975103726, 5562.276904002454, 5568.192612071268, 3675.7794532328144, 3778.301014312361, 3804.8478060877533, 3868.207017561393, 3869.052082239841, 5777.537796976274, 5803.0, 5816.563757718188, 5819.592628515963, 5827.650340979555, 3970.8610198643487, 3974.741641793274, 3975.92048159041, 3977.1846771411792, 3981.960180398217, 4035.051762835731, 4036.737612055207, 4037.7577345359373, 4038.2327357801923, 4046.3728122141115, 4531.637469002472, 4614.630829533629, 4657.697249678828, 4667.019925815549, 4675.579197872208, 5518.889622207534, 5524.226608274845, 5527.834164975057, 5529.391766905637, 5531.9723401382735, 1428.8640530777848, 1428.9142651440948, 1430.1133297355707, 1430.8926830487546, 1431.191376872064, 1005.1305620638095, 1012.5696578953915, 1015.3956748337608, 1023.181454836143, 1033.1992705653179, 4838.080764654775, 4843.588294994965, 4843.878903027453, 4848.515148485123, 4862.246351815475, 5719.370869204384, 5734.827955161351, 5738.167965644958, 5740.885182296414, 5744.109663002241, 4826.879328016757, 4828.37231159947, 4838.2016967200725, 4843.4430040545085, 4846.5638092571835, 3037.5747395364665, 3067.1718635968164, 3089.135042188146, 3105.0374383941053, 3141.1361875483967, 5522.723863806874, 5529.30883639545, 5530.640508366943, 5531.419200983919, 5535.778568857281, 5945.34601193877, 5966.105084237399, 5970.402959704082, 5973.074173503114, 5974.312954010257, 5470.890582188334, 5493.917591236214, 5508.228847961289, 5520.972395137998, 5527.44725527444, 5688.371814571644, 5820.417958204146, 5833.854153646023, 5839.795607153729, 5841.269841269841, 5405.972970135124, 5519.972400137974, 5523.585731070266, 5688.77244910199, 5700.771969121189, 5329.840104796862, 5367.704776237344, 5416.350037995466, 5418.512333889968, 5492.258545096361, 3971.1660551284554, 3996.0809013926378, 4005.719599627998, 4011.458453108793, 4012.7993600319282, 5794.478496935296, 5797.8550536236935, 5806.274215723035, 5807.577143599845, 5811.94188058114, 5429.837104886859, 5582.246396736388, 5582.888342233214, 5584.664920104807, 5599.216109744558, 5579.414161512983, 5579.581531385081, 5586.720663966867, 5592.328920529562, 5595.5523558116065, 5471.480209380103, 5471.50756431923, 5476.863078423071, 5478.342598888159, 5478.698671573102, 5427.402985671652, 5611.831645050655, 5617.8033768817895, 5623.650323922311, 5642.0, 5485.451454854483, 5492.038893193755, 5500.4224556420995, 5505.944940550704, 5507.284053073075], "unit": "score", "name": "prototype.html", "value": 4175.07909936382}, {"lowerIsBetter": false, "replicates": [722.3931897206347, 741.3513175971025, 749.3238716720839, 750.3716934252668, 753.788939097053, 9857.654982075628, 10041.297109202358, 10048.547815348309, 10076.042775936292, 10090.243231757611, 11432.828507572392, 11527.884721152786, 11532.96203341699, 11543.307401555912, 11546.884531154707, 624.6221036273046, 633.3255083336232, 793.2464159048898, 803.6504120707482, 804.8511025460308, 789.3961119743401, 795.1491903663083, 800.087899794235, 800.8598495263335, 801.1867954026668, 821.8191997760483, 834.3783881008657, 836.0552575589576, 836.8577341851869, 837.2841220756258, 810.5136917849302, 818.7993941484315, 819.0294501016315, 821.9506829590243, 822.9588520574007, 615.5875563372506, 617.3949529461153, 617.7683368736724, 618.227215980025, 618.8143556932902, 10855.67432977012, 10980.725481862937, 10991.285566438235, 10995.945020274927, 10996.06533444658, 10907.563697452093, 11279.617559309621, 11302.773944521063, 11463.197576169672, 11628.24416412939, 9414.764630884214, 9549.761255968588, 9561.0, 9563.90436095644, 9633.277504187214, 3188.5536024956523, 3192.74458043356, 3236.2718388362664, 3243.172990887332, 3248.30161515273, 37489.0, 37615.43576846322, 37821.81089094564, 37850.242995140215, 37871.81064094662, 8263.834723305501, 8684.56577171139, 8708.91291087081, 8727.0, 8753.824923501494, 16455.25951332193, 16481.25834337458, 16529.752053719203, 16534.586635333973, 16548.172591370385, 6256.937430625636, 6266.091416744546, 6407.070974708734, 6420.0, 6423.807285781434, 3512.8594856205464, 3577.4633804929467, 3586.874459393961, 3629.6551827576336, 3655.177585043344, 2499.1003238834005, 2545.27459673992, 2545.3127655532903, 2546.7071286801884, 2548.439343344461, 455.7652808803469, 461.67913300256, 470.618798772995, 471.7900534262289, 477.75873184041836, 403.6165642639504, 544.4827413956757, 545.2938444714025, 551.6662419236385, 567.1775924908899, 6942.271061538567, 6973.163220413583, 7543.0, 7827.804304892309, 7972.402069844785, 493.7802677808341, 515.8632962265003, 525.8264772625024, 563.2649392542771, 577.7544543568966, 3326.751630467305, 3448.2413868948793, 3451.430513965218, 3475.5308033415167, 3536.1866770642896, 45419.31871021937, 45464.0, 45774.31338529925, 45795.0, 46279.768601157455, 37272.0, 41459.0, 41881.0, 42055.57944420516, 44927.0, 37416.25167496635, 38212.617873820906, 38364.42453363202, 38484.42273365902, 39278.607213928066, 6987.650617469208, 7382.5570465772225, 7450.329470347695, 7456.328930396074, 7617.314441700052, 29690.406191876475, 30197.245068872577, 30228.395432091675, 30359.241018974702, 30473.23816904595, 33798.49302260517, 34204.657953420145, 35159.82420087883, 36879.0, 37048.0, 9555.14003739639, 9600.711978640651, 9618.567164477476, 9769.413835169627, 10123.291369604058, 10502.947485262524, 10559.313644613076, 11013.2841365311, 11143.387113708824, 11186.32882027081, 9689.916667916432, 9721.70834874955, 9791.412515248823, 9866.161376283097, 10044.397336159855, 9111.952125505386, 9429.104235097655, 9551.42691438516, 9620.278479113955, 9638.807223855343, 9542.379745316532, 9733.318667693193, 10106.292559521056, 10109.14072303833, 10492.685219443123, 8447.155284471504, 8462.153784621734, 8629.827403452022, 8880.600372983103, 8889.111088891059, 8278.917210827814, 8464.57677116154, 8476.49141051539, 8599.484030958163, 8633.223009929137], "unit": "score", "name": "yui.html", "value": 5463.547264973853}], "name": "dromaeo_css", "value": 6228.996242577327}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 114.0, 114.0, 100.0, 113.0, 112.0, 105.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 156.0, 165.0, 146.0, 163.0, 156.0, 133.0, 174.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 90.0, 93.0, 72.0, 73.0, 72.0, 95.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 135.0, 94.0, 95.0, 95.0, 132.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 74.0, 71.0, 72.0, 80.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [90.0, 82.0, 83.0, 84.0, 82.0, 83.0, 83.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 120.0, 116.0, 121.0, 133.0, 137.0, 131.0, 127.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [135.0, 138.0, 154.0, 145.0, 149.0, 135.0, 151.0, 159.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 71.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1525.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [186.01190476190476], "unit": "score", "name": "DeltaBlue", "value": 355.4503679999999}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [611.1786148238153], "unit": "score", "name": "Splay", "value": 133.33418091451293}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19779.274412818362}]} 08:53:45 INFO - RETURN: dromaeo_css: 6229.00 08:53:45 INFO - RETURN: kraken: 1525.90 08:53:45 INFO - RETURN: v8_7: 19779.27 08:53:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19779.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6229.00"}}} 08:53:45 INFO - Return code: 0 08:53:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:53:46 INFO - # TBPL SUCCESS # 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - Running post-run listener: _resource_record_post_run 08:53:47 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545796096; Read time: 16; Write time: 546860 08:53:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226824192; Read time: 0; Write time: 348224 08:53:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318967808; Read time: 16; Write time: 197620 08:53:47 INFO - Running post-run listener: _upload_blobber_files 08:53:47 INFO - Blob upload gear active. 08:53:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:53:47 INFO - Copying logs to upload dir... 08:53:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.039541 ========= master_lag: 1.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 08:53:48.434043) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:53:48.441747) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010056 build_url: 'https://queue.taskcluster.net/v1/task/8UbgcxOaT7GR0S8SbMg4HQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:53:48.466722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:53:48.467050) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450369766.534349-1325747641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:53:48.518983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:53:48.519283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:53:48.521601) ========= ========= Total master_lag: 1.85 =========