builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1450423473.27 results: success (0) buildid: 20151217224651 builduid: 7a64459a366d431c8c9c5f733e14c684 revision: 63254aa6dfabeced552c9401cf9fb3cfa9b7add4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.266211) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.266707) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.267013) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006430 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.301465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.301762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.358101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.358457) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.409846) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.410132) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.410504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.410792) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 23:24:33-- 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% 220M=0s 2015-12-17 23:24:34 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161387 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.584347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.584665) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:33.636967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 23:24:33.637701) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 63254aa6dfabeced552c9401cf9fb3cfa9b7add4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 63254aa6dfabeced552c9401cf9fb3cfa9b7add4 --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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 23:24:34,191 truncating revision to first 12 chars 2015-12-17 23:24:34,191 Setting DEBUG logging. 2015-12-17 23:24:34,191 attempt 1/10 2015-12-17 23:24:34,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/63254aa6dfab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 23:24:35,456 unpacking tar archive at: b2g-inbound-63254aa6dfab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.577467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 23:24:35.231880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:35.232212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:35.241800) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:35.242130) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 23:24:35.242527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 23:24:35.242801) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:35 INFO - MultiFileLogger online at 20151217 23:24:35 in /builds/slave/test 23:24:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 23:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:35 INFO - {'append_to_log': False, 23:24:35 INFO - 'base_work_dir': '/builds/slave/test', 23:24:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 23:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 23:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:35 INFO - 'config_files': ('talos/linux_config.py',), 23:24:35 INFO - 'default_actions': ('clobber', 23:24:35 INFO - 'read-buildbot-config', 23:24:35 INFO - 'download-and-extract', 23:24:35 INFO - 'populate-webroot', 23:24:35 INFO - 'create-virtualenv', 23:24:35 INFO - 'install', 23:24:35 INFO - 'run-tests'), 23:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:35 INFO - 'download_minidump_stackwalk': True, 23:24:35 INFO - 'download_symbols': 'ondemand', 23:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:35 INFO - 'installer_path': 'installer.exe', 23:24:35 INFO - 'log_level': 'info', 23:24:35 INFO - 'log_name': 'talos', 23:24:35 INFO - 'log_to_console': True, 23:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:35 INFO - 'opt_config_files': (), 23:24:35 INFO - 'pip_index': False, 23:24:35 INFO - 'sps_profile': False, 23:24:35 INFO - 'sps_profile_interval': 0, 23:24:35 INFO - 'suite': 'dromaeojs', 23:24:35 INFO - 'system_bits': '64', 23:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:35 INFO - 'title': 'talos-linux64-ix-056', 23:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:35 INFO - 'use_talos_json': True, 23:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:35 INFO - 'work_dir': 'build'} 23:24:35 INFO - ##### 23:24:35 INFO - ##### Running clobber step. 23:24:35 INFO - ##### 23:24:35 INFO - Running pre-action listener: _resource_record_pre_action 23:24:35 INFO - Running main action method: clobber 23:24:35 INFO - rmtree: /builds/slave/test/build 23:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:36 INFO - Running post-action listener: _resource_record_post_action 23:24:36 INFO - ##### 23:24:36 INFO - ##### Running read-buildbot-config step. 23:24:36 INFO - ##### 23:24:36 INFO - Running pre-action listener: _resource_record_pre_action 23:24:36 INFO - Running main action method: read_buildbot_config 23:24:36 INFO - Using buildbot properties: 23:24:36 INFO - { 23:24:36 INFO - "project": "", 23:24:36 INFO - "product": "firefox", 23:24:36 INFO - "script_repo_revision": "production", 23:24:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:24:36 INFO - "repository": "", 23:24:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 23:24:36 INFO - "buildid": "20151217224651", 23:24:36 INFO - "pgo_build": "False", 23:24:36 INFO - "basedir": "/builds/slave/test", 23:24:36 INFO - "buildnumber": 309, 23:24:36 INFO - "slavename": "talos-linux64-ix-056", 23:24:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:24:36 INFO - "platform": "ubuntu64_hw", 23:24:36 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 23:24:36 INFO - "branch": "b2g-inbound", 23:24:36 INFO - "repo_path": "integration/b2g-inbound", 23:24:36 INFO - "revision": "63254aa6dfabeced552c9401cf9fb3cfa9b7add4", 23:24:36 INFO - "stage_platform": "linux64", 23:24:36 INFO - "builduid": "7a64459a366d431c8c9c5f733e14c684", 23:24:36 INFO - "slavebuilddir": "test" 23:24:36 INFO - } 23:24:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:24:36 INFO - Running post-action listener: _resource_record_post_action 23:24:36 INFO - ##### 23:24:36 INFO - ##### Running download-and-extract step. 23:24:36 INFO - ##### 23:24:36 INFO - Running pre-action listener: _resource_record_pre_action 23:24:36 INFO - Running main action method: download_and_extract 23:24:36 INFO - mkdir: /builds/slave/test/build/tests 23:24:36 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')]} 23:24:36 INFO - https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/test_packages.json 23:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/test_packages.json 23:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:24:40 INFO - Downloaded 1302 bytes. 23:24:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:24:40 INFO - Using the following test package requirements: 23:24:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'jsshell-linux-x86_64.zip'], 23:24:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:24:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:24:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:40 INFO - https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:41 INFO - Downloaded 21871020 bytes. 23:24:41 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 23:24:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:41 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 23:24:42 INFO - Return code: 0 23:24:42 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 23:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:42 INFO - https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:44 INFO - Downloaded 21871020 bytes. 23:24:44 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 23:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:24:44 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 23:24:45 INFO - Return code: 0 23:24: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')]} 23:24:45 INFO - https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:46 INFO - Downloaded 11132039 bytes. 23:24:46 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 23:24:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:46 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 23:24:46 INFO - Return code: 0 23:24:46 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')]} 23:24:46 INFO - https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEJqXIKZS9ydlGxlNmanHg/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 23:24:48 INFO - Downloaded 53018725 bytes. 23:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:24:48 INFO - mkdir: /builds/slave/test/properties 23:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:48 INFO - Contents: 23:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:24:48 INFO - Running post-action listener: _resource_record_post_action 23:24:48 INFO - Running post-action listener: set_extra_try_arguments 23:24:48 INFO - ##### 23:24:48 INFO - ##### Running populate-webroot step. 23:24:48 INFO - ##### 23:24:48 INFO - Running pre-action listener: _resource_record_pre_action 23:24:48 INFO - Running main action method: populate_webroot 23:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:48 INFO - '--tppagecycles', 23:24:48 INFO - '7'], 23:24:48 INFO - 'tests': ['tsvgm']}}, 23:24:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:24:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:24:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:24:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'tests': ['damp', 'tps']}, 23:24:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['damp', 'tps']}, 23:24:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:48 INFO - 'other': {'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'other_l64': {'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'other_nol64': {'tests': ['a11yr', 23:24:48 INFO - 'ts_paint', 23:24:48 INFO - 'tpaint', 23:24:48 INFO - 'sessionrestore', 23:24:48 INFO - 'sessionrestore_no_auto_restore']}, 23:24:48 INFO - 'svgr': {'tests': ['tsvgx', 23:24:48 INFO - 'tsvgr_opacity', 23:24:48 INFO - 'tart', 23:24:48 INFO - 'tscrollx', 23:24:48 INFO - 'cart']}, 23:24:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['tsvgx', 23:24:48 INFO - 'tsvgr_opacity', 23:24:48 INFO - 'tart', 23:24:48 INFO - 'tscrollx', 23:24:48 INFO - 'cart']}, 23:24:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'tests': ['tp5o']}, 23:24:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'talos_options': ['--e10s'], 23:24:48 INFO - 'tests': ['tp5o']}, 23:24:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'talos_options': ['--xperf_path', 23:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:48 INFO - 'tests': ['tp5n']}, 23:24:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:48 INFO - 'talos_options': ['--e10s', 23:24:48 INFO - '--xperf_path', 23:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:48 INFO - 'tests': ['tp5n']}}, 23:24:48 INFO - 'talos.zip': {'path': '', 23:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:48 INFO - Running post-action listener: _resource_record_post_action 23:24:48 INFO - ##### 23:24:48 INFO - ##### Running create-virtualenv step. 23:24:48 INFO - ##### 23:24:48 INFO - Running pre-action listener: _resource_record_pre_action 23:24:48 INFO - Running main action method: create_virtualenv 23:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:48 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 23:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:48 INFO - Using real prefix '/usr' 23:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:50 INFO - Installing pip.................done. 23:24:50 INFO - Return code: 0 23:24:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:50 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:24:50 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 23:24:50 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 23:24:50 INFO - Using env: {'DISPLAY': ':0', 23:24:50 INFO - 'HOME': '/home/cltbld', 23:24:50 INFO - 'LANG': 'en_US.UTF-8', 23:24:50 INFO - 'LANGUAGE': 'en_US:en', 23:24:50 INFO - 'LOGNAME': 'cltbld', 23:24:50 INFO - 'MAIL': '/var/mail/cltbld', 23:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:50 INFO - 'MOZ_NO_REMOTE': '1', 23:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:50 INFO - 'NO_EM_RESTART': '1', 23:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:50 INFO - 'PWD': '/builds/slave/test', 23:24:50 INFO - 'SHELL': '/bin/bash', 23:24:50 INFO - 'SHLVL': '1', 23:24:50 INFO - 'TERM': 'linux', 23:24:50 INFO - 'TMOUT': '86400', 23:24:50 INFO - 'USER': 'cltbld', 23:24:50 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:50 INFO - '_': '/tools/buildbot/bin/python'} 23:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:50 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 23:24:50 INFO - Cleaning up... 23:24:50 INFO - Return code: 0 23:24:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:50 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:24:50 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 23:24:50 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 23:24:50 INFO - Using env: {'DISPLAY': ':0', 23:24:50 INFO - 'HOME': '/home/cltbld', 23:24:50 INFO - 'LANG': 'en_US.UTF-8', 23:24:50 INFO - 'LANGUAGE': 'en_US:en', 23:24:50 INFO - 'LOGNAME': 'cltbld', 23:24:50 INFO - 'MAIL': '/var/mail/cltbld', 23:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:50 INFO - 'MOZ_NO_REMOTE': '1', 23:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:50 INFO - 'NO_EM_RESTART': '1', 23:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:50 INFO - 'PWD': '/builds/slave/test', 23:24:50 INFO - 'SHELL': '/bin/bash', 23:24:50 INFO - 'SHLVL': '1', 23:24:50 INFO - 'TERM': 'linux', 23:24:50 INFO - 'TMOUT': '86400', 23:24:50 INFO - 'USER': 'cltbld', 23:24:50 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:50 INFO - '_': '/tools/buildbot/bin/python'} 23:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:51 INFO - Downloading/unpacking psutil>=0.7.1 23:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:24:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:52 INFO - Installing collected packages: psutil 23:24:52 INFO - Running setup.py install for psutil 23:24:53 INFO - building 'psutil._psutil_linux' extension 23:24:53 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 23:24:53 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 23:24:53 INFO - building 'psutil._psutil_posix' extension 23:24:53 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 23:24:53 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 23:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:53 INFO - Successfully installed psutil 23:24:53 INFO - Cleaning up... 23:24:53 INFO - Return code: 0 23:24:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:24:53 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 23:24:53 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 23:24:53 INFO - Using env: {'DISPLAY': ':0', 23:24:53 INFO - 'HOME': '/home/cltbld', 23:24:53 INFO - 'LANG': 'en_US.UTF-8', 23:24:53 INFO - 'LANGUAGE': 'en_US:en', 23:24:53 INFO - 'LOGNAME': 'cltbld', 23:24:53 INFO - 'MAIL': '/var/mail/cltbld', 23:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:53 INFO - 'MOZ_NO_REMOTE': '1', 23:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:53 INFO - 'NO_EM_RESTART': '1', 23:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:53 INFO - 'PWD': '/builds/slave/test', 23:24:53 INFO - 'SHELL': '/bin/bash', 23:24:53 INFO - 'SHLVL': '1', 23:24:53 INFO - 'TERM': 'linux', 23:24:53 INFO - 'TMOUT': '86400', 23:24:53 INFO - 'USER': 'cltbld', 23:24:53 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:53 INFO - '_': '/tools/buildbot/bin/python'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:24:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:24:55 INFO - Installing collected packages: mozsystemmonitor 23:24:55 INFO - Running setup.py install for mozsystemmonitor 23:24:55 INFO - Successfully installed mozsystemmonitor 23:24:55 INFO - Cleaning up... 23:24:55 INFO - Return code: 0 23:24:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:55 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')]} 23:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:55 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')]} 23:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:55 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:24:55 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 23:24:55 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 23:24:55 INFO - Using env: {'DISPLAY': ':0', 23:24:55 INFO - 'HOME': '/home/cltbld', 23:24:55 INFO - 'LANG': 'en_US.UTF-8', 23:24:55 INFO - 'LANGUAGE': 'en_US:en', 23:24:55 INFO - 'LOGNAME': 'cltbld', 23:24:55 INFO - 'MAIL': '/var/mail/cltbld', 23:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:55 INFO - 'MOZ_NO_REMOTE': '1', 23:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:55 INFO - 'NO_EM_RESTART': '1', 23:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:55 INFO - 'PWD': '/builds/slave/test', 23:24:55 INFO - 'SHELL': '/bin/bash', 23:24:55 INFO - 'SHLVL': '1', 23:24:55 INFO - 'TERM': 'linux', 23:24:55 INFO - 'TMOUT': '86400', 23:24:55 INFO - 'USER': 'cltbld', 23:24:55 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:55 INFO - '_': '/tools/buildbot/bin/python'} 23:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 23:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:57 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:58 INFO - Downloading docopt-0.6.1.tar.gz 23:24:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:58 INFO - Running setup.py install for blobuploader 23:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:58 INFO - Running setup.py install for requests 23:24:58 INFO - Running setup.py install for docopt 23:24:58 INFO - Successfully installed blobuploader requests docopt 23:24:58 INFO - Cleaning up... 23:24:58 INFO - Return code: 0 23:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:58 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')]} 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 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')]} 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:24:58 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 23:24:58 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 23:24:58 INFO - Using env: {'DISPLAY': ':0', 23:24:58 INFO - 'HOME': '/home/cltbld', 23:24:58 INFO - 'LANG': 'en_US.UTF-8', 23:24:58 INFO - 'LANGUAGE': 'en_US:en', 23:24:58 INFO - 'LOGNAME': 'cltbld', 23:24:58 INFO - 'MAIL': '/var/mail/cltbld', 23:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:58 INFO - 'MOZ_NO_REMOTE': '1', 23:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:58 INFO - 'NO_EM_RESTART': '1', 23:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:58 INFO - 'PWD': '/builds/slave/test', 23:24:58 INFO - 'SHELL': '/bin/bash', 23:24:58 INFO - 'SHLVL': '1', 23:24:58 INFO - 'TERM': 'linux', 23:24:58 INFO - 'TMOUT': '86400', 23:24:58 INFO - 'USER': 'cltbld', 23:24:58 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:58 INFO - '_': '/tools/buildbot/bin/python'} 23:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:59 INFO - Running setup.py (path:/tmp/pip-0WFZHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:59 INFO - Running setup.py (path:/tmp/pip-XQBAXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:59 INFO - Running setup.py (path:/tmp/pip-pAjEmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:59 INFO - Running setup.py (path:/tmp/pip-weSIFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:59 INFO - Running setup.py (path:/tmp/pip-eHPvBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:59 INFO - Running setup.py (path:/tmp/pip-SSOgeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:59 INFO - Running setup.py (path:/tmp/pip-D18j2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:59 INFO - Running setup.py (path:/tmp/pip-2BntjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:59 INFO - Running setup.py (path:/tmp/pip-rvvVrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:59 INFO - Running setup.py (path:/tmp/pip-g4NWmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:59 INFO - Running setup.py (path:/tmp/pip-yQRZlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:59 INFO - Running setup.py (path:/tmp/pip-Edxjyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:59 INFO - Running setup.py (path:/tmp/pip-L_0VYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:59 INFO - Running setup.py (path:/tmp/pip-cKwrm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:00 INFO - Running setup.py (path:/tmp/pip-DKX9HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:00 INFO - Running setup.py (path:/tmp/pip-UTEyqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:00 INFO - Running setup.py (path:/tmp/pip-UcsHrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:00 INFO - Running setup.py install for manifestparser 23:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Running setup.py install for mozcrash 23:25:00 INFO - Running setup.py install for mozdebug 23:25:00 INFO - Running setup.py install for mozdevice 23:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Running setup.py install for mozfile 23:25:00 INFO - Running setup.py install for mozhttpd 23:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Running setup.py install for mozinfo 23:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Running setup.py install for mozInstall 23:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Running setup.py install for mozleak 23:25:01 INFO - Running setup.py install for mozlog 23:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Running setup.py install for moznetwork 23:25:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Running setup.py install for mozprocess 23:25:01 INFO - Running setup.py install for mozprofile 23:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Running setup.py install for mozrunner 23:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:25:01 INFO - Running setup.py install for mozscreenshot 23:25:01 INFO - Running setup.py install for moztest 23:25:01 INFO - Running setup.py install for mozversion 23:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:02 INFO - Cleaning up... 23:25:02 INFO - Return code: 0 23:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:02 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:25:02 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 23:25:02 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 23:25:02 INFO - Using env: {'DISPLAY': ':0', 23:25:02 INFO - 'HOME': '/home/cltbld', 23:25:02 INFO - 'LANG': 'en_US.UTF-8', 23:25:02 INFO - 'LANGUAGE': 'en_US:en', 23:25:02 INFO - 'LOGNAME': 'cltbld', 23:25:02 INFO - 'MAIL': '/var/mail/cltbld', 23:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:02 INFO - 'MOZ_NO_REMOTE': '1', 23:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:02 INFO - 'NO_EM_RESTART': '1', 23:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:02 INFO - 'PWD': '/builds/slave/test', 23:25:02 INFO - 'SHELL': '/bin/bash', 23:25:02 INFO - 'SHLVL': '1', 23:25:02 INFO - 'TERM': 'linux', 23:25:02 INFO - 'TMOUT': '86400', 23:25:02 INFO - 'USER': 'cltbld', 23:25:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:02 INFO - '_': '/tools/buildbot/bin/python'} 23:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:02 INFO - Running setup.py (path:/tmp/pip-o2XRRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:02 INFO - Running setup.py (path:/tmp/pip-H3kmT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:02 INFO - Running setup.py (path:/tmp/pip-HMOOjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:02 INFO - Running setup.py (path:/tmp/pip-caF0qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:02 INFO - Running setup.py (path:/tmp/pip-bifnrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:02 INFO - Running setup.py (path:/tmp/pip-_Qvvt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:02 INFO - Running setup.py (path:/tmp/pip-OYA8WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:02 INFO - Running setup.py (path:/tmp/pip-KvKhn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:02 INFO - Running setup.py (path:/tmp/pip-FNeWPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:02 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)) 23:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:02 INFO - Running setup.py (path:/tmp/pip-MRR8P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:03 INFO - Running setup.py (path:/tmp/pip-BzPGol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:03 INFO - Running setup.py (path:/tmp/pip-2J2skE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:03 INFO - Running setup.py (path:/tmp/pip-aYR7Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:03 INFO - Running setup.py (path:/tmp/pip-w3wmmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:03 INFO - Running setup.py (path:/tmp/pip-qyNIZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:03 INFO - Running setup.py (path:/tmp/pip-oCFMul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:03 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)) 23:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:03 INFO - Running setup.py (path:/tmp/pip-IhLU1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:03 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)) 23:25:03 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)) 23:25:03 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)) 23:25:03 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)) 23:25:03 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)) 23:25:03 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)) 23:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:05 INFO - Downloading blessings-1.5.1.tar.gz 23:25:05 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 23:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:05 INFO - Installing collected packages: blessings 23:25:05 INFO - Running setup.py install for blessings 23:25:05 INFO - Successfully installed blessings 23:25:05 INFO - Cleaning up... 23:25:05 INFO - Return code: 0 23:25:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:05 INFO - Reading from file tmpfile_stdout 23:25:05 INFO - Current package versions: 23:25:05 INFO - argparse == 1.2.1 23:25:05 INFO - blessings == 1.5.1 23:25:05 INFO - blobuploader == 1.2.4 23:25:05 INFO - docopt == 0.6.1 23:25:05 INFO - manifestparser == 1.1 23:25:05 INFO - mozInstall == 1.12 23:25:05 INFO - mozcrash == 0.16 23:25:05 INFO - mozdebug == 0.1 23:25:05 INFO - mozdevice == 0.47 23:25:05 INFO - mozfile == 1.2 23:25:05 INFO - mozhttpd == 0.7 23:25:05 INFO - mozinfo == 0.9 23:25:05 INFO - mozleak == 0.1 23:25:05 INFO - mozlog == 3.1 23:25:05 INFO - moznetwork == 0.27 23:25:05 INFO - mozprocess == 0.22 23:25:05 INFO - mozprofile == 0.27 23:25:05 INFO - mozrunner == 6.11 23:25:05 INFO - mozscreenshot == 0.1 23:25:05 INFO - mozsystemmonitor == 0.0 23:25:05 INFO - moztest == 0.7 23:25:05 INFO - mozversion == 1.4 23:25:05 INFO - psutil == 3.1.1 23:25:05 INFO - requests == 1.2.3 23:25:05 INFO - wsgiref == 0.1.2 23:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:25:05 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 23:25:05 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 23:25:05 INFO - Using env: {'DISPLAY': ':0', 23:25:05 INFO - 'HOME': '/home/cltbld', 23:25:05 INFO - 'LANG': 'en_US.UTF-8', 23:25:05 INFO - 'LANGUAGE': 'en_US:en', 23:25:05 INFO - 'LOGNAME': 'cltbld', 23:25:05 INFO - 'MAIL': '/var/mail/cltbld', 23:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:05 INFO - 'MOZ_NO_REMOTE': '1', 23:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:05 INFO - 'NO_EM_RESTART': '1', 23:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:05 INFO - 'PWD': '/builds/slave/test', 23:25:05 INFO - 'SHELL': '/bin/bash', 23:25:05 INFO - 'SHLVL': '1', 23:25:05 INFO - 'TERM': 'linux', 23:25:05 INFO - 'TMOUT': '86400', 23:25:05 INFO - 'USER': 'cltbld', 23:25:05 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:05 INFO - '_': '/tools/buildbot/bin/python'} 23:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 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)) 23:25:05 INFO - Cleaning up... 23:25:05 INFO - Return code: 0 23:25:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:25:05 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 23:25:05 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 23:25:05 INFO - Using env: {'DISPLAY': ':0', 23:25:05 INFO - 'HOME': '/home/cltbld', 23:25:05 INFO - 'LANG': 'en_US.UTF-8', 23:25:05 INFO - 'LANGUAGE': 'en_US:en', 23:25:05 INFO - 'LOGNAME': 'cltbld', 23:25:05 INFO - 'MAIL': '/var/mail/cltbld', 23:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:05 INFO - 'MOZ_NO_REMOTE': '1', 23:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:05 INFO - 'NO_EM_RESTART': '1', 23:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:05 INFO - 'PWD': '/builds/slave/test', 23:25:05 INFO - 'SHELL': '/bin/bash', 23:25:05 INFO - 'SHLVL': '1', 23:25:05 INFO - 'TERM': 'linux', 23:25:05 INFO - 'TMOUT': '86400', 23:25:05 INFO - 'USER': 'cltbld', 23:25:05 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:05 INFO - '_': '/tools/buildbot/bin/python'} 23:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:06 INFO - Downloading/unpacking jsonschema 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:25:07 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 23:25:07 INFO - Downloading/unpacking functools32 (from jsonschema) 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25:07 INFO - Downloading functools32-3.2.3-2.tar.gz 23:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:25:08 INFO - warning: no files found matching '*.txt' 23:25:08 INFO - no previously-included directories found matching 'build' 23:25:08 INFO - no previously-included directories found matching 'dist' 23:25:08 INFO - no previously-included directories found matching '.git*' 23:25:08 INFO - Installing collected packages: jsonschema, functools32 23:25:08 INFO - Running setup.py install for functools32 23:25:08 INFO - warning: no files found matching '*.txt' 23:25:08 INFO - no previously-included directories found matching 'build' 23:25:08 INFO - no previously-included directories found matching 'dist' 23:25:08 INFO - no previously-included directories found matching '.git*' 23:25:08 INFO - Successfully installed jsonschema functools32 23:25:08 INFO - Cleaning up... 23:25:08 INFO - Return code: 0 23:25:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:25:08 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')]} 23:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:08 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')]} 23:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:08 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 0x7fd972b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, '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': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', '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 23:25:08 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 23:25:08 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 23:25:08 INFO - Using env: {'DISPLAY': ':0', 23:25:08 INFO - 'HOME': '/home/cltbld', 23:25:08 INFO - 'LANG': 'en_US.UTF-8', 23:25:08 INFO - 'LANGUAGE': 'en_US:en', 23:25:08 INFO - 'LOGNAME': 'cltbld', 23:25:08 INFO - 'MAIL': '/var/mail/cltbld', 23:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:08 INFO - 'MOZ_NO_REMOTE': '1', 23:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:08 INFO - 'NO_EM_RESTART': '1', 23:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:08 INFO - 'PWD': '/builds/slave/test', 23:25:08 INFO - 'SHELL': '/bin/bash', 23:25:08 INFO - 'SHLVL': '1', 23:25:08 INFO - 'TERM': 'linux', 23:25:08 INFO - 'TMOUT': '86400', 23:25:08 INFO - 'USER': 'cltbld', 23:25:08 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:08 INFO - '_': '/tools/buildbot/bin/python'} 23:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:08 INFO - Downloading/unpacking flake8 23:25:08 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 23:25:08 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 23:25:08 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 23:25:08 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 23:25:08 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 23:25:08 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 23:25:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:25:10 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 23:25:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:25:10 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 23:25:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 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 23:25:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:10 INFO - no previously-included directories found matching 'docs/_build' 23:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:25:10 INFO - Running setup.py install for pep8 23:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:11 INFO - no previously-included directories found matching 'docs/_build' 23:25:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:25:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:25:11 INFO - Cleaning up... 23:25:11 INFO - Return code: 0 23:25:11 INFO - Running post-action listener: _resource_record_post_action 23:25:11 INFO - Running post-action listener: _start_resource_monitoring 23:25:11 INFO - Starting resource monitoring. 23:25:11 INFO - ##### 23:25:11 INFO - ##### Running install step. 23:25:11 INFO - ##### 23:25:11 INFO - Running pre-action listener: _resource_record_pre_action 23:25:11 INFO - Running main action method: install 23:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:11 INFO - Reading from file tmpfile_stdout 23:25:11 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:11 INFO - Reading from file tmpfile_stdout 23:25:11 INFO - Output received: 23:25:11 INFO - Usage: mozinstall [options] installer 23:25:11 INFO - Options: 23:25:11 INFO - -h, --help show this help message and exit 23:25:11 INFO - -d DEST, --destination=DEST 23:25:11 INFO - Directory to install application into. [default: 23:25:11 INFO - "/builds/slave/test"] 23:25:11 INFO - --app=APP Application being installed. [default: firefox] 23:25:11 INFO - mkdir: /builds/slave/test/build/application 23:25:11 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'] 23:25:11 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 23:25:26 INFO - Reading from file tmpfile_stdout 23:25:26 INFO - Output received: 23:25:26 INFO - /builds/slave/test/build/application/firefox/firefox 23:25:26 INFO - Running post-action listener: _resource_record_post_action 23:25:26 INFO - ##### 23:25:26 INFO - ##### Running run-tests step. 23:25:26 INFO - ##### 23:25:26 INFO - Running pre-action listener: _resource_record_pre_action 23:25:26 INFO - Running main action method: run_tests 23:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:26 INFO - Python 2.7.3 23:25:26 INFO - Return code: 0 23:25:26 INFO - grabbing minidump binary from tooltool 23:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:26 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 0x101c0b0>, '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 0x101cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:26 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 23:25:26 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 23:25:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:26 INFO - Return code: 0 23:25:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:25:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:25:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:25:27 INFO - Return code: 0 23:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 23:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 23:25:27 INFO - Using env: {'DISPLAY': ':0', 23:25:27 INFO - 'HOME': '/home/cltbld', 23:25:27 INFO - 'LANG': 'en_US.UTF-8', 23:25:27 INFO - 'LANGUAGE': 'en_US:en', 23:25:27 INFO - 'LOGNAME': 'cltbld', 23:25:27 INFO - 'MAIL': '/var/mail/cltbld', 23:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:27 INFO - 'MOZ_NO_REMOTE': '1', 23:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:27 INFO - 'NO_EM_RESTART': '1', 23:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:27 INFO - 'PWD': '/builds/slave/test', 23:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:27 INFO - 'SHELL': '/bin/bash', 23:25:27 INFO - 'SHLVL': '1', 23:25:27 INFO - 'TERM': 'linux', 23:25:27 INFO - 'TMOUT': '86400', 23:25:27 INFO - 'USER': 'cltbld', 23:25:27 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996', 23:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:27 INFO - '_': '/tools/buildbot/bin/python'} 23:25:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 23:25:28 INFO - mozversion INFO | application_buildid: 20151217224651 23:25:28 INFO - mozversion INFO | application_changeset: 63254aa6dfabeced552c9401cf9fb3cfa9b7add4 23:25:28 INFO - mozversion INFO | application_display_name: Nightly 23:25:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:28 INFO - mozversion INFO | application_name: Firefox 23:25:28 INFO - mozversion INFO | application_remotingname: firefox 23:25:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:25:28 INFO - mozversion INFO | application_vendor: Mozilla 23:25:28 INFO - mozversion INFO | application_version: 46.0a1 23:25:28 INFO - mozversion INFO | platform_buildid: 20151217224651 23:25:28 INFO - mozversion INFO | platform_changeset: 63254aa6dfabeced552c9401cf9fb3cfa9b7add4 23:25:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:25:28 INFO - mozversion INFO | platform_version: 46.0a1 23:25:28 INFO - 2015-12-17 23:25:28,050 DEBUG : using testdate: 1450423528 23:25:28 INFO - 2015-12-17 23:25:28,050 DEBUG : actual date: 1450423528 23:25:28 INFO - 2015-12-17 23:25:28,129 INFO : starting webserver on 'localhost:58297' 23:25:28 INFO - 2015-12-17 23:25:28,130 INFO : Starting test suite talos-linux64-ix-056 23:25:28 INFO - 2015-12-17 23:25:28,130 INFO : Starting test dromaeo_css 23:25:28 INFO - 2015-12-17 23:25:28,130 DEBUG : operating with platform_type : linux_ 23:25:28 INFO - 2015-12-17 23:25:28,131 INFO : Initialising browser for dromaeo_css test... 23:25:28 INFO - 2015-12-17 23:25:28,145 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps63pjC/profile http://localhost:58297/getInfo.html 23:25:33 INFO - 2015-12-17 23:25:33,403 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:25:33 INFO - 2015-12-17 23:25:33,404 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:25:33 INFO - 2015-12-17 23:25:33,404 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:25:33 INFO - 2015-12-17 23:25:33,404 DEBUG : BROWSER_OUTPUT: __metrics 23:25:33 INFO - 2015-12-17 23:25:33,500 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] 23:25:33 INFO - 2015-12-17 23:25:33,576 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] 23:25:34 INFO - 2015-12-17 23:25:34,515 INFO : Browser initialized. 23:25:34 INFO - 2015-12-17 23:25:34,515 INFO : Running cycle 1/1 for dromaeo_css test... 23:25:34 INFO - 2015-12-17 23:25:34,516 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps63pjC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:25:46 INFO - 2015-12-17 23:25:46,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 150142976 23:25:46 INFO - 2015-12-17 23:25:46,574 DEBUG : BROWSER_OUTPUT: 23:26:38 INFO - 2015-12-17 23:26:38,048 DEBUG : BROWSER_OUTPUT: 1450423598047 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] 23:28:50 INFO - 2015-12-17 23:28:50,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58297/tests/dromaeo/cssquery-ext.html) 23:28:51 INFO - 2015-12-17 23:28:51,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 253423616 23:28:51 INFO - 2015-12-17 23:28:51,492 DEBUG : BROWSER_OUTPUT: 23:31:54 INFO - 2015-12-17 23:31:54,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-ext.html (next: http://localhost:58297/tests/dromaeo/cssquery-jquery.html) 23:31:54 INFO - 2015-12-17 23:31:54,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 234356736 23:31:54 INFO - 2015-12-17 23:31:54,600 DEBUG : BROWSER_OUTPUT: 23:34:56 INFO - 2015-12-17 23:34:56,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58297/tests/dromaeo/cssquery-mootools.html) 23:34:57 INFO - 2015-12-17 23:34:57,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 235225088 23:34:57 INFO - 2015-12-17 23:34:57,299 DEBUG : BROWSER_OUTPUT: 23:37:59 INFO - 2015-12-17 23:37:59,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58297/tests/dromaeo/cssquery-prototype.html) 23:37:59 INFO - 2015-12-17 23:37:59,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 216965120 23:37:59 INFO - 2015-12-17 23:37:59,768 DEBUG : BROWSER_OUTPUT: 23:41:02 INFO - 2015-12-17 23:41:02,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58297/tests/dromaeo/cssquery-yui.html) 23:41:03 INFO - 2015-12-17 23:41:03,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 217673728 23:41:03 INFO - 2015-12-17 23:41:03,086 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/dromaeo/cssquery-yui.html (next: http://localhost:58297/tests/dromaeo/cssquery-dojo.html) 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 263581696 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.4886147201296;2694.6766388033416;2717.062613398377;2730.6723193216817;2760.9999999999995;4490.1019796040755;4603.976980115095;4659.207934651109;4690.882727931799;4709.128811169936;4634.698744581599;4673.088747694201;4747.477777444478;4774.4270687517455;4796.184648609736;4366.8908277293085;4367.650587952956;4390.604845563898;4481.1037792441475;4500.392447019643;4425.31407631816;4484.103179364124;4487.39420178275;4490.842820501283;4529.682922195448;4206.26390381682;4264.211120942636;4316.611504964537;4323.783810809447;4366.585174408426;4346.848085257409;4352.695311328208;4355.194289056535;4357.542458041923;4400.911981760379;4346.217680817452;4347.630451411634;4348.282533381988;4373;4391.341298805173;4514.954850451486;4640.280756482751;4648.790804413809;4681.88295292617;4804.183288840871;5097.6941383517105;5099.643024988252;5109.156989096795;5122.487751224848;5125.431130741203;5128.051310507568;5131.563817075553;5133.974330128362;5170.482951704837;5175.042617115846;4473.753943533105;4565.543445655408;4586.793594288265;4654.069186162781;4787.952120478821;5239.083160446907;5271.314729085195;5271.683698978073;5279.208118782137;5330.973345133327;5030.245463180552;5038.244263360525;5039.69761814285;5041.319421878;5090.847274581768;4854.247591623304;4956.5786908112495;4962;4995.525425084611;5097.413797413271;5040.49595040493;5043.672161309503;5047.242913562922;5061.898762024739;5110.872228194251;5031.742064483879;5037.773300201499;5038.319826823332;5041.168207245763;5041.319421878073;4089.754614723126;4179.456670632799;4180.874573762792;4210.347396153601;4302.569743025735;3748.1004558905665;3752.1745216052423;3756.6431189037;3757.9436308455397;3798.2213646202463;4294.205571969133;4346.456692913386;4380.846670366522;4399.472063352418;4424.048829501673;4772.973810630731;4884.9511504884495;4884.95115048852;4921.458639549646;5035.496450354935;4301.376300436419;4303.698741088094;4320.4383430153875;4348.67384946124;4351.303791393362;4463.464384273908;4470.418845550058;4472.217361961643;4472.44094488189;4510.21071312519;4632.86101416958;4724.220503617003;4729.881752956066;4772.880677983078;4772.952270477251;4927.162382394929;5042.9243561345875;5049.899002020013;5066;5068.2904393384215;4820.638452116035;4823.855284341475;4838.177509823268;4849.975750121368;4867.026594681149;4810.855674329776;4920.384951881015;5024.4473107957365;5036.949630503795;5071.467495912876;5005.974970125126;5035.169197082587;5081.542661160365;5085.821996230115;5132.10188217068;4936.827211047596;5022.623303252198;5025.271335656236;5025.3718285214345;5067.594592432671;4702.811887524461;4820.132376172322;5013.072581572421;5025.974870125772;5036.420811606712;4688.437387513383;4692.155412025868;4721.173794586002;4836.395450568679;4845.830395936126;4986.47641997585;4990.3762029746285;4997.175466048061;5000.374953130859;5002.874928126826;4891.926621100757;4895.681780684244;4902.828401005948;4903.141950158637;4933.358663373739 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.21851298925;561.7893290016244;562.151151760841;568.0910543130991;571.400029968533;26703.4659306814;27242.31894202646;27271.45457090857;35046.47430288548;35268.64731352692;39610.207795844064;40076.398854017214;40109.59890401095;40133.799331003305;40291.19417611646;7880.842383152333;8107.797305067362;8116.985376827896;8120.553369564672;8132.105468398471;7127.607981561038;7367.600155970348;7864.46642904631;10112.797744045114;10423.426711530901;10046.547905344278;10184.541695623715;10188.64339748109;10199.694009179737;10200.13298869597;7185.964070179668;9929.851052234186;10002.449865257408;10028.448435336053;10035.247356448295;7039;10113.49432528378;10472.633457828939;10477.58089676412;10488.31825931312;36697.449538256944;37160.81419592912;37194.25611487782;37209.62790372116;37251;2770.6259654946525;2785.843874791959;2862.413205292931;2926.88292468301;3561.3589553880292;26435.471290574274;26595;26665.46669066608;27116.72883271162;27584.724152758416;3393.6097348804956;3469.8612055517747;3477.791332520057;3572.0534058474527;3572.1962558424407;214790;218152;218328;218938;219024;51942;53261.46738532565;55355.44644553583;55828.720856395455;55922.72038639862;60120.398796012356;61392.69303653453;61800.69099654473;61805.69097154486;61838.690806546576;13162.473501060042;13351.332433378293;13355.399007044707;13360.5323813668;13375.33123343829;9857.260705447121;9927.702168934944;9928.851067233998;9932.602695892228;9933.552990115317;19002.524936876413;19121.23515059382;19150.233990640496;19242.23031078741;19300.80699193018;7483.700651973969;7643.191458606401;7845.646945887449;7847.48991315574;7912.802179945433;826.3059030414361;844.4511067805853;939.3377668743519;968.8837339519303;995.9203263738883;26041.73958260431;26453.33866653349;26625.33436664099;26761.598576021373;26803.865980669972;979.5543027922279;1034.7206254311293;1065.0627447846;1095.45774841454;1108.5510368300852;13769.173849569059;13851.930740346234;13956;13986.30068496571;14004.929975350058;252231;259019;259085;259150;259862;45023.549764501935;45318;45656.77171614121;45676.314855277196;45707.08585828265;1221.5175005872632;1229.0536287058915;1229.655696405008;1233.747081848219;1242.2174030360816;21775.346739597837;24370.26889193327;24891.751082488943;26586.867065665323;26643.866780665972;36245.09387265234;36679.81660091683;36685;36710;36759.08102297464;199933.00033500322;202701;202748;203607.87372441893;220298;23928.28215153548;28410.85794571014;28716.282092947844;28968;29031;32753.18117047093;44839.55160448354;46406.53593464157;46965;47068.29397558971;32521;32708.509372358956;33022.50466243056;33379.666203337656;33670.66329336773;32760.83619581887;32832.343353133285;32835.67164328326;33271.66728332783;33310.66689333173;32133.357332852745;32616.673833261364;32713.34573308568;32878.67121328756;33168.668313317525;28850.27874303075;29414.41171176607;30422.847885760428;30538.739558390032;30636.387272254877;23422.414439638465;23440.413989650395;23493.76506234984;23843.165489207793;23856.761432385454 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.66476194281836;331.64348325550037;334.31131868351196;334.8426239667356;339.6145374999376;12663.240205587672;12983.870161298384;14701.999999999987;15304.69390612187;16244.675106497878;9096.499692516909;9208.447493150416;10558.524866381013;11343.886561134386;12451.937740311309;4430.800613972379;4472.955270447303;4556.9088618227615;4865.464798872121;4879.853604391857;3419.829008549575;4935.481774413689;4983.7508124593805;4995.275685025687;4997.600191984632;3525.7179425646013;5009.524095210967;5162.303089082963;5177.58579313654;5179.585633149339;5007.5993920486635;5093.592512598983;5101.591872650179;5125.179971204608;5147.279380886679;5008.198688209869;5008.574271186953;5009.5491405773655;5013.373328333958;5014.348134742497;11452.599159029394;11495.310281383061;15049.473268435551;19806;19815.40553783389;1834.174621420366;1834.220456306078;1844.8339649431482;1862.981370186308;1924.2591602233101;12027.338496382696;12157.878421215763;12418.751624967541;12721.809172862415;12945.482180712761;1656.900585964846;1664.8251933547047;1670.590705277215;1685.8819882608223;1705.4201571465637;55417;56617.71691141518;56966;57072.42927570712;57870.421295786924;9653.71038868835;9686.806263874683;9709.854352184722;9750.366226195274;9839.065288797552;12428.875711242952;12456.377181140906;12458.439370228361;12505.874941250471;12574;6464.0627109069865;6671.39957403836;6712.664366781739;6863.347981941708;6901.551399159039;6706.22878368984;6718.22740384862;6801.4898882584;6812.795616131524;6818.897716534256;4037.798110094542;4160.83356665736;4180.122174343422;4260.190563792869;4313.396124542566;1670.8663306935416;1705.4116329866176;1749.7112976358758;1760.595063135486;1795.380593695173;371.5968174530665;658.9374009469093;914.2046419614977;925.5881132895931;936.5223735894742;8841.469511829311;9042.909570904207;9263.953680231556;9605.18355939753;15421.922890385476;793.6626933553217;839.0267289943758;839.3536976528039;852.1308265569085;952.0574631115146;8742.169493898069;8744;8800.251978581764;8824.073472285447;8982.326325525612;397206;456454;457168;465002;474168;37364.43953340702;37573;37586.81206593949;56988.71505642445;71555.56888862194;1077.9245452818227;1078.449990504848;1101.2071308657753;1123.8707548632012;1126.8929451702074;14435.422583096979;14588.051776634486;14934.477293294682;15109.697806043598;15231.543053708407;33886.322273554884;34343.141421464665;34719.47920781241;35323.64676353306;36232.27535449329;45256.77371613121;45536.08927821491;45767.54232457766;45882.85292867705;47391.289130663754;8399.118092600189;8628.82742345137;8704.956475217583;8719.084496127814;8736.388452808242;10170.135538479311;15000.924995374953;15983.120928349052;16628;16673.91619544726;10870.891291087304;12823.294718790183;13504.527341542998;13857;13961.301934903417;13109.344532773513;13386.799198011842;13428.597142085753;13444.865551344752;13477.595672129852;13415.32923353848;13428;13868.583942481742;14141.787873181705;14170.291485425481;8433.36749743784;8479.618417171365;8608.741737747878;8618.82762344737;8640.78398040054;10542.736431589272;13952.720945581235;14142.50501232452;14146.363413646204;14239.50161744334 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1410.5838777560618;1600.5198440467861;1656.8011838579373;1669.7161482547965;1690.3492155520128;5943.524518038557;6822.7270909163635;7008.053912721781;7016.087908571879;7045.718171273155;6988;7115.928840711591;7141.964290178542;7144.178419481761;7151.463640226991;1686.3001854230479;1720.8021077576113;1724.3792234795465;2037.5822956293962;2074.7551469118484;2056.0953180600486;2067.400453868376;2074.222166687492;2076.6781148921864;2079.573687394088;2039.5105174758025;2065.710800487933;2071.482129467633;2080.9687854682115;2104.926327578535;1982.9801701983013;1995.2617531513288;1996.7304413904155;1997.3608445297511;2004.1883037369817;2024.6052019856133;2039.1537511932531;2043.0295609585476;2046.3758553641132;2046.467918341227;7060.152781666182;7143.1428228612895;7157.785266442015;7169.89245161323;7179.425645948364;4079.918401631951;4190.120074784299;4207.495100587949;4223.767692776896;4224.809883555247;2515.5220508103585;2518.0305582350743;2540.0982651158756;2552.66815314008;2577.832440891336;824.3570015388007;834.3450391442689;855.9614817333235;874.3136637739344;876.6055275126218;9269.629214831399;9373.578188981512;9378.718638440858;9418.058194180596;9447.527623618791;3752.568454627698;3772.07584141887;3776.981115094407;3836.827342769582;3929.1159489115294;8356.247937685637;8406.579671016425;8417.873731894026;8439.70461033861;8452.323814094858;4116.423700681907;4166.645835103989;4172.248995180836;4178.435911151955;4180.979095104505;3750.4936833527127;3754.0990162360836;3760.0599850037493;3772.3775577029483;3787.450819631138;2965.1104668599332;2981.2844917220145;3004.7746419018663;3294.390537750524;3354.681305275995;937.0863408176973;976.8192884316425;992.1021475564626;1100.5157730598512;1105.5522513382093;889.5196593839383;927.0173615966962;977.6773664690635;1193.928364298145;1199.1066655341651;6428;6484.351564843478;6509.9023514647315;6538.019297105472;6540.640264785482;537.0413811346727;540.2922171954751;541.258475888036;541.7643325153492;696.3210869402393;4857.878553036202;4945.554900059012;4949.90100197994;4964.975175124174;4967.801287948441;7008.649567521604;7074.6816393262425;8339.791505212297;8646.357192133475;8673.566321683891;8026.117127116013;8132.959335203286;8169.754907352789;8182;8294.253517183482;6517.9348206517325;6551.934480655228;6659.733610655519;6697.732090716414;6706;6730.93269067303;6770.932290677227;6777.322267773183;6790.185177778698;6859.691313890787;7671.347935425551;7694.8076298090755;7763.184865589032;7799.5320280783335;7849.097353804385;7902.604869756604;7983.1617680142745;8032.919670803217;8076.434649574473;8143.144969778088;6062.757489700539;6163.3836616338;6168.876622467616;6175.505959523317;6184.165137706352;6854.931450685429;6983.057287266154;6987;6989.231184569795;6996.790096296915;5164.664296820694;6497.967510162419;6590.637514936724;6658.6337751424135;6742.696578653874;6259.2488901332135;6307.05394190875;6380.074889141141;6429.7106630200815;6452.290248072614;6268.498520118288;6297.496200303873;6300.464460520724;6315.115883776367;6321.841953951188;5650.802221922213;5661.037623603915;5669.943300566942;5677.205191273142;5677.233573467529;5814.854628634318;5963.403659634002;5976.910346344721;5977.491913187428;6002.0996850472775 23:44:05 INFO - 2015-12-17 23:44:05,889 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.62105573282605;296.09985643643324;298.583476050909;302.66253127762553;303.3039175093161;5228.503292187241;5247.553957913572;5305.761240744167;5392.0294347017525;5433.809816656408;5213.244079608455;5282.5245727884485;5284.682919024861;5295.179247216678;5299.708516031616;3859.7298189126773;4102.241085399196;4102.856400025999;4109;4112.650424713888;3946.2304850554156;3951.308521008826;3991.361382178852;4020.4974378202724;4034.919301613966;3985.6213659702426;4001.6398524132824;4017.698672599552;4018.839246430139;4025.315696331616;3838.769673819552;3915.393114067324;3966.8809935701975;4013.2776100301935;4016.4778578784717;3456.9827150864085;3457.135716070982;3461.7230621550216;3476.8261586920808;3485.8082805445692;5019.071471777733;5030.943501864613;5035.521625445614;5035.62232832539;5037.118504261776;4586.197415452282;4609.608183304423;4611.723296602215;4614.2617181250835;4619.607333376667;5307.548858347045;5466.398696143421;5490.094134467808;5510.366307874606;5523.28197334348;3731.5708693500324;3734.402495600691;3734.5705243897028;3746.6628003479545;3762.285165818513;5770.682612456313;5839.737211825478;5858.853528661817;5860.179574859523;5870.882582348372;3930.1157239620857;3944.2308749793515;3944.9408258876138;3945.0926286953586;3946.4869566956686;3995.141044675409;3995.840166393312;3996.4005399189773;4000.5199376075057;4001.47980762499;4573.131105090022;4621.768911554409;4623.098495793288;4624.5375462453485;4633.675642705046;5577.553795696334;5579.218909352694;5592.804251851166;5593.74828132735;5598.86002849932;1387.8550196088268;1403.1510935883848;1404.1364560795037;1404.3890907455086;1405.1147776900486;937.2642475656577;939.9718008459757;942.9717108486619;958.6980101268078;959.2613687460616;4900.558949694545;4901.3383193269165;4903.166461701519;4909.042736666387;4913.11563918491;5789.8552536186935;5791.131330300489;5798.985177593904;5807.332156801937;5809.157672137601;4896.436909755353;4903.8528844134735;4905.969746353235;4909.729964851967;4913.115639184981;3032.2116249775218;3087.1047396255285;3095.3190298134373;3116.703913128249;3123.2504198992533;5506.779728810883;5529.751161197675;5534.944650553443;5540.556755459554;5547.11246200606;5988.550858685616;5996.640201587918;6006.339302676702;6007.27912650476;6020.458158765732;5483.1227003680815;5542.91685624716;5543.833684989457;5544.805931792449;5550.084236101079;5670.943290567042;5803.622764520293;5814.680192589448;5833.241678581757;5834.649921004753;5661.264035675335;5685.175649530877;5685.630434021776;5686.2607860977805;5693.430656934439;5506.862328441821;5508.779648814003;5508.80719174843;5511.263951855153;5521.337439507124;3888.6111388860886;3926.1951299984007;3975.4434379187514;3979.442877997025;3981.820818063252;5819.76720931158;5822.737976791139;5827.970860145672;5834.737436815269;5852.239208902815;5595.132754423071;5596.104623260258;5598.580106491948;5599.580031497572;5602.3837377887585;5602.663840169603;5609.411011843861;5611.7194140292;5613.101903695389;5619.80330688424;5336.946630533645;5430.15832545956;5473.370562385217;5474.890502190014;5486.890262194814;5415.052365835884;5559.861003474945;5620.353659329229;5630.577706671934;5641.661500309994;5373.7850485980125;5430.67415955044;5433.809816656398;5438.102713052302;5449.536789372948 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: |5;yui.html;596.8507873031742;606.805822136916;672.5292295393223;673.4545018534988;683.5351960666744;10844.566217351297;10908.236423450362;11096.05683516901;11128;11134.33194008358;10595.523201455933;10662.413567253818;10694.78610427791;10706.357618542894;10748.570057197703;632.4876849751715;640.9134766806468;774.9457537972344;777.933875620573;788.7909703928464;763.625823346559;770.5415277909635;770.9653065612061;779.6530543907963;795.9363250939911;659.3406593406594;806.7862016565615;806.8507326144653;815.6207363575936;838.0278876503257;635.7965451055641;647.6502688548178;648.4941745438565;648.708081363386;807.7294106474338;577.8237637520555;582.8659408336064;585.060977131706;597.5548216578633;606.5390303369427;10713.732156696067;10895.291806032583;10917.836232456519;10920.836187457195;10921.071708904752;11042.779144417147;11044.502997365138;11112.833307500314;11367.204295699305;11584;8461.74614761552;8462.898055780232;8472.49165050099;8604.182602652738;8742.475451472868;3185.9681403186137;3192.4413227685063;3243.124356423776;3269.8392070814757;3303.80177189367;37910;37959.62040379588;38012;38219.23561528782;38444.615553844385;8900.332475064397;8997.55012249398;9007.77480562978;9024.954875225712;9038.028210956778;16672.249748761336;16700.164991750364;16700.331986720637;16709.582260443585;16755.162241887858;6048.979795211604;6107.206063211843;6108.175396321529;6232.065190221503;6292.402221788922;3422.3155368926314;3439.720535111748;3532.4171511700283;3542.6634469725336;3606.5311509503595;2474.3195621204313;2477.7770000700025;2495.8752062396807;2500.349909023667;2500.4874000829786;429.14385800328546;433.40506934481414;437.51217392607015;444.2470013327379;445.8907567645883;405.98301255355733;445.26308958673445;465.96039336656764;525.2987262005266;553.1868153813887;7747.22527747232;7971;7983.640736166886;8066.274035336848;8224.095349511548;457.77340216593;460.69594067915017;541.0369542214785;561.264743186427;585.7159277750287;3276.967230327714;3365.5793025871767;3401.2517246205794;3421.3328400962073;3421.623621401644;47437.288440673416;47688.52311476841;47955.280670789965;48110;48410;43175.35236971448;43716.12567748627;43799;43926.12147757027;44004.77997609991;38697.80651096727;39121.80439097843;39827;39895.80052099779;39897.40153897694;7210.387117094896;7264.709411623688;7316.561006339637;7334.486585938933;7493.138289096605;30246;30564.541531877483;30733.078007659806;30835.537466938462;31173.53239701452;35061.47407788936;35212;37097.814510927274;38143.80928095342;38437.03907402337;9316.161545460942;9614.55218496721;9660;9867.358621689567;9960.800783984425;10386.844197336895;10801.459927003461;10816.134709223086;10963.451827408757;10994.890051099386;10031.849522257318;10056.49717514136;10063.842658094412;10296.382217067;10512.737181570523;9739.269554783561;9779.706608801747;9893.703188904345;10027.899721002697;10189.847152292574;9686;9796.412215267106;9799.51002449889;9980.700578982642;10152.54313555877;8821.382503224713;8884.600192991202;9114.316426267924;9171.954140229256;9186.816263674822;8536.615852286786;8599.39804213724;8651.826963460822;8812.955935220283;8862.468251904906 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,935 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: __startTimestamp1450424645882__endTimestamp 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:44:05 INFO - 2015-12-17 23:44:05,890 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,891 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4671.89 Median:4787.95 stddev:488.58 (10.2%) stddev-sans-first:462.88 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: Values: 2622.5 2694.7 2717.1 2730.7 2761.0 4490.1 4604.0 4659.2 4690.9 4709.1 4634.7 4673.1 4747.5 4774.4 4796.2 4366.9 4367.7 4390.6 4481.1 4500.4 4425.3 4484.1 4487.4 4490.8 4529.7 4206.3 4264.2 4316.6 4323.8 4366.6 4346.8 4352.7 4355.2 4357.5 4400.9 4346.2 4347.6 4348.3 4373.0 4391.3 4515.0 4640.3 4648.8 4681.9 4804.2 5097.7 5099.6 5109.2 5122.5 5125.4 5128.1 5131.6 5134.0 5170.5 5175.0 4473.8 4565.5 4586.8 4654.1 4788.0 5239.1 5271.3 5271.7 5279.2 5331.0 5030.2 5038.2 5039.7 5041.3 5090.8 4854.2 4956.6 4962.0 4995.5 5097.4 5040.5 5043.7 5047.2 5061.9 5110.9 5031.7 5037.8 5038.3 5041.2 5041.3 4089.8 4179.5 4180.9 4210.3 4302.6 3748.1 3752.2 3756.6 3757.9 3798.2 4294.2 4346.5 4380.8 4399.5 4424.0 4773.0 4885.0 4885.0 4921.5 5035.5 4301.4 4303.7 4320.4 4348.7 4351.3 4463.5 4470.4 4472.2 4472.4 4510.2 4632.9 4724.2 4729.9 4772.9 4773.0 4927.2 5042.9 5049.9 5066.0 5068.3 4820.6 4823.9 4838.2 4850.0 4867.0 4810.9 4920.4 5024.4 5036.9 5071.5 5006.0 5035.2 5081.5 5085.8 5132.1 4936.8 5022.6 5025.3 5025.4 5067.6 4702.8 4820.1 5013.1 5026.0 5036.4 4688.4 4692.2 4721.2 4836.4 4845.8 4986.5 4990.4 4997.2 5000.4 5002.9 4891.9 4895.7 4902.8 4903.1 4933.4 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39146.78 Median:32327.18 stddev:59350.52 (183.6%) stddev-sans-first:59446.28 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: Values: 556.2 561.8 562.2 568.1 571.4 26703.5 27242.3 27271.5 35046.5 35268.6 39610.2 40076.4 40109.6 40133.8 40291.2 7880.8 8107.8 8117.0 8120.6 8132.1 7127.6 7367.6 7864.5 10112.8 10423.4 10046.5 10184.5 10188.6 10199.7 10200.1 7186.0 9929.9 10002.4 10028.4 10035.2 7039.0 10113.5 10472.6 10477.6 10488.3 36697.4 37160.8 37194.3 37209.6 37251.0 2770.6 2785.8 2862.4 2926.9 3561.4 26435.5 26595.0 26665.5 27116.7 27584.7 3393.6 3469.9 3477.8 3572.1 3572.2 214790.0 218152.0 218328.0 218938.0 219024.0 51942.0 53261.5 55355.4 55828.7 55922.7 60120.4 61392.7 61800.7 61805.7 61838.7 13162.5 13351.3 13355.4 13360.5 13375.3 9857.3 9927.7 9928.9 9932.6 9933.6 19002.5 19121.2 19150.2 19242.2 19300.8 7483.7 7643.2 7845.6 7847.5 7912.8 826.3 844.5 939.3 968.9 995.9 26041.7 26453.3 26625.3 26761.6 26803.9 979.6 1034.7 1065.1 1095.5 1108.6 13769.2 13851.9 13956.0 13986.3 14004.9 252231.0 259019.0 259085.0 259150.0 259862.0 45023.5 45318.0 45656.8 45676.3 45707.1 1221.5 1229.1 1229.7 1233.7 1242.2 21775.3 24370.3 24891.8 26586.9 26643.9 36245.1 36679.8 36685.0 36710.0 36759.1 199933.0 202701.0 202748.0 203607.9 220298.0 23928.3 28410.9 28716.3 28968.0 29031.0 32753.2 44839.6 46406.5 46965.0 47068.3 32521.0 32708.5 33022.5 33379.7 33670.7 32760.8 32832.3 32835.7 33271.7 33310.7 32133.4 32616.7 32713.3 32878.7 33168.7 28850.3 29414.4 30422.8 30538.7 30636.4 23422.4 23440.4 23493.8 23843.2 23856.8 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,892 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24471.87 Median:200621.90 stddev:73516.13 (36.6%) stddev-sans-first:73700.01 23:44:05 INFO - 2015-12-17 23:44:05,893 DEBUG : BROWSER_OUTPUT: Values: 328.7 331.6 334.3 334.8 339.6 12663.2 12983.9 14702.0 15304.7 16244.7 9096.5 9208.4 10558.5 11343.9 12451.9 4430.8 4473.0 4556.9 4865.5 4879.9 3419.8 4935.5 4983.8 4995.3 4997.6 3525.7 5009.5 5162.3 5177.6 5179.6 5007.6 5093.6 5101.6 5125.2 5147.3 5008.2 5008.6 5009.5 5013.4 5014.3 11452.6 11495.3 15049.5 19806.0 19815.4 1834.2 1834.2 1844.8 1863.0 1924.3 12027.3 12157.9 12418.8 12721.8 12945.5 1656.9 1664.8 1670.6 1685.9 1705.4 55417.0 56617.7 56966.0 57072.4 57870.4 9653.7 9686.8 9709.9 9750.4 9839.1 12428.9 12456.4 12458.4 12505.9 12574.0 6464.1 6671.4 6712.7 6863.3 6901.6 6706.2 6718.2 6801.5 6812.8 6818.9 4037.8 4160.8 4180.1 4260.2 4313.4 1670.9 1705.4 1749.7 1760.6 1795.4 371.6 658.9 914.2 925.6 936.5 8841.5 9042.9 9264.0 9605.2 15421.9 793.7 839.0 839.4 852.1 952.1 8742.2 8744.0 8800.3 8824.1 8982.3 397206.0 456454.0 457168.0 465002.0 474168.0 37364.4 37573.0 37586.8 56988.7 71555.6 1077.9 1078.4 1101.2 1123.9 1126.9 14435.4 14588.1 14934.5 15109.7 15231.5 33886.3 34343.1 34719.5 35323.6 36232.3 45256.8 45536.1 45767.5 45882.9 47391.3 8399.1 8628.8 8705.0 8719.1 8736.4 10170.1 15000.9 15983.1 16628.0 16673.9 10870.9 12823.3 13504.5 13857.0 13961.3 13109.3 13386.8 13428.6 13444.9 13477.6 13415.3 13428.0 13868.6 14141.8 14170.3 8433.4 8479.6 8608.7 8618.8 8640.8 10542.7 13952.7 14142.5 14146.4 14239.5 23:44:05 INFO - 2015-12-17 23:44:05,894 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,894 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4888.38 Median:6263.87 stddev:2577.07 (41.1%) stddev-sans-first:2571.05 23:44:05 INFO - 2015-12-17 23:44:05,894 DEBUG : BROWSER_OUTPUT: Values: 1410.6 1600.5 1656.8 1669.7 1690.3 5943.5 6822.7 7008.1 7016.1 7045.7 6988.0 7115.9 7142.0 7144.2 7151.5 1686.3 1720.8 1724.4 2037.6 2074.8 2056.1 2067.4 2074.2 2076.7 2079.6 2039.5 2065.7 2071.5 2081.0 2104.9 1983.0 1995.3 1996.7 1997.4 2004.2 2024.6 2039.2 2043.0 2046.4 2046.5 7060.2 7143.1 7157.8 7169.9 7179.4 4079.9 4190.1 4207.5 4223.8 4224.8 2515.5 2518.0 2540.1 2552.7 2577.8 824.4 834.3 856.0 874.3 876.6 9269.6 9373.6 9378.7 9418.1 9447.5 3752.6 3772.1 3777.0 3836.8 3929.1 8356.2 8406.6 8417.9 8439.7 8452.3 4116.4 4166.6 4172.2 4178.4 4181.0 3750.5 3754.1 3760.1 3772.4 3787.5 2965.1 2981.3 3004.8 3294.4 3354.7 937.1 976.8 992.1 1100.5 1105.6 889.5 927.0 977.7 1193.9 1199.1 6428.0 6484.4 6509.9 6538.0 6540.6 537.0 540.3 541.3 541.8 696.3 4857.9 4945.6 4949.9 4965.0 4967.8 7008.6 7074.7 8339.8 8646.4 8673.6 8026.1 8133.0 8169.8 8182.0 8294.3 6517.9 6551.9 6659.7 6697.7 6706.0 6730.9 6770.9 6777.3 6790.2 6859.7 7671.3 7694.8 7763.2 7799.5 7849.1 7902.6 7983.2 8032.9 8076.4 8143.1 6062.8 6163.4 6168.9 6175.5 6184.2 6854.9 6983.1 6987.0 6989.2 6996.8 5164.7 6498.0 6590.6 6658.6 6742.7 6259.2 6307.1 6380.1 6429.7 6452.3 6268.5 6297.5 6300.5 6315.1 6321.8 5650.8 5661.0 5669.9 5677.2 5677.2 5814.9 5963.4 5976.9 5977.5 6002.1 23:44:05 INFO - 2015-12-17 23:44:05,894 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,894 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4603.58 Median:5297.44 stddev:1379.43 (26.0%) stddev-sans-first:1344.81 23:44:05 INFO - 2015-12-17 23:44:05,895 DEBUG : BROWSER_OUTPUT: Values: 292.6 296.1 298.6 302.7 303.3 5228.5 5247.6 5305.8 5392.0 5433.8 5213.2 5282.5 5284.7 5295.2 5299.7 3859.7 4102.2 4102.9 4109.0 4112.7 3946.2 3951.3 3991.4 4020.5 4034.9 3985.6 4001.6 4017.7 4018.8 4025.3 3838.8 3915.4 3966.9 4013.3 4016.5 3457.0 3457.1 3461.7 3476.8 3485.8 5019.1 5030.9 5035.5 5035.6 5037.1 4586.2 4609.6 4611.7 4614.3 4619.6 5307.5 5466.4 5490.1 5510.4 5523.3 3731.6 3734.4 3734.6 3746.7 3762.3 5770.7 5839.7 5858.9 5860.2 5870.9 3930.1 3944.2 3944.9 3945.1 3946.5 3995.1 3995.8 3996.4 4000.5 4001.5 4573.1 4621.8 4623.1 4624.5 4633.7 5577.6 5579.2 5592.8 5593.7 5598.9 1387.9 1403.2 1404.1 1404.4 1405.1 937.3 940.0 943.0 958.7 959.3 4900.6 4901.3 4903.2 4909.0 4913.1 5789.9 5791.1 5799.0 5807.3 5809.2 4896.4 4903.9 4906.0 4909.7 4913.1 3032.2 3087.1 3095.3 3116.7 3123.3 5506.8 5529.8 5534.9 5540.6 5547.1 5988.6 5996.6 6006.3 6007.3 6020.5 5483.1 5542.9 5543.8 5544.8 5550.1 5670.9 5803.6 5814.7 5833.2 5834.6 5661.3 5685.2 5685.6 5686.3 5693.4 5506.9 5508.8 5508.8 5511.3 5521.3 3888.6 3926.2 3975.4 3979.4 3981.8 5819.8 5822.7 5828.0 5834.7 5852.2 5595.1 5596.1 5598.6 5599.6 5602.4 5602.7 5609.4 5611.7 5613.1 5619.8 5336.9 5430.2 5473.4 5474.9 5486.9 5415.1 5559.9 5620.4 5630.6 5641.7 5373.8 5430.7 5433.8 5438.1 5449.5 23:44:05 INFO - 2015-12-17 23:44:05,895 DEBUG : BROWSER_OUTPUT: 23:44:05 INFO - 2015-12-17 23:44:05,895 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11742.74 Median:459.23 stddev:13302.98 (2896.8%) stddev-sans-first:13313.97 23:44:05 INFO - 2015-12-17 23:44:05,896 DEBUG : BROWSER_OUTPUT: Values: 596.9 606.8 672.5 673.5 683.5 10844.6 10908.2 11096.1 11128.0 11134.3 10595.5 10662.4 10694.8 10706.4 10748.6 632.5 640.9 774.9 777.9 788.8 763.6 770.5 771.0 779.7 795.9 659.3 806.8 806.9 815.6 838.0 635.8 647.7 648.5 648.7 807.7 577.8 582.9 585.1 597.6 606.5 10713.7 10895.3 10917.8 10920.8 10921.1 11042.8 11044.5 11112.8 11367.2 11584.0 8461.7 8462.9 8472.5 8604.2 8742.5 3186.0 3192.4 3243.1 3269.8 3303.8 37910.0 37959.6 38012.0 38219.2 38444.6 8900.3 8997.6 9007.8 9025.0 9038.0 16672.2 16700.2 16700.3 16709.6 16755.2 6049.0 6107.2 6108.2 6232.1 6292.4 3422.3 3439.7 3532.4 3542.7 3606.5 2474.3 2477.8 2495.9 2500.3 2500.5 429.1 433.4 437.5 444.2 445.9 406.0 445.3 466.0 525.3 553.2 7747.2 7971.0 7983.6 8066.3 8224.1 457.8 460.7 541.0 561.3 585.7 3277.0 3365.6 3401.3 3421.3 3421.6 47437.3 47688.5 47955.3 48110.0 48410.0 43175.4 43716.1 43799.0 43926.1 44004.8 38697.8 39121.8 39827.0 39895.8 39897.4 7210.4 7264.7 7316.6 7334.5 7493.1 30246.0 30564.5 30733.1 30835.5 31173.5 35061.5 35212.0 37097.8 38143.8 38437.0 9316.2 9614.6 9660.0 9867.4 9960.8 10386.8 10801.5 10816.1 10963.5 10994.9 10031.8 10056.5 10063.8 10296.4 10512.7 9739.3 9779.7 9893.7 10027.9 10189.8 9686.0 9796.4 9799.5 9980.7 10152.5 8821.4 8884.6 9114.3 9172.0 9186.8 8536.6 8599.4 8651.8 8813.0 8862.5 23:44:05 INFO - 2015-12-17 23:44:05,897 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:44:05 INFO - 2015-12-17 23:44:05,897 DEBUG : BROWSER_OUTPUT: 23:44:06 INFO - 2015-12-17 23:44:06,649 INFO : Browser exited with error code: 0 23:44:06 INFO - 2015-12-17 23:44:06,669 INFO : Completed test dromaeo_css (00:18:38) 23:44:06 INFO - 2015-12-17 23:44:06,669 INFO : Starting test kraken 23:44:06 INFO - 2015-12-17 23:44:06,669 DEBUG : operating with platform_type : linux_ 23:44:06 INFO - 2015-12-17 23:44:06,670 INFO : Initialising browser for kraken test... 23:44:06 INFO - 2015-12-17 23:44:06,676 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDpZC1/profile http://localhost:58297/getInfo.html 23:44:11 INFO - 2015-12-17 23:44:11,562 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:44:11 INFO - 2015-12-17 23:44:11,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:44:11 INFO - 2015-12-17 23:44:11,562 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:44:11 INFO - 2015-12-17 23:44:11,562 DEBUG : BROWSER_OUTPUT: __metrics 23:44:11 INFO - 2015-12-17 23:44:11,671 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] 23:44:11 INFO - 2015-12-17 23:44:11,747 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] 23:44:12 INFO - 2015-12-17 23:44:12,647 INFO : Browser initialized. 23:44:12 INFO - 2015-12-17 23:44:12,647 INFO : Running cycle 1/1 for kraken test... 23:44:12 INFO - 2015-12-17 23:44:12,647 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDpZC1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:44:24 INFO - 2015-12-17 23:44:24,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 150519808 23:44:24 INFO - 2015-12-17 23:44:24,684 DEBUG : BROWSER_OUTPUT: 23:44:27 INFO - 2015-12-17 23:44:27,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58297/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:27 INFO - 2015-12-17 23:44:27,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 187154432 23:44:27 INFO - 2015-12-17 23:44:27,882 DEBUG : BROWSER_OUTPUT: 23:44:30 INFO - 2015-12-17 23:44:30,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58297/tests/kraken/driver.html?testName=audio-dft) 23:44:31 INFO - 2015-12-17 23:44:31,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 177434624 23:44:31 INFO - 2015-12-17 23:44:31,247 DEBUG : BROWSER_OUTPUT: 23:44:34 INFO - 2015-12-17 23:44:34,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58297/tests/kraken/driver.html?testName=audio-fft) 23:44:34 INFO - 2015-12-17 23:44:34,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 160686080 23:44:34 INFO - 2015-12-17 23:44:34,820 DEBUG : BROWSER_OUTPUT: 23:44:36 INFO - 2015-12-17 23:44:36,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58297/tests/kraken/driver.html?testName=audio-oscillator) 23:44:37 INFO - 2015-12-17 23:44:37,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 164052992 23:44:37 INFO - 2015-12-17 23:44:37,406 DEBUG : BROWSER_OUTPUT: 23:44:39 INFO - 2015-12-17 23:44:39,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:40 INFO - 2015-12-17 23:44:40,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 165052416 23:44:40 INFO - 2015-12-17 23:44:40,222 DEBUG : BROWSER_OUTPUT: 23:44:43 INFO - 2015-12-17 23:44:43,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58297/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:43 INFO - 2015-12-17 23:44:43,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 165683200 23:44:43 INFO - 2015-12-17 23:44:43,837 DEBUG : BROWSER_OUTPUT: 23:44:47 INFO - 2015-12-17 23:44:47,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58297/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:47 INFO - 2015-12-17 23:44:47,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 166203392 23:44:47 INFO - 2015-12-17 23:44:47,841 DEBUG : BROWSER_OUTPUT: 23:44:50 INFO - 2015-12-17 23:44:50,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58297/tests/kraken/driver.html?testName=json-parse-financial) 23:44:51 INFO - 2015-12-17 23:44:51,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 165982208 23:44:51 INFO - 2015-12-17 23:44:51,267 DEBUG : BROWSER_OUTPUT: 23:44:53 INFO - 2015-12-17 23:44:53,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:53 INFO - 2015-12-17 23:44:53,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 175857664 23:44:53 INFO - 2015-12-17 23:44:53,601 DEBUG : BROWSER_OUTPUT: 23:44:55 INFO - 2015-12-17 23:44:55,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:56 INFO - 2015-12-17 23:44:56,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 173617152 23:44:56 INFO - 2015-12-17 23:44:56,061 DEBUG : BROWSER_OUTPUT: 23:44:58 INFO - 2015-12-17 23:44:58,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:58 INFO - 2015-12-17 23:44:58,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 187584512 23:44:58 INFO - 2015-12-17 23:44:58,805 DEBUG : BROWSER_OUTPUT: 23:45:01 INFO - 2015-12-17 23:45:01,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:45:01 INFO - 2015-12-17 23:45:01,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 191713280 23:45:01 INFO - 2015-12-17 23:45:01,914 DEBUG : BROWSER_OUTPUT: 23:45:04 INFO - 2015-12-17 23:45:04,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:45:05 INFO - 2015-12-17 23:45:05,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 190775296 23:45:05 INFO - 2015-12-17 23:45:05,078 DEBUG : BROWSER_OUTPUT: 23:45:06 INFO - 2015-12-17 23:45:06,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58297/tests/kraken/driver.html?testName=ai-astar) 23:45:07 INFO - 2015-12-17 23:45:07,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 248070144 23:45:07 INFO - 2015-12-17 23:45:07,105 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,108 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:45:07 INFO - 2015-12-17 23:45:07,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:45:07 INFO - 2015-12-17 23:45:07,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:45:07 INFO - 2015-12-17 23:45:07,108 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:45:07 INFO - 2015-12-17 23:45:07,108 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;108;115;115;115;103;112;112;121 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;138;154;170;144;160;155;139;173;130 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;162;162;162;162;163;162;163;165 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;81;92;73;72;74;94;94;72 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;129;94;94;95;127;94;95;125 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;110;109;110;110 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;148;147;147;148;147;146;146;147 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;96;95;95;95 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;71;72;71;73;74;82;68;70 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;68;68;68;69;69;68 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;84;82;89;81;84;83;84;83 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;118;122;123;122;119;128;127;122;125 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;145;150;146;149;135;144;145;145;134 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;72;71;69;71;70;69;69;69 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:45:07 INFO - 2015-12-17 23:45:07,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1012 23:45:07 INFO - 2015-12-17 23:45:07,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:45:07 INFO - 2015-12-17 23:45:07,110 DEBUG : BROWSER_OUTPUT: __startTimestamp1450424707107__endTimestamp 23:45:07 INFO - 2015-12-17 23:45:07,110 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:4.76 (4.2%) stddev-sans-first:5.04 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 115.0 115.0 115.0 103.0 112.0 112.0 121.0 23:45:07 INFO - 2015-12-17 23:45:07,113 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.50 stddev:14.28 (9.1%) stddev-sans-first:14.80 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: Values: 161.0 138.0 154.0 170.0 144.0 160.0 155.0 139.0 173.0 130.0 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.13 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 162.0 162.0 162.0 162.0 163.0 162.0 163.0 165.0 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:77.50 stddev:9.72 (12.5%) stddev-sans-first:10.08 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 81.0 92.0 73.0 72.0 74.0 94.0 94.0 72.0 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:94.50 stddev:15.70 (16.6%) stddev-sans-first:16.29 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 129.0 94.0 94.0 95.0 127.0 94.0 95.0 125.0 23:45:07 INFO - 2015-12-17 23:45:07,114 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 148.0 147.0 147.0 148.0 147.0 146.0 146.0 147.0 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.00 stddev:3.72 (5.2%) stddev-sans-first:3.94 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 72.0 71.0 73.0 74.0 82.0 68.0 70.0 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,115 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:2.17 (2.6%) stddev-sans-first:2.30 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 84.0 82.0 89.0 81.0 84.0 83.0 84.0 83.0 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:3.86 (3.1%) stddev-sans-first:3.33 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: Values: 130.0 118.0 122.0 123.0 122.0 119.0 128.0 127.0 122.0 125.0 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:145.00 stddev:5.78 (4.0%) stddev-sans-first:5.57 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: Values: 136.0 145.0 150.0 146.0 149.0 135.0 144.0 145.0 145.0 134.0 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.15 (1.6%) stddev-sans-first:1.17 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 72.0 71.0 69.0 71.0 70.0 69.0 69.0 69.0 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:45:07 INFO - 2015-12-17 23:45:07,116 DEBUG : BROWSER_OUTPUT: 23:45:08 INFO - 2015-12-17 23:45:08,057 INFO : Browser exited with error code: 0 23:45:08 INFO - 2015-12-17 23:45:08,107 INFO : Completed test kraken (00:01:01) 23:45:08 INFO - 2015-12-17 23:45:08,107 INFO : Starting test v8_7 23:45:08 INFO - 2015-12-17 23:45:08,107 DEBUG : operating with platform_type : linux_ 23:45:08 INFO - 2015-12-17 23:45:08,108 INFO : Initialising browser for v8_7 test... 23:45:08 INFO - 2015-12-17 23:45:08,114 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOLJGHv/profile http://localhost:58297/getInfo.html 23:45:13 INFO - 2015-12-17 23:45:13,044 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:45:13 INFO - 2015-12-17 23:45:13,044 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:45:13 INFO - 2015-12-17 23:45:13,044 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:45:13 INFO - 2015-12-17 23:45:13,044 DEBUG : BROWSER_OUTPUT: __metrics 23:45:13 INFO - 2015-12-17 23:45:13,187 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] 23:45:13 INFO - 2015-12-17 23:45:13,255 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] 23:45:13 ERROR - 2015-12-17 23:45:13,271 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 23:45:14 INFO - 2015-12-17 23:45:14,283 INFO : Browser initialized. 23:45:14 INFO - 2015-12-17 23:45:14,284 INFO : Running cycle 1/1 for v8_7 test... 23:45:14 INFO - 2015-12-17 23:45:14,284 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOLJGHv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:45:26 INFO - 2015-12-17 23:45:26,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 150310912 23:45:26 INFO - 2015-12-17 23:45:26,239 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58297/tests/v8_7/run.html (next: http://localhost:58297/tests/v8_7/run.html) 23:45:47 INFO - 2015-12-17 23:45:47,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 450695168 23:45:47 INFO - 2015-12-17 23:45:47,840 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,840 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: |0;Richards;166.38935108153078 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.2308556450103 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 23:45:47 INFO - 2015-12-17 23:45:47,841 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 23:45:47 INFO - 2015-12-17 23:45:47,842 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2012.0481927710844 23:45:47 INFO - 2015-12-17 23:45:47,842 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 23:45:47 INFO - 2015-12-17 23:45:47,842 DEBUG : BROWSER_OUTPUT: |6;Boyer;11940.47619047619 23:45:47 INFO - 2015-12-17 23:45:47,842 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 23:45:47 INFO - 2015-12-17 23:45:47,843 DEBUG : BROWSER_OUTPUT: |8;Splay;615.3846153846154 23:45:47 INFO - 2015-12-17 23:45:47,843 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 23:45:47 INFO - 2015-12-17 23:45:47,843 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:45:47 INFO - 2015-12-17 23:45:47,843 DEBUG : BROWSER_OUTPUT: __startTimestamp1450424747839__endTimestamp 23:45:47 INFO - 2015-12-17 23:45:47,843 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,844 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:45:47 INFO - 2015-12-17 23:45:47,844 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:45:47 INFO - 2015-12-17 23:45:47,844 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,844 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,844 DEBUG : BROWSER_OUTPUT: Values: 166.4 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.23 Median:187.23 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: Values: 187.2 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,845 DEBUG : BROWSER_OUTPUT: Values: 281.4 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: Values: 5133.3 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2012.05 Median:2012.05 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,846 DEBUG : BROWSER_OUTPUT: Values: 2012.0 23:45:47 INFO - 2015-12-17 23:45:47,847 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,847 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,847 DEBUG : BROWSER_OUTPUT: Values: 794.3 23:45:47 INFO - 2015-12-17 23:45:47,847 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,847 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11940.48 Median:11940.48 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: Values: 11940.5 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: Values: 27108.1 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.38 Median:615.38 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,848 DEBUG : BROWSER_OUTPUT: Values: 615.4 23:45:47 INFO - 2015-12-17 23:45:47,850 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-12-17 23:45:47,850 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:45:47 INFO - 2015-12-17 23:45:47,850 DEBUG : BROWSER_OUTPUT: Values: 4835.7 23:45:47 INFO - 2015-12-17 23:45:47,850 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:45:47 INFO - 2015-12-17 23:45:47,850 DEBUG : BROWSER_OUTPUT: 23:45:48 INFO - 2015-12-17 23:45:48,825 INFO : Browser exited with error code: 0 23:45:48 INFO - 2015-12-17 23:45:48,836 INFO : Completed test v8_7 (00:00:40) 23:45:48 INFO - 2015-12-17 23:45:48,922 INFO : Completed test suite (00:20:20) 23:45:48 INFO - 2015-12-17 23:45:48,923 DEBUG : Working with test: dromaeo_css 23:45:48 INFO - 2015-12-17 23:45:48,923 DEBUG : Generating results file: dromaeo_css 23:45:48 INFO - 2015-12-17 23:45:48,924 DEBUG : Working with test: kraken 23:45:48 INFO - 2015-12-17 23:45:48,924 DEBUG : Generating results file: kraken 23:45:48 INFO - 2015-12-17 23:45:48,924 INFO : javascript benchmark 23:45:48 INFO - 2015-12-17 23:45:48,924 DEBUG : Working with test: v8_7 23:45:48 INFO - 2015-12-17 23:45:48,924 DEBUG : Generating results file: v8_7 23:45:48 INFO - 2015-12-17 23:45:48,925 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:45:49 INFO - 2015-12-17 23:45:49,079 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 23:45:49 INFO - 2015-12-17 23:45:49,079 DEBUG : process_Request line: dromaeo_css 6175.55 graph.html#tests=[[72,203,35]] 23:45:49 INFO - 2015-12-17 23:45:49,079 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:45:49 INFO - 2015-12-17 23:45:49,112 DEBUG : process_Request line: kraken 1524.60 graph.html#tests=[[232,203,35]] 23:45:49 INFO - 2015-12-17 23:45:49,112 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:45:49 INFO - 2015-12-17 23:45:49,231 DEBUG : process_Request line: v8_7 19740.95 graph.html#tests=[[230,203,35]] 23:45:49 INFO - 2015-12-17 23:45:49,232 INFO : javascript benchmark 23:45:49 INFO - 2015-12-17 23:45:49,236 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.4886147201296, 2694.6766388033416, 2717.062613398377, 2730.6723193216817, 2760.9999999999995, 4490.1019796040755, 4603.976980115095, 4659.207934651109, 4690.882727931799, 4709.128811169936, 4634.698744581599, 4673.088747694201, 4747.477777444478, 4774.4270687517455, 4796.184648609736, 4366.8908277293085, 4367.650587952956, 4390.604845563898, 4481.1037792441475, 4500.392447019643, 4425.31407631816, 4484.103179364124, 4487.39420178275, 4490.842820501283, 4529.682922195448, 4206.26390381682, 4264.211120942636, 4316.611504964537, 4323.783810809447, 4366.585174408426, 4346.848085257409, 4352.695311328208, 4355.194289056535, 4357.542458041923, 4400.911981760379, 4346.217680817452, 4347.630451411634, 4348.282533381988, 4373.0, 4391.341298805173, 4514.954850451486, 4640.280756482751, 4648.790804413809, 4681.88295292617, 4804.183288840871, 5097.6941383517105, 5099.643024988252, 5109.156989096795, 5122.487751224848, 5125.431130741203, 5128.051310507568, 5131.563817075553, 5133.974330128362, 5170.482951704837, 5175.042617115846, 4473.753943533105, 4565.543445655408, 4586.793594288265, 4654.069186162781, 4787.952120478821, 5239.083160446907, 5271.314729085195, 5271.683698978073, 5279.208118782137, 5330.973345133327, 5030.245463180552, 5038.244263360525, 5039.69761814285, 5041.319421878, 5090.847274581768, 4854.247591623304, 4956.5786908112495, 4962.0, 4995.525425084611, 5097.413797413271, 5040.49595040493, 5043.672161309503, 5047.242913562922, 5061.898762024739, 5110.872228194251, 5031.742064483879, 5037.773300201499, 5038.319826823332, 5041.168207245763, 5041.319421878073, 4089.754614723126, 4179.456670632799, 4180.874573762792, 4210.347396153601, 4302.569743025735, 3748.1004558905665, 3752.1745216052423, 3756.6431189037, 3757.9436308455397, 3798.2213646202463, 4294.205571969133, 4346.456692913386, 4380.846670366522, 4399.472063352418, 4424.048829501673, 4772.973810630731, 4884.9511504884495, 4884.95115048852, 4921.458639549646, 5035.496450354935, 4301.376300436419, 4303.698741088094, 4320.4383430153875, 4348.67384946124, 4351.303791393362, 4463.464384273908, 4470.418845550058, 4472.217361961643, 4472.44094488189, 4510.21071312519, 4632.86101416958, 4724.220503617003, 4729.881752956066, 4772.880677983078, 4772.952270477251, 4927.162382394929, 5042.9243561345875, 5049.899002020013, 5066.0, 5068.2904393384215, 4820.638452116035, 4823.855284341475, 4838.177509823268, 4849.975750121368, 4867.026594681149, 4810.855674329776, 4920.384951881015, 5024.4473107957365, 5036.949630503795, 5071.467495912876, 5005.974970125126, 5035.169197082587, 5081.542661160365, 5085.821996230115, 5132.10188217068, 4936.827211047596, 5022.623303252198, 5025.271335656236, 5025.3718285214345, 5067.594592432671, 4702.811887524461, 4820.132376172322, 5013.072581572421, 5025.974870125772, 5036.420811606712, 4688.437387513383, 4692.155412025868, 4721.173794586002, 4836.395450568679, 4845.830395936126, 4986.47641997585, 4990.3762029746285, 4997.175466048061, 5000.374953130859, 5002.874928126826, 4891.926621100757, 4895.681780684244, 4902.828401005948, 4903.141950158637, 4933.358663373739], "unit": "score", "name": "dojo.html", "value": 4641.536465177632}, {"lowerIsBetter": false, "replicates": [556.21851298925, 561.7893290016244, 562.151151760841, 568.0910543130991, 571.400029968533, 26703.4659306814, 27242.31894202646, 27271.45457090857, 35046.47430288548, 35268.64731352692, 39610.207795844064, 40076.398854017214, 40109.59890401095, 40133.799331003305, 40291.19417611646, 7880.842383152333, 8107.797305067362, 8116.985376827896, 8120.553369564672, 8132.105468398471, 7127.607981561038, 7367.600155970348, 7864.46642904631, 10112.797744045114, 10423.426711530901, 10046.547905344278, 10184.541695623715, 10188.64339748109, 10199.694009179737, 10200.13298869597, 7185.964070179668, 9929.851052234186, 10002.449865257408, 10028.448435336053, 10035.247356448295, 7039.0, 10113.49432528378, 10472.633457828939, 10477.58089676412, 10488.31825931312, 36697.449538256944, 37160.81419592912, 37194.25611487782, 37209.62790372116, 37251.0, 2770.6259654946525, 2785.843874791959, 2862.413205292931, 2926.88292468301, 3561.3589553880292, 26435.471290574274, 26595.0, 26665.46669066608, 27116.72883271162, 27584.724152758416, 3393.6097348804956, 3469.8612055517747, 3477.791332520057, 3572.0534058474527, 3572.1962558424407, 214790.0, 218152.0, 218328.0, 218938.0, 219024.0, 51942.0, 53261.46738532565, 55355.44644553583, 55828.720856395455, 55922.72038639862, 60120.398796012356, 61392.69303653453, 61800.69099654473, 61805.69097154486, 61838.690806546576, 13162.473501060042, 13351.332433378293, 13355.399007044707, 13360.5323813668, 13375.33123343829, 9857.260705447121, 9927.702168934944, 9928.851067233998, 9932.602695892228, 9933.552990115317, 19002.524936876413, 19121.23515059382, 19150.233990640496, 19242.23031078741, 19300.80699193018, 7483.700651973969, 7643.191458606401, 7845.646945887449, 7847.48991315574, 7912.802179945433, 826.3059030414361, 844.4511067805853, 939.3377668743519, 968.8837339519303, 995.9203263738883, 26041.73958260431, 26453.33866653349, 26625.33436664099, 26761.598576021373, 26803.865980669972, 979.5543027922279, 1034.7206254311293, 1065.0627447846, 1095.45774841454, 1108.5510368300852, 13769.173849569059, 13851.930740346234, 13956.0, 13986.30068496571, 14004.929975350058, 252231.0, 259019.0, 259085.0, 259150.0, 259862.0, 45023.549764501935, 45318.0, 45656.77171614121, 45676.314855277196, 45707.08585828265, 1221.5175005872632, 1229.0536287058915, 1229.655696405008, 1233.747081848219, 1242.2174030360816, 21775.346739597837, 24370.26889193327, 24891.751082488943, 26586.867065665323, 26643.866780665972, 36245.09387265234, 36679.81660091683, 36685.0, 36710.0, 36759.08102297464, 199933.00033500322, 202701.0, 202748.0, 203607.87372441893, 220298.0, 23928.28215153548, 28410.85794571014, 28716.282092947844, 28968.0, 29031.0, 32753.18117047093, 44839.55160448354, 46406.53593464157, 46965.0, 47068.29397558971, 32521.0, 32708.509372358956, 33022.50466243056, 33379.666203337656, 33670.66329336773, 32760.83619581887, 32832.343353133285, 32835.67164328326, 33271.66728332783, 33310.66689333173, 32133.357332852745, 32616.673833261364, 32713.34573308568, 32878.67121328756, 33168.668313317525, 28850.27874303075, 29414.41171176607, 30422.847885760428, 30538.739558390032, 30636.387272254877, 23422.414439638465, 23440.413989650395, 23493.76506234984, 23843.165489207793, 23856.761432385454], "unit": "score", "name": "ext.html", "value": 16993.057416179723}, {"lowerIsBetter": false, "replicates": [328.66476194281836, 331.64348325550037, 334.31131868351196, 334.8426239667356, 339.6145374999376, 12663.240205587672, 12983.870161298384, 14701.999999999987, 15304.69390612187, 16244.675106497878, 9096.499692516909, 9208.447493150416, 10558.524866381013, 11343.886561134386, 12451.937740311309, 4430.800613972379, 4472.955270447303, 4556.9088618227615, 4865.464798872121, 4879.853604391857, 3419.829008549575, 4935.481774413689, 4983.7508124593805, 4995.275685025687, 4997.600191984632, 3525.7179425646013, 5009.524095210967, 5162.303089082963, 5177.58579313654, 5179.585633149339, 5007.5993920486635, 5093.592512598983, 5101.591872650179, 5125.179971204608, 5147.279380886679, 5008.198688209869, 5008.574271186953, 5009.5491405773655, 5013.373328333958, 5014.348134742497, 11452.599159029394, 11495.310281383061, 15049.473268435551, 19806.0, 19815.40553783389, 1834.174621420366, 1834.220456306078, 1844.8339649431482, 1862.981370186308, 1924.2591602233101, 12027.338496382696, 12157.878421215763, 12418.751624967541, 12721.809172862415, 12945.482180712761, 1656.900585964846, 1664.8251933547047, 1670.590705277215, 1685.8819882608223, 1705.4201571465637, 55417.0, 56617.71691141518, 56966.0, 57072.42927570712, 57870.421295786924, 9653.71038868835, 9686.806263874683, 9709.854352184722, 9750.366226195274, 9839.065288797552, 12428.875711242952, 12456.377181140906, 12458.439370228361, 12505.874941250471, 12574.0, 6464.0627109069865, 6671.39957403836, 6712.664366781739, 6863.347981941708, 6901.551399159039, 6706.22878368984, 6718.22740384862, 6801.4898882584, 6812.795616131524, 6818.897716534256, 4037.798110094542, 4160.83356665736, 4180.122174343422, 4260.190563792869, 4313.396124542566, 1670.8663306935416, 1705.4116329866176, 1749.7112976358758, 1760.595063135486, 1795.380593695173, 371.5968174530665, 658.9374009469093, 914.2046419614977, 925.5881132895931, 936.5223735894742, 8841.469511829311, 9042.909570904207, 9263.953680231556, 9605.18355939753, 15421.922890385476, 793.6626933553217, 839.0267289943758, 839.3536976528039, 852.1308265569085, 952.0574631115146, 8742.169493898069, 8744.0, 8800.251978581764, 8824.073472285447, 8982.326325525612, 397206.0, 456454.0, 457168.0, 465002.0, 474168.0, 37364.43953340702, 37573.0, 37586.81206593949, 56988.71505642445, 71555.56888862194, 1077.9245452818227, 1078.449990504848, 1101.2071308657753, 1123.8707548632012, 1126.8929451702074, 14435.422583096979, 14588.051776634486, 14934.477293294682, 15109.697806043598, 15231.543053708407, 33886.322273554884, 34343.141421464665, 34719.47920781241, 35323.64676353306, 36232.27535449329, 45256.77371613121, 45536.08927821491, 45767.54232457766, 45882.85292867705, 47391.289130663754, 8399.118092600189, 8628.82742345137, 8704.956475217583, 8719.084496127814, 8736.388452808242, 10170.135538479311, 15000.924995374953, 15983.120928349052, 16628.0, 16673.91619544726, 10870.891291087304, 12823.294718790183, 13504.527341542998, 13857.0, 13961.301934903417, 13109.344532773513, 13386.799198011842, 13428.597142085753, 13444.865551344752, 13477.595672129852, 13415.32923353848, 13428.0, 13868.583942481742, 14141.787873181705, 14170.291485425481, 8433.36749743784, 8479.618417171365, 8608.741737747878, 8618.82762344737, 8640.78398040054, 10542.736431589272, 13952.720945581235, 14142.50501232452, 14146.363413646204, 14239.50161744334], "unit": "score", "name": "jquery.html", "value": 7919.440655777588}, {"lowerIsBetter": false, "replicates": [1410.5838777560618, 1600.5198440467861, 1656.8011838579373, 1669.7161482547965, 1690.3492155520128, 5943.524518038557, 6822.7270909163635, 7008.053912721781, 7016.087908571879, 7045.718171273155, 6988.0, 7115.928840711591, 7141.964290178542, 7144.178419481761, 7151.463640226991, 1686.3001854230479, 1720.8021077576113, 1724.3792234795465, 2037.5822956293962, 2074.7551469118484, 2056.0953180600486, 2067.400453868376, 2074.222166687492, 2076.6781148921864, 2079.573687394088, 2039.5105174758025, 2065.710800487933, 2071.482129467633, 2080.9687854682115, 2104.926327578535, 1982.9801701983013, 1995.2617531513288, 1996.7304413904155, 1997.3608445297511, 2004.1883037369817, 2024.6052019856133, 2039.1537511932531, 2043.0295609585476, 2046.3758553641132, 2046.467918341227, 7060.152781666182, 7143.1428228612895, 7157.785266442015, 7169.89245161323, 7179.425645948364, 4079.918401631951, 4190.120074784299, 4207.495100587949, 4223.767692776896, 4224.809883555247, 2515.5220508103585, 2518.0305582350743, 2540.0982651158756, 2552.66815314008, 2577.832440891336, 824.3570015388007, 834.3450391442689, 855.9614817333235, 874.3136637739344, 876.6055275126218, 9269.629214831399, 9373.578188981512, 9378.718638440858, 9418.058194180596, 9447.527623618791, 3752.568454627698, 3772.07584141887, 3776.981115094407, 3836.827342769582, 3929.1159489115294, 8356.247937685637, 8406.579671016425, 8417.873731894026, 8439.70461033861, 8452.323814094858, 4116.423700681907, 4166.645835103989, 4172.248995180836, 4178.435911151955, 4180.979095104505, 3750.4936833527127, 3754.0990162360836, 3760.0599850037493, 3772.3775577029483, 3787.450819631138, 2965.1104668599332, 2981.2844917220145, 3004.7746419018663, 3294.390537750524, 3354.681305275995, 937.0863408176973, 976.8192884316425, 992.1021475564626, 1100.5157730598512, 1105.5522513382093, 889.5196593839383, 927.0173615966962, 977.6773664690635, 1193.928364298145, 1199.1066655341651, 6428.0, 6484.351564843478, 6509.9023514647315, 6538.019297105472, 6540.640264785482, 537.0413811346727, 540.2922171954751, 541.258475888036, 541.7643325153492, 696.3210869402393, 4857.878553036202, 4945.554900059012, 4949.90100197994, 4964.975175124174, 4967.801287948441, 7008.649567521604, 7074.6816393262425, 8339.791505212297, 8646.357192133475, 8673.566321683891, 8026.117127116013, 8132.959335203286, 8169.754907352789, 8182.0, 8294.253517183482, 6517.9348206517325, 6551.934480655228, 6659.733610655519, 6697.732090716414, 6706.0, 6730.93269067303, 6770.932290677227, 6777.322267773183, 6790.185177778698, 6859.691313890787, 7671.347935425551, 7694.8076298090755, 7763.184865589032, 7799.5320280783335, 7849.097353804385, 7902.604869756604, 7983.1617680142745, 8032.919670803217, 8076.434649574473, 8143.144969778088, 6062.757489700539, 6163.3836616338, 6168.876622467616, 6175.505959523317, 6184.165137706352, 6854.931450685429, 6983.057287266154, 6987.0, 6989.231184569795, 6996.790096296915, 5164.664296820694, 6497.967510162419, 6590.637514936724, 6658.6337751424135, 6742.696578653874, 6259.2488901332135, 6307.05394190875, 6380.074889141141, 6429.7106630200815, 6452.290248072614, 6268.498520118288, 6297.496200303873, 6300.464460520724, 6315.115883776367, 6321.841953951188, 5650.802221922213, 5661.037623603915, 5669.943300566942, 5677.205191273142, 5677.233573467529, 5814.854628634318, 5963.403659634002, 5976.910346344721, 5977.491913187428, 6002.0996850472775], "unit": "score", "name": "mootools.html", "value": 3953.123914341088}, {"lowerIsBetter": false, "replicates": [292.62105573282605, 296.09985643643324, 298.583476050909, 302.66253127762553, 303.3039175093161, 5228.503292187241, 5247.553957913572, 5305.761240744167, 5392.0294347017525, 5433.809816656408, 5213.244079608455, 5282.5245727884485, 5284.682919024861, 5295.179247216678, 5299.708516031616, 3859.7298189126773, 4102.241085399196, 4102.856400025999, 4109.0, 4112.650424713888, 3946.2304850554156, 3951.308521008826, 3991.361382178852, 4020.4974378202724, 4034.919301613966, 3985.6213659702426, 4001.6398524132824, 4017.698672599552, 4018.839246430139, 4025.315696331616, 3838.769673819552, 3915.393114067324, 3966.8809935701975, 4013.2776100301935, 4016.4778578784717, 3456.9827150864085, 3457.135716070982, 3461.7230621550216, 3476.8261586920808, 3485.8082805445692, 5019.071471777733, 5030.943501864613, 5035.521625445614, 5035.62232832539, 5037.118504261776, 4586.197415452282, 4609.608183304423, 4611.723296602215, 4614.2617181250835, 4619.607333376667, 5307.548858347045, 5466.398696143421, 5490.094134467808, 5510.366307874606, 5523.28197334348, 3731.5708693500324, 3734.402495600691, 3734.5705243897028, 3746.6628003479545, 3762.285165818513, 5770.682612456313, 5839.737211825478, 5858.853528661817, 5860.179574859523, 5870.882582348372, 3930.1157239620857, 3944.2308749793515, 3944.9408258876138, 3945.0926286953586, 3946.4869566956686, 3995.141044675409, 3995.840166393312, 3996.4005399189773, 4000.5199376075057, 4001.47980762499, 4573.131105090022, 4621.768911554409, 4623.098495793288, 4624.5375462453485, 4633.675642705046, 5577.553795696334, 5579.218909352694, 5592.804251851166, 5593.74828132735, 5598.86002849932, 1387.8550196088268, 1403.1510935883848, 1404.1364560795037, 1404.3890907455086, 1405.1147776900486, 937.2642475656577, 939.9718008459757, 942.9717108486619, 958.6980101268078, 959.2613687460616, 4900.558949694545, 4901.3383193269165, 4903.166461701519, 4909.042736666387, 4913.11563918491, 5789.8552536186935, 5791.131330300489, 5798.985177593904, 5807.332156801937, 5809.157672137601, 4896.436909755353, 4903.8528844134735, 4905.969746353235, 4909.729964851967, 4913.115639184981, 3032.2116249775218, 3087.1047396255285, 3095.3190298134373, 3116.703913128249, 3123.2504198992533, 5506.779728810883, 5529.751161197675, 5534.944650553443, 5540.556755459554, 5547.11246200606, 5988.550858685616, 5996.640201587918, 6006.339302676702, 6007.27912650476, 6020.458158765732, 5483.1227003680815, 5542.91685624716, 5543.833684989457, 5544.805931792449, 5550.084236101079, 5670.943290567042, 5803.622764520293, 5814.680192589448, 5833.241678581757, 5834.649921004753, 5661.264035675335, 5685.175649530877, 5685.630434021776, 5686.2607860977805, 5693.430656934439, 5506.862328441821, 5508.779648814003, 5508.80719174843, 5511.263951855153, 5521.337439507124, 3888.6111388860886, 3926.1951299984007, 3975.4434379187514, 3979.442877997025, 3981.820818063252, 5819.76720931158, 5822.737976791139, 5827.970860145672, 5834.737436815269, 5852.239208902815, 5595.132754423071, 5596.104623260258, 5598.580106491948, 5599.580031497572, 5602.3837377887585, 5602.663840169603, 5609.411011843861, 5611.7194140292, 5613.101903695389, 5619.80330688424, 5336.946630533645, 5430.15832545956, 5473.370562385217, 5474.890502190014, 5486.890262194814, 5415.052365835884, 5559.861003474945, 5620.353659329229, 5630.577706671934, 5641.661500309994, 5373.7850485980125, 5430.67415955044, 5433.809816656398, 5438.102713052302, 5449.536789372948], "unit": "score", "name": "prototype.html", "value": 4158.354599788171}, {"lowerIsBetter": false, "replicates": [596.8507873031742, 606.805822136916, 672.5292295393223, 673.4545018534988, 683.5351960666744, 10844.566217351297, 10908.236423450362, 11096.05683516901, 11128.0, 11134.33194008358, 10595.523201455933, 10662.413567253818, 10694.78610427791, 10706.357618542894, 10748.570057197703, 632.4876849751715, 640.9134766806468, 774.9457537972344, 777.933875620573, 788.7909703928464, 763.625823346559, 770.5415277909635, 770.9653065612061, 779.6530543907963, 795.9363250939911, 659.3406593406594, 806.7862016565615, 806.8507326144653, 815.6207363575936, 838.0278876503257, 635.7965451055641, 647.6502688548178, 648.4941745438565, 648.708081363386, 807.7294106474338, 577.8237637520555, 582.8659408336064, 585.060977131706, 597.5548216578633, 606.5390303369427, 10713.732156696067, 10895.291806032583, 10917.836232456519, 10920.836187457195, 10921.071708904752, 11042.779144417147, 11044.502997365138, 11112.833307500314, 11367.204295699305, 11584.0, 8461.74614761552, 8462.898055780232, 8472.49165050099, 8604.182602652738, 8742.475451472868, 3185.9681403186137, 3192.4413227685063, 3243.124356423776, 3269.8392070814757, 3303.80177189367, 37910.0, 37959.62040379588, 38012.0, 38219.23561528782, 38444.615553844385, 8900.332475064397, 8997.55012249398, 9007.77480562978, 9024.954875225712, 9038.028210956778, 16672.249748761336, 16700.164991750364, 16700.331986720637, 16709.582260443585, 16755.162241887858, 6048.979795211604, 6107.206063211843, 6108.175396321529, 6232.065190221503, 6292.402221788922, 3422.3155368926314, 3439.720535111748, 3532.4171511700283, 3542.6634469725336, 3606.5311509503595, 2474.3195621204313, 2477.7770000700025, 2495.8752062396807, 2500.349909023667, 2500.4874000829786, 429.14385800328546, 433.40506934481414, 437.51217392607015, 444.2470013327379, 445.8907567645883, 405.98301255355733, 445.26308958673445, 465.96039336656764, 525.2987262005266, 553.1868153813887, 7747.22527747232, 7971.0, 7983.640736166886, 8066.274035336848, 8224.095349511548, 457.77340216593, 460.69594067915017, 541.0369542214785, 561.264743186427, 585.7159277750287, 3276.967230327714, 3365.5793025871767, 3401.2517246205794, 3421.3328400962073, 3421.623621401644, 47437.288440673416, 47688.52311476841, 47955.280670789965, 48110.0, 48410.0, 43175.35236971448, 43716.12567748627, 43799.0, 43926.12147757027, 44004.77997609991, 38697.80651096727, 39121.80439097843, 39827.0, 39895.80052099779, 39897.40153897694, 7210.387117094896, 7264.709411623688, 7316.561006339637, 7334.486585938933, 7493.138289096605, 30246.0, 30564.541531877483, 30733.078007659806, 30835.537466938462, 31173.53239701452, 35061.47407788936, 35212.0, 37097.814510927274, 38143.80928095342, 38437.03907402337, 9316.161545460942, 9614.55218496721, 9660.0, 9867.358621689567, 9960.800783984425, 10386.844197336895, 10801.459927003461, 10816.134709223086, 10963.451827408757, 10994.890051099386, 10031.849522257318, 10056.49717514136, 10063.842658094412, 10296.382217067, 10512.737181570523, 9739.269554783561, 9779.706608801747, 9893.703188904345, 10027.899721002697, 10189.847152292574, 9686.0, 9796.412215267106, 9799.51002449889, 9980.700578982642, 10152.54313555877, 8821.382503224713, 8884.600192991202, 9114.316426267924, 9171.954140229256, 9186.816263674822, 8536.615852286786, 8599.39804213724, 8651.826963460822, 8812.955935220283, 8862.468251904906], "unit": "score", "name": "yui.html", "value": 5401.525454913012}], "name": "dromaeo_css", "value": 6175.547687899109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 115.0, 115.0, 115.0, 103.0, 112.0, 112.0, 121.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [161.0, 138.0, 154.0, 170.0, 144.0, 160.0, 155.0, 139.0, 173.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 165.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 81.0, 92.0, 73.0, 72.0, 74.0, 94.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 129.0, 94.0, 94.0, 95.0, 127.0, 94.0, 95.0, 125.0], "unit": "score", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 71.0, 73.0, 74.0, 82.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 82.0, 89.0, 81.0, 84.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [130.0, 118.0, 122.0, 123.0, 122.0, 119.0, 128.0, 127.0, 122.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [136.0, 145.0, 150.0, 146.0, 149.0, 135.0, 144.0, 145.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 72.0, 71.0, 69.0, 71.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1524.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [187.2308556450103], "unit": "score", "name": "DeltaBlue", "value": 353.1362380000001}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2012.0481927710844], "unit": "score", "name": "RayTrace", "value": 367.77896407185614}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [11940.47619047619], "unit": "score", "name": "Boyer", "value": 55.815445663010976}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [615.3846153846154], "unit": "score", "name": "Splay", "value": 132.42287499999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19740.94984029671}]} 23:45:49 INFO - RETURN: dromaeo_css: 6175.55 23:45:49 INFO - RETURN: kraken: 1524.60 23:45:49 INFO - RETURN: v8_7: 19740.95 23:45:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19740.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1524.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6175.55"}}} 23:45:49 INFO - Return code: 0 23:45:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:45:49 ERROR - # TBPL SUCCESS # 23:45:49 INFO - Running post-action listener: _resource_record_post_action 23:45:49 INFO - Running post-run listener: _resource_record_post_run 23:45:50 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553930752; Read time: 12; Write time: 581144 23:45:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 238727168; Read time: 0; Write time: 385640 23:45:50 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315203584; Read time: 12; Write time: 195504 23:45:50 INFO - Running post-run listener: _upload_blobber_files 23:45:50 INFO - Blob upload gear active. 23:45:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:45:50 INFO - Copying logs to upload dir... 23:45:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.728975 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 23:45:49.967032) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:45:49.970746) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010007 build_url: 'https://queue.taskcluster.net/v1/task/HEJqXIKZS9ydlGxlNmanHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:45:50.025162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:45:50.025502) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450419367.744675-844747996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:45:50.075335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 23:45:50.075651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 23:45:50.075984) ========= ========= Total master_lag: 0.22 =========