builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1450395517.68 results: success (0) buildid: 20151217150054 builduid: eff51cc5c6c54b7b9bc6c283e8218127 revision: 2d95a1f997e8a4a3289ebb2c10288445ae0b6a02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.679404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.679751) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.680081) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006435 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.706065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.706325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.733646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.733895) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.782891) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.783156) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.783485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.783758) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 15:38:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-12-17 15:38:38 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.981587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:37.981905) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.031055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.031450) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2d95a1f997e8a4a3289ebb2c10288445ae0b6a02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2d95a1f997e8a4a3289ebb2c10288445ae0b6a02 --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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 15:38:38,177 truncating revision to first 12 chars 2015-12-17 15:38:38,178 Setting DEBUG logging. 2015-12-17 15:38:38,178 attempt 1/10 2015-12-17 15:38:38,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2d95a1f997e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 15:38:38,421 unpacking tar archive at: fx-team-2d95a1f997e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.589928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.590242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.602879) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.603138) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 15:38:38.603579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-12-17 15:38:38.603893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:38:38 INFO - MultiFileLogger online at 20151217 15:38:38 in /builds/slave/test 15:38:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:38:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:38:38 INFO - {'append_to_log': False, 15:38:38 INFO - 'base_work_dir': '/builds/slave/test', 15:38:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:38:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:38:38 INFO - 'branch': 'Fx-Team-Non-PGO', 15:38:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:38:38 INFO - 'config_files': ('talos/linux_config.py',), 15:38:38 INFO - 'default_actions': ('clobber', 15:38:38 INFO - 'read-buildbot-config', 15:38:38 INFO - 'download-and-extract', 15:38:38 INFO - 'populate-webroot', 15:38:38 INFO - 'create-virtualenv', 15:38:38 INFO - 'install', 15:38:38 INFO - 'run-tests'), 15:38:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:38:38 INFO - 'download_minidump_stackwalk': True, 15:38:38 INFO - 'download_symbols': 'ondemand', 15:38:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:38:38 INFO - 'tooltool.py': '/tools/tooltool.py', 15:38:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:38:38 INFO - '/tools/misc-python/virtualenv.py')}, 15:38:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:38:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:38:38 INFO - 'installer_path': 'installer.exe', 15:38:38 INFO - 'log_level': 'info', 15:38:38 INFO - 'log_name': 'talos', 15:38:38 INFO - 'log_to_console': True, 15:38:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:38:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:38:38 INFO - 'opt_config_files': (), 15:38:38 INFO - 'pip_index': False, 15:38:38 INFO - 'sps_profile': False, 15:38:38 INFO - 'sps_profile_interval': 0, 15:38:38 INFO - 'suite': 'dromaeojs-e10s', 15:38:38 INFO - 'system_bits': '64', 15:38:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:38:38 INFO - 'title': 'talos-linux64-ix-013', 15:38:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:38:38 INFO - 'use_talos_json': True, 15:38:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:38:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:38:38 INFO - 'work_dir': 'build'} 15:38:38 INFO - ##### 15:38:38 INFO - ##### Running clobber step. 15:38:38 INFO - ##### 15:38:38 INFO - Running pre-action listener: _resource_record_pre_action 15:38:38 INFO - Running main action method: clobber 15:38:38 INFO - rmtree: /builds/slave/test/build 15:38:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:38:39 INFO - Running post-action listener: _resource_record_post_action 15:38:39 INFO - ##### 15:38:39 INFO - ##### Running read-buildbot-config step. 15:38:39 INFO - ##### 15:38:39 INFO - Running pre-action listener: _resource_record_pre_action 15:38:39 INFO - Running main action method: read_buildbot_config 15:38:39 INFO - Using buildbot properties: 15:38:39 INFO - { 15:38:39 INFO - "project": "", 15:38:39 INFO - "product": "firefox", 15:38:39 INFO - "script_repo_revision": "production", 15:38:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:38:39 INFO - "repository": "", 15:38:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:38:39 INFO - "buildid": "20151217150054", 15:38:39 INFO - "pgo_build": "False", 15:38:39 INFO - "basedir": "/builds/slave/test", 15:38:39 INFO - "buildnumber": 825, 15:38:39 INFO - "slavename": "talos-linux64-ix-013", 15:38:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:38:39 INFO - "platform": "ubuntu64_hw", 15:38:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:38:39 INFO - "branch": "fx-team", 15:38:39 INFO - "repo_path": "integration/fx-team", 15:38:39 INFO - "revision": "2d95a1f997e8a4a3289ebb2c10288445ae0b6a02", 15:38:39 INFO - "stage_platform": "linux64", 15:38:39 INFO - "builduid": "eff51cc5c6c54b7b9bc6c283e8218127", 15:38:39 INFO - "slavebuilddir": "test" 15:38:39 INFO - } 15:38:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:38:39 INFO - Running post-action listener: _resource_record_post_action 15:38:39 INFO - ##### 15:38:39 INFO - ##### Running download-and-extract step. 15:38:39 INFO - ##### 15:38:39 INFO - Running pre-action listener: _resource_record_pre_action 15:38:39 INFO - Running main action method: download_and_extract 15:38:39 INFO - mkdir: /builds/slave/test/build/tests 15:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:39 INFO - https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/test_packages.json 15:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/test_packages.json 15:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:38:46 INFO - Downloaded 1302 bytes. 15:38:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:38:46 INFO - Using the following test package requirements: 15:38:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:38:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:38:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'jsshell-linux-x86_64.zip'], 15:38:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:38:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:38:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:38:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:38:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:38:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:38:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:38:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:38:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:38: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')]} 15:38:46 INFO - https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:50 INFO - Downloaded 21870957 bytes. 15:38:50 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 15:38:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:50 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 15:38:52 INFO - Return code: 0 15:38:52 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 15:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:52 INFO - https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:53 INFO - Downloaded 21870957 bytes. 15:38:53 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 15:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:38:53 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 15:38:55 INFO - Return code: 0 15:38: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')]} 15:38:55 INFO - https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:38:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:38:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:38:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:38:56 INFO - Downloaded 11132039 bytes. 15:39:00 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 15:39:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:00 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 15:39:00 INFO - Return code: 0 15:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:00 INFO - https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 15:39:01 INFO - Downloaded 53018416 bytes. 15:39:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:39:01 INFO - mkdir: /builds/slave/test/properties 15:39:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:01 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:01 INFO - Contents: 15:39:01 INFO - build_url:https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:39:01 INFO - Running post-action listener: _resource_record_post_action 15:39:01 INFO - Running post-action listener: set_extra_try_arguments 15:39:01 INFO - ##### 15:39:01 INFO - ##### Running populate-webroot step. 15:39:01 INFO - ##### 15:39:01 INFO - Running pre-action listener: _resource_record_pre_action 15:39:01 INFO - Running main action method: populate_webroot 15:39:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:01 INFO - '--tppagecycles', 15:39:01 INFO - '7'], 15:39:01 INFO - 'tests': ['tsvgm']}}, 15:39:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:39:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:39:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:39:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'tests': ['damp', 'tps']}, 15:39:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['damp', 'tps']}, 15:39:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:39:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:01 INFO - 'other': {'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'other_l64': {'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'other_nol64': {'tests': ['a11yr', 15:39:01 INFO - 'ts_paint', 15:39:01 INFO - 'tpaint', 15:39:01 INFO - 'sessionrestore', 15:39:01 INFO - 'sessionrestore_no_auto_restore']}, 15:39:01 INFO - 'svgr': {'tests': ['tsvgx', 15:39:01 INFO - 'tsvgr_opacity', 15:39:01 INFO - 'tart', 15:39:01 INFO - 'tscrollx', 15:39:01 INFO - 'cart']}, 15:39:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['tsvgx', 15:39:01 INFO - 'tsvgr_opacity', 15:39:01 INFO - 'tart', 15:39:01 INFO - 'tscrollx', 15:39:01 INFO - 'cart']}, 15:39:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'tests': ['tp5o']}, 15:39:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'talos_options': ['--e10s'], 15:39:01 INFO - 'tests': ['tp5o']}, 15:39:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'talos_options': ['--xperf_path', 15:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:01 INFO - 'tests': ['tp5n']}, 15:39:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:01 INFO - 'talos_options': ['--e10s', 15:39:01 INFO - '--xperf_path', 15:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:01 INFO - 'tests': ['tp5n']}}, 15:39:01 INFO - 'talos.zip': {'path': '', 15:39:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:01 INFO - Running post-action listener: _resource_record_post_action 15:39:01 INFO - ##### 15:39:01 INFO - ##### Running create-virtualenv step. 15:39:01 INFO - ##### 15:39:01 INFO - Running pre-action listener: _resource_record_pre_action 15:39:01 INFO - Running main action method: create_virtualenv 15:39:01 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:01 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 15:39:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:01 INFO - Using real prefix '/usr' 15:39:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:04 INFO - Installing pip.................done. 15:39:04 INFO - Return code: 0 15:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:04 INFO - Using env: {'DISPLAY': ':0', 15:39:04 INFO - 'HOME': '/home/cltbld', 15:39:04 INFO - 'LANG': 'en_US.UTF-8', 15:39:04 INFO - 'LANGUAGE': 'en_US:en', 15:39:04 INFO - 'LOGNAME': 'cltbld', 15:39:04 INFO - 'MAIL': '/var/mail/cltbld', 15:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:04 INFO - 'MOZ_NO_REMOTE': '1', 15:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:04 INFO - 'NO_EM_RESTART': '1', 15:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:04 INFO - 'PWD': '/builds/slave/test', 15:39:04 INFO - 'SHELL': '/bin/bash', 15:39:04 INFO - 'SHLVL': '1', 15:39:04 INFO - 'TERM': 'linux', 15:39:04 INFO - 'TMOUT': '86400', 15:39:04 INFO - 'USER': 'cltbld', 15:39:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:04 INFO - '_': '/tools/buildbot/bin/python'} 15:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:04 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 15:39:04 INFO - Cleaning up... 15:39:04 INFO - Return code: 0 15:39:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:39:04 INFO - Using env: {'DISPLAY': ':0', 15:39:04 INFO - 'HOME': '/home/cltbld', 15:39:04 INFO - 'LANG': 'en_US.UTF-8', 15:39:04 INFO - 'LANGUAGE': 'en_US:en', 15:39:04 INFO - 'LOGNAME': 'cltbld', 15:39:04 INFO - 'MAIL': '/var/mail/cltbld', 15:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:04 INFO - 'MOZ_NO_REMOTE': '1', 15:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:04 INFO - 'NO_EM_RESTART': '1', 15:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:04 INFO - 'PWD': '/builds/slave/test', 15:39:04 INFO - 'SHELL': '/bin/bash', 15:39:04 INFO - 'SHLVL': '1', 15:39:04 INFO - 'TERM': 'linux', 15:39:04 INFO - 'TMOUT': '86400', 15:39:04 INFO - 'USER': 'cltbld', 15:39:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:04 INFO - '_': '/tools/buildbot/bin/python'} 15:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:04 INFO - Downloading/unpacking psutil>=0.7.1 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:39:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:06 INFO - Installing collected packages: psutil 15:39:06 INFO - Running setup.py install for psutil 15:39:06 INFO - building 'psutil._psutil_linux' extension 15:39:06 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 15:39:06 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 15:39:06 INFO - building 'psutil._psutil_posix' extension 15:39:06 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 15:39:06 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 15:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:06 INFO - Successfully installed psutil 15:39:06 INFO - Cleaning up... 15:39:06 INFO - Return code: 0 15:39:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:06 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:06 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 15:39:06 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 15:39:06 INFO - Using env: {'DISPLAY': ':0', 15:39:06 INFO - 'HOME': '/home/cltbld', 15:39:06 INFO - 'LANG': 'en_US.UTF-8', 15:39:06 INFO - 'LANGUAGE': 'en_US:en', 15:39:06 INFO - 'LOGNAME': 'cltbld', 15:39:06 INFO - 'MAIL': '/var/mail/cltbld', 15:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:06 INFO - 'MOZ_NO_REMOTE': '1', 15:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:06 INFO - 'NO_EM_RESTART': '1', 15:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:06 INFO - 'PWD': '/builds/slave/test', 15:39:06 INFO - 'SHELL': '/bin/bash', 15:39:06 INFO - 'SHLVL': '1', 15:39:06 INFO - 'TERM': 'linux', 15:39:06 INFO - 'TMOUT': '86400', 15:39:06 INFO - 'USER': 'cltbld', 15:39:06 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:06 INFO - '_': '/tools/buildbot/bin/python'} 15:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:39:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:39:08 INFO - Installing collected packages: mozsystemmonitor 15:39:08 INFO - Running setup.py install for mozsystemmonitor 15:39:08 INFO - Successfully installed mozsystemmonitor 15:39:08 INFO - Cleaning up... 15:39:09 INFO - Return code: 0 15:39:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:09 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')]} 15:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:09 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')]} 15:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:09 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:09 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 15:39:09 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 15:39:09 INFO - Using env: {'DISPLAY': ':0', 15:39:09 INFO - 'HOME': '/home/cltbld', 15:39:09 INFO - 'LANG': 'en_US.UTF-8', 15:39:09 INFO - 'LANGUAGE': 'en_US:en', 15:39:09 INFO - 'LOGNAME': 'cltbld', 15:39:09 INFO - 'MAIL': '/var/mail/cltbld', 15:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:09 INFO - 'MOZ_NO_REMOTE': '1', 15:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:09 INFO - 'NO_EM_RESTART': '1', 15:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:09 INFO - 'PWD': '/builds/slave/test', 15:39:09 INFO - 'SHELL': '/bin/bash', 15:39:09 INFO - 'SHLVL': '1', 15:39:09 INFO - 'TERM': 'linux', 15:39:09 INFO - 'TMOUT': '86400', 15:39:09 INFO - 'USER': 'cltbld', 15:39:09 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:09 INFO - '_': '/tools/buildbot/bin/python'} 15:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:11 INFO - Downloading docopt-0.6.1.tar.gz 15:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:11 INFO - Running setup.py install for blobuploader 15:39:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:11 INFO - Running setup.py install for requests 15:39:12 INFO - Running setup.py install for docopt 15:39:12 INFO - Successfully installed blobuploader requests docopt 15:39:12 INFO - Cleaning up... 15:39:12 INFO - Return code: 0 15:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:12 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')]} 15:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:12 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')]} 15:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:12 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:12 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 15:39:12 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 15:39:12 INFO - Using env: {'DISPLAY': ':0', 15:39:12 INFO - 'HOME': '/home/cltbld', 15:39:12 INFO - 'LANG': 'en_US.UTF-8', 15:39:12 INFO - 'LANGUAGE': 'en_US:en', 15:39:12 INFO - 'LOGNAME': 'cltbld', 15:39:12 INFO - 'MAIL': '/var/mail/cltbld', 15:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:12 INFO - 'MOZ_NO_REMOTE': '1', 15:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:12 INFO - 'NO_EM_RESTART': '1', 15:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:12 INFO - 'PWD': '/builds/slave/test', 15:39:12 INFO - 'SHELL': '/bin/bash', 15:39:12 INFO - 'SHLVL': '1', 15:39:12 INFO - 'TERM': 'linux', 15:39:12 INFO - 'TMOUT': '86400', 15:39:12 INFO - 'USER': 'cltbld', 15:39:12 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:12 INFO - '_': '/tools/buildbot/bin/python'} 15:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:12 INFO - Running setup.py (path:/tmp/pip-ybIpWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:12 INFO - Running setup.py (path:/tmp/pip-UvQBSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:12 INFO - Running setup.py (path:/tmp/pip-8I9gFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:12 INFO - Running setup.py (path:/tmp/pip-uhwVZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:12 INFO - Running setup.py (path:/tmp/pip-x9aCoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:12 INFO - Running setup.py (path:/tmp/pip-gw2vCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:12 INFO - Running setup.py (path:/tmp/pip-thl5nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:13 INFO - Running setup.py (path:/tmp/pip-tEm4om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:13 INFO - Running setup.py (path:/tmp/pip-zEe_kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:13 INFO - Running setup.py (path:/tmp/pip-kk0Xaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:13 INFO - Running setup.py (path:/tmp/pip-XZNRvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:13 INFO - Running setup.py (path:/tmp/pip-by3WMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:13 INFO - Running setup.py (path:/tmp/pip-b7reLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:13 INFO - Running setup.py (path:/tmp/pip-805cUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:13 INFO - Running setup.py (path:/tmp/pip-0wH6yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:13 INFO - Running setup.py (path:/tmp/pip-qKQRHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:13 INFO - Running setup.py (path:/tmp/pip-v6G4vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:13 INFO - Running setup.py install for manifestparser 15:39:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:13 INFO - Running setup.py install for mozcrash 15:39:13 INFO - Running setup.py install for mozdebug 15:39:14 INFO - Running setup.py install for mozdevice 15:39:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for mozfile 15:39:14 INFO - Running setup.py install for mozhttpd 15:39:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for mozinfo 15:39:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for mozInstall 15:39:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for mozleak 15:39:14 INFO - Running setup.py install for mozlog 15:39:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for moznetwork 15:39:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:14 INFO - Running setup.py install for mozprocess 15:39:14 INFO - Running setup.py install for mozprofile 15:39:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:15 INFO - Running setup.py install for mozrunner 15:39:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:15 INFO - Running setup.py install for mozscreenshot 15:39:15 INFO - Running setup.py install for moztest 15:39:15 INFO - Running setup.py install for mozversion 15:39:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:15 INFO - Cleaning up... 15:39:15 INFO - Return code: 0 15:39:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:15 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')]} 15:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:15 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')]} 15:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:15 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:15 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 15:39:15 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 15:39:15 INFO - Using env: {'DISPLAY': ':0', 15:39:15 INFO - 'HOME': '/home/cltbld', 15:39:15 INFO - 'LANG': 'en_US.UTF-8', 15:39:15 INFO - 'LANGUAGE': 'en_US:en', 15:39:15 INFO - 'LOGNAME': 'cltbld', 15:39:15 INFO - 'MAIL': '/var/mail/cltbld', 15:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:15 INFO - 'MOZ_NO_REMOTE': '1', 15:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:15 INFO - 'NO_EM_RESTART': '1', 15:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:15 INFO - 'PWD': '/builds/slave/test', 15:39:15 INFO - 'SHELL': '/bin/bash', 15:39:15 INFO - 'SHLVL': '1', 15:39:15 INFO - 'TERM': 'linux', 15:39:15 INFO - 'TMOUT': '86400', 15:39:15 INFO - 'USER': 'cltbld', 15:39:15 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:15 INFO - '_': '/tools/buildbot/bin/python'} 15:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:15 INFO - Running setup.py (path:/tmp/pip-Qz9s4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:15 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)) 15:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:15 INFO - Running setup.py (path:/tmp/pip-vmOfL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:15 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)) 15:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:15 INFO - Running setup.py (path:/tmp/pip-HDbYVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:15 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)) 15:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:15 INFO - Running setup.py (path:/tmp/pip-iJbMBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:16 INFO - Running setup.py (path:/tmp/pip-UIihte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:16 INFO - Running setup.py (path:/tmp/pip-KOH5NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:16 INFO - Running setup.py (path:/tmp/pip-hHbifK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:16 INFO - Running setup.py (path:/tmp/pip-Hc8X5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:16 INFO - Running setup.py (path:/tmp/pip-0RF8CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:16 INFO - Running setup.py (path:/tmp/pip-zym9ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:16 INFO - Running setup.py (path:/tmp/pip-29y4cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:16 INFO - Running setup.py (path:/tmp/pip-IL1ctW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:16 INFO - Running setup.py (path:/tmp/pip-lbqt_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:16 INFO - Running setup.py (path:/tmp/pip-QkDdSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:16 INFO - Running setup.py (path:/tmp/pip-9NqOyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:16 INFO - Running setup.py (path:/tmp/pip-WmDjEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:16 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)) 15:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:16 INFO - Running setup.py (path:/tmp/pip-fD73uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:16 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)) 15:39:16 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)) 15:39:16 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)) 15:39:16 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)) 15:39:16 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)) 15:39:16 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)) 15:39:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:18 INFO - Downloading blessings-1.5.1.tar.gz 15:39:18 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 15:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:18 INFO - Installing collected packages: blessings 15:39:18 INFO - Running setup.py install for blessings 15:39:18 INFO - Successfully installed blessings 15:39:18 INFO - Cleaning up... 15:39:18 INFO - Return code: 0 15:39:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:19 INFO - Reading from file tmpfile_stdout 15:39:19 INFO - Current package versions: 15:39:19 INFO - argparse == 1.2.1 15:39:19 INFO - blessings == 1.5.1 15:39:19 INFO - blobuploader == 1.2.4 15:39:19 INFO - docopt == 0.6.1 15:39:19 INFO - manifestparser == 1.1 15:39:19 INFO - mozInstall == 1.12 15:39:19 INFO - mozcrash == 0.16 15:39:19 INFO - mozdebug == 0.1 15:39:19 INFO - mozdevice == 0.47 15:39:19 INFO - mozfile == 1.2 15:39:19 INFO - mozhttpd == 0.7 15:39:19 INFO - mozinfo == 0.9 15:39:19 INFO - mozleak == 0.1 15:39:19 INFO - mozlog == 3.1 15:39:19 INFO - moznetwork == 0.27 15:39:19 INFO - mozprocess == 0.22 15:39:19 INFO - mozprofile == 0.27 15:39:19 INFO - mozrunner == 6.11 15:39:19 INFO - mozscreenshot == 0.1 15:39:19 INFO - mozsystemmonitor == 0.0 15:39:19 INFO - moztest == 0.7 15:39:19 INFO - mozversion == 1.4 15:39:19 INFO - psutil == 3.1.1 15:39:19 INFO - requests == 1.2.3 15:39:19 INFO - wsgiref == 0.1.2 15:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:19 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:19 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 15:39:19 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 15:39:19 INFO - Using env: {'DISPLAY': ':0', 15:39:19 INFO - 'HOME': '/home/cltbld', 15:39:19 INFO - 'LANG': 'en_US.UTF-8', 15:39:19 INFO - 'LANGUAGE': 'en_US:en', 15:39:19 INFO - 'LOGNAME': 'cltbld', 15:39:19 INFO - 'MAIL': '/var/mail/cltbld', 15:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:19 INFO - 'MOZ_NO_REMOTE': '1', 15:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:19 INFO - 'NO_EM_RESTART': '1', 15:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:19 INFO - 'PWD': '/builds/slave/test', 15:39:19 INFO - 'SHELL': '/bin/bash', 15:39:19 INFO - 'SHLVL': '1', 15:39:19 INFO - 'TERM': 'linux', 15:39:19 INFO - 'TMOUT': '86400', 15:39:19 INFO - 'USER': 'cltbld', 15:39:19 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:19 INFO - '_': '/tools/buildbot/bin/python'} 15:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 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)) 15:39:19 INFO - Cleaning up... 15:39:19 INFO - Return code: 0 15:39:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:19 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:19 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 15:39:19 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 15:39:19 INFO - Using env: {'DISPLAY': ':0', 15:39:19 INFO - 'HOME': '/home/cltbld', 15:39:19 INFO - 'LANG': 'en_US.UTF-8', 15:39:19 INFO - 'LANGUAGE': 'en_US:en', 15:39:19 INFO - 'LOGNAME': 'cltbld', 15:39:19 INFO - 'MAIL': '/var/mail/cltbld', 15:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:19 INFO - 'MOZ_NO_REMOTE': '1', 15:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:19 INFO - 'NO_EM_RESTART': '1', 15:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:19 INFO - 'PWD': '/builds/slave/test', 15:39:19 INFO - 'SHELL': '/bin/bash', 15:39:19 INFO - 'SHLVL': '1', 15:39:19 INFO - 'TERM': 'linux', 15:39:19 INFO - 'TMOUT': '86400', 15:39:19 INFO - 'USER': 'cltbld', 15:39:19 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:19 INFO - '_': '/tools/buildbot/bin/python'} 15:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:19 INFO - Downloading/unpacking jsonschema 15:39:19 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 15:39:19 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 15:39:19 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 15:39:19 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 15:39:19 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 15:39:19 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 15:39:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:21 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 15:39:21 INFO - Downloading/unpacking functools32 (from jsonschema) 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:21 INFO - warning: no files found matching '*.txt' 15:39:21 INFO - no previously-included directories found matching 'build' 15:39:21 INFO - no previously-included directories found matching 'dist' 15:39:21 INFO - no previously-included directories found matching '.git*' 15:39:21 INFO - Installing collected packages: jsonschema, functools32 15:39:21 INFO - Running setup.py install for functools32 15:39:21 INFO - warning: no files found matching '*.txt' 15:39:21 INFO - no previously-included directories found matching 'build' 15:39:21 INFO - no previously-included directories found matching 'dist' 15:39:21 INFO - no previously-included directories found matching '.git*' 15:39:21 INFO - Successfully installed jsonschema functools32 15:39:21 INFO - Cleaning up... 15:39:21 INFO - Return code: 0 15:39:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:39:21 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')]} 15:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:21 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')]} 15:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:21 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 0x7fa192c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, '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': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', '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 15:39:21 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 15:39:21 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 15:39:21 INFO - Using env: {'DISPLAY': ':0', 15:39:21 INFO - 'HOME': '/home/cltbld', 15:39:21 INFO - 'LANG': 'en_US.UTF-8', 15:39:21 INFO - 'LANGUAGE': 'en_US:en', 15:39:21 INFO - 'LOGNAME': 'cltbld', 15:39:21 INFO - 'MAIL': '/var/mail/cltbld', 15:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:21 INFO - 'MOZ_NO_REMOTE': '1', 15:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:21 INFO - 'NO_EM_RESTART': '1', 15:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:21 INFO - 'PWD': '/builds/slave/test', 15:39:21 INFO - 'SHELL': '/bin/bash', 15:39:21 INFO - 'SHLVL': '1', 15:39:21 INFO - 'TERM': 'linux', 15:39:21 INFO - 'TMOUT': '86400', 15:39:21 INFO - 'USER': 'cltbld', 15:39:21 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:21 INFO - '_': '/tools/buildbot/bin/python'} 15:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:21 INFO - Downloading/unpacking flake8 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:21 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 15:39:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:39:23 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 15:39:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:39:23 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 15:39:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:23 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 15:39:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:24 INFO - no previously-included directories found matching 'docs/_build' 15:39:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:39:24 INFO - Running setup.py install for pep8 15:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:24 INFO - no previously-included directories found matching 'docs/_build' 15:39:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:39:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:39:24 INFO - Cleaning up... 15:39:24 INFO - Return code: 0 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - Running post-action listener: _start_resource_monitoring 15:39:24 INFO - Starting resource monitoring. 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running install step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: install 15:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:24 INFO - Reading from file tmpfile_stdout 15:39:24 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:24 INFO - Reading from file tmpfile_stdout 15:39:24 INFO - Output received: 15:39:24 INFO - Usage: mozinstall [options] installer 15:39:24 INFO - Options: 15:39:24 INFO - -h, --help show this help message and exit 15:39:24 INFO - -d DEST, --destination=DEST 15:39:24 INFO - Directory to install application into. [default: 15:39:24 INFO - "/builds/slave/test"] 15:39:24 INFO - --app=APP Application being installed. [default: firefox] 15:39:24 INFO - mkdir: /builds/slave/test/build/application 15:39:24 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'] 15:39:24 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 15:39:54 INFO - Reading from file tmpfile_stdout 15:39:54 INFO - Output received: 15:39:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:39:54 INFO - Running post-action listener: _resource_record_post_action 15:39:54 INFO - ##### 15:39:54 INFO - ##### Running run-tests step. 15:39:54 INFO - ##### 15:39:54 INFO - Running pre-action listener: _resource_record_pre_action 15:39:54 INFO - Running main action method: run_tests 15:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:39:54 INFO - Python 2.7.3 15:39:54 INFO - Return code: 0 15:39:54 INFO - grabbing minidump binary from tooltool 15:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:54 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 0x17590b0>, '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 0x1759fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:39:54 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 15:39:54 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 15:39:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:39:54 INFO - Return code: 0 15:39:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:39:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:39:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:39:55 INFO - Return code: 0 15:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test/build 15:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 15:39:55 INFO - Using env: {'DISPLAY': ':0', 15:39:55 INFO - 'HOME': '/home/cltbld', 15:39:55 INFO - 'LANG': 'en_US.UTF-8', 15:39:55 INFO - 'LANGUAGE': 'en_US:en', 15:39:55 INFO - 'LOGNAME': 'cltbld', 15:39:55 INFO - 'MAIL': '/var/mail/cltbld', 15:39:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:55 INFO - 'MOZ_NO_REMOTE': '1', 15:39:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:55 INFO - 'NO_EM_RESTART': '1', 15:39:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:55 INFO - 'PWD': '/builds/slave/test', 15:39:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:55 INFO - 'SHELL': '/bin/bash', 15:39:55 INFO - 'SHLVL': '1', 15:39:55 INFO - 'TERM': 'linux', 15:39:55 INFO - 'TMOUT': '86400', 15:39:55 INFO - 'USER': 'cltbld', 15:39:55 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412', 15:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:55 INFO - '_': '/tools/buildbot/bin/python'} 15:39:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 15:39:55 INFO - mozversion INFO | application_buildid: 20151217150054 15:39:55 INFO - mozversion INFO | application_changeset: 2d95a1f997e8a4a3289ebb2c10288445ae0b6a02 15:39:55 INFO - mozversion INFO | application_display_name: Nightly 15:39:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:39:55 INFO - mozversion INFO | application_name: Firefox 15:39:55 INFO - mozversion INFO | application_remotingname: firefox 15:39:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:39:55 INFO - mozversion INFO | application_vendor: Mozilla 15:39:55 INFO - mozversion INFO | application_version: 46.0a1 15:39:55 INFO - mozversion INFO | platform_buildid: 20151217150054 15:39:55 INFO - mozversion INFO | platform_changeset: 2d95a1f997e8a4a3289ebb2c10288445ae0b6a02 15:39:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:39:55 INFO - mozversion INFO | platform_version: 46.0a1 15:39:55 INFO - 2015-12-17 15:39:55,481 DEBUG : using testdate: 1450395595 15:39:55 INFO - 2015-12-17 15:39:55,481 DEBUG : actual date: 1450395595 15:39:55 INFO - 2015-12-17 15:39:55,489 INFO : starting webserver on 'localhost:44572' 15:39:55 INFO - 2015-12-17 15:39:55,489 INFO : Starting test suite talos-linux64-ix-013.e 15:39:55 INFO - 2015-12-17 15:39:55,489 INFO : Starting test dromaeo_css 15:39:55 INFO - 2015-12-17 15:39:55,489 DEBUG : operating with platform_type : linux_ 15:39:55 INFO - 2015-12-17 15:39:55,490 INFO : Initialising browser for dromaeo_css test... 15:39:55 INFO - 2015-12-17 15:39:55,496 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMgxlt/profile http://localhost:44572/getInfo.html 15:40:52 INFO - 2015-12-17 15:40:52,324 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:40:52 INFO - 2015-12-17 15:40:52,324 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:40:52 INFO - 2015-12-17 15:40:52,324 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:40:52 INFO - 2015-12-17 15:40:52,324 DEBUG : BROWSER_OUTPUT: __metrics 15:40:52 INFO - 2015-12-17 15:40:52,830 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] 15:40:53 INFO - 2015-12-17 15:40:53,537 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:40:56 INFO - 2015-12-17 15:40:56,883 INFO : Browser initialized. 15:40:56 INFO - 2015-12-17 15:40:56,883 INFO : Running cycle 1/1 for dromaeo_css test... 15:40:56 INFO - 2015-12-17 15:40:56,883 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMgxlt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:41:08 INFO - 2015-12-17 15:41:08,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 151474176 15:41:08 INFO - 2015-12-17 15:41:08,903 DEBUG : BROWSER_OUTPUT: 15:41:58 INFO - 2015-12-17 15:41:58,510 DEBUG : BROWSER_OUTPUT: 1450395718506 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] 15:44:10 INFO - 2015-12-17 15:44:10,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44572/tests/dromaeo/cssquery-ext.html) 15:44:11 INFO - 2015-12-17 15:44:11,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 156872704 15:44:11 INFO - 2015-12-17 15:44:11,820 DEBUG : BROWSER_OUTPUT: 15:47:13 INFO - 2015-12-17 15:47:13,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-ext.html (next: http://localhost:44572/tests/dromaeo/cssquery-jquery.html) 15:47:14 INFO - 2015-12-17 15:47:14,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 151228416 15:47:14 INFO - 2015-12-17 15:47:14,399 DEBUG : BROWSER_OUTPUT: 15:50:16 INFO - 2015-12-17 15:50:16,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44572/tests/dromaeo/cssquery-mootools.html) 15:50:16 INFO - 2015-12-17 15:50:16,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 152875008 15:50:16 INFO - 2015-12-17 15:50:16,818 DEBUG : BROWSER_OUTPUT: 15:53:18 INFO - 2015-12-17 15:53:18,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44572/tests/dromaeo/cssquery-prototype.html) 15:53:19 INFO - 2015-12-17 15:53:19,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 152182784 15:53:19 INFO - 2015-12-17 15:53:19,143 DEBUG : BROWSER_OUTPUT: 15:56:21 INFO - 2015-12-17 15:56:21,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44572/tests/dromaeo/cssquery-yui.html) 15:56:22 INFO - 2015-12-17 15:56:22,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 152686592 15:56:22 INFO - 2015-12-17 15:56:22,405 DEBUG : BROWSER_OUTPUT: 15:59:24 INFO - 2015-12-17 15:59:24,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/dromaeo/cssquery-yui.html (next: http://localhost:44572/tests/dromaeo/cssquery-dojo.html) 15:59:25 INFO - 2015-12-17 15:59:25,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 155664384 15:59:25 INFO - 2015-12-17 15:59:25,106 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,106 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:59:25 INFO - 2015-12-17 15:59:25,106 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:59:25 INFO - 2015-12-17 15:59:25,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:59:25 INFO - 2015-12-17 15:59:25,107 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:59:25 INFO - 2015-12-17 15:59:25,107 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2657.694365148008;2709.945801083977;2738.9041383551566;2741.410596721704;2745.9999999999986;4660.953390466094;4810.374651295336;4814.3741313629225;4845.854624361266;4878.78045487953;4692.929606055904;4711.034237981215;4727.787249573769;4871.391076115486;4879.926801097987;4353.760543170132;4434.578715022068;4491.797869095899;4493.910121797562;4535.115652447774;4432.556744325558;4484.955150448486;4502.909941801162;4567.474740404846;4592.08158368326;4277.165952639237;4373.956260437387;4383.276759334706;4474.709143905636;4486.125205584913;4434.379186913835;4455.509893911667;4459.375687403766;4460.130274596455;4466.039801442673;4416.580424859633;4417.3815665806815;4431.047324825146;4447.177272204653;4477.955220447787;4476.2837945928495;4593.311003349491;4604.654650901196;4606.953930460686;4698.765061746899;4997.350344455234;5021.824236151754;5081.517255860687;5107.310513080761;5144.485551444825;5146.819861304836;5152;5158.974205128988;5176.7411629418375;5204.245384419238;4627.676062675648;4770.42754869411;4772.188727916263;4787.593054590329;4789.760511974388;5187.922181167285;5242.606804489678;5273.1035723927025;5284.630075894651;5322.787088516416;5087.821926232638;5119.180931051014;5133.153029750124;5136.8202112925865;5160.870978225499;4833.32333473314;4950.77721502526;4991.575716064102;5216.191490319006;5221.399539052982;5081.669691470042;5147.253648220987;5148.330717006766;5148.4079330876675;5149.819756308511;5104.412992505835;5113.769880355393;5116.667416617908;5125.923111153335;5175.689458632494;4026.516817981861;4136.669066474675;4207.326827707552;4276.016516201291;4303.505096913832;3732.4774531565604;3742.9064273392837;3745.3071181831447;3794.241151769602;3797.1646237828186;4447.3773671685985;4447.421835161408;4467.754273514923;4471.552844715502;4509.864704058883;4891.777055736066;4947.826826061142;5064.848054558369;5142.845714628567;5197.090509160882;4440.822367105279;4451.376807246988;4455.198064348384;4456.821727130943;4489.842855500042;4321.351797230441;4556.863294101182;4561.384213131251;4575.290829921368;4622.884427889329;4739.597134243559;4760.95239047612;4830.178869592108;4834.154023046023;4876.78054487556;5170.793168273377;5172.482751724798;5184.714840683799;5227.111391063452;5249.160134378481;4559.589636932559;4662.5104364042645;4878.731669758055;4889.9022019560125;4933.58064564516;4919.901601967869;4957.206846904478;4967.379077615298;4986.526280003394;5013.348264725562;5174.120399532013;5176.844694659016;5181.792728290826;5192.662476938987;5231.372235331784;4806.062817750505;4899.779509921991;4924.926126108039;5010.048090862724;5013.799448022039;4878.756062196805;4896.510348965075;4911.165101932608;4927.334809800631;4946.455889852042;4814.735189564608;4826.0830442215865;4828.8792780180775;4853.51464853526;4907.993861258362;4773.236282194832;4846.418429788448;4914.164592019437;4969.577585905238;4995.425526064549;4899.583535399531;4903.215485522299;4913.115639184981;4914.459409465027;4973.104841128632 15:59:25 INFO - 2015-12-17 15:59:25,107 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.5459414092162;548.876502786873;570.7602806821135;576.700115939711;581.6684489840792;34303.82848085759;35381;35385.11537211571;35506.644933550655;35586.82206588963;40448.59551404485;40781.184376312456;41065.79467102668;41136.58863411372;41190.58809411905;7796.883046754303;7923.445358824884;7934.246246606592;7958.4826986246;7964.681412743512;7816.609169541529;7947.880781788278;7957.482763620375;8007.119216886138;8009.599520024005;7600.657970391346;7717.845643087163;7734.690612375498;7736.690532378726;7738.49699769516;7890.723824666109;7922.801929951768;7950.045994480642;7965.322947549465;7973.362131029504;7762.184970578121;7930.1276859545405;7959.522428654299;7961.482503637245;7963.601819908981;37470.25059498795;37646;37703.81148094242;37959;38012.80993595014;2843.843588602626;2931.5016447204025;3012.4276387486307;3615.692666123383;3650.3976843820737;27787.86106069477;28150.296242593893;28180.436391272266;28294.15117546477;28345.716542834514;3351.949720754191;3502.5271588335504;3562.8040457774814;3563.893083207482;3631.673149416565;218842;220602;221339.89330053408;221744;222607;49867.750661247184;53330.73334633302;53343.19985200225;53383;53408.73295633497;44606;61077.38922610717;62051.379486205464;62206.68896655488;62437.68781156065;14169.433222670978;14530.564083077525;14535.709285814224;14542.41830326775;14554.854451455562;9800.754981125529;9920;9927.15619172364;9998.500074996222;10007.749806254902;18634.440966771017;18865.905670471835;18897.43307700771;18934.24263029491;19788.20847166126;7577.280158384945;7803.9609801951765;7813.648385822652;8022.318102961197;8027.197280272043;857.6140736668399;968.9031096890254;992.5682328187262;994.9651762188289;997.6358629100326;25707.485850283265;26107.347316316864;26338.473230535667;26389.868050659625;26582;984.625842179967;996.2976101848179;1012.3015119567475;1061.6496556136456;1075.4461452352045;13633.02541454139;13928.37322320498;14003.579892603238;14096.154230746188;14205.78691319631;262717;263538;264055;265521;266645;46560.8359791008;47028;47204;47217.527824722;47477.76261118741;1210.6489118155637;1218.7196944702769;1225.522046401904;1231.4950870143377;1232.1436601562007;24835.25494235176;24911.750882490942;25292;25424;25596.23211303664;40644.561326320516;41047.17905641811;41092.794536027126;41158;41246.793766030976;241360;244266;244781;245166;245236;29831.850840745657;41659.58340416557;42552.787236063625;42854;43032.354514681676;37637.435438467895;37802.0549486254;37994;38494.615053850226;38854.80572597232;32929;33138.66861331356;33479.66520334766;33607.83196084004;34028.65971340255;32598.674013259562;32859.67140328566;33046.66953330436;33062.5040624386;33081.50377744288;33416.33167336688;33693.3261334767;33694.66305336915;34011;34249.315013700085;28164.577531336636;29825.403491929606;30679.846600766854;30695.846520767253;30721;23877.52244955126;24289.27132186037;25861.224163275132;26616.201513954613;26774.732252677222 15:59:25 INFO - 2015-12-17 15:59:25,108 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.7665704036054;323.70704512416273;340.8619509098815;342.98799542016036;343.2140398487464;10087.193024558026;10233.48832558371;10552;15167.848321516782;15587.766183507256;15653.45212917548;15968.441104561343;15972.281247343868;16124.75812862808;16486.67026659466;5551.750171242284;5584.357798853133;5615.578831587647;5617.9719101404435;5630.802921897734;5661.150827375906;5680.744366503496;5703.429657034305;5708.058170401879;5716.514096301798;4107.342825147977;4239.173361194568;5579.442055794429;5594.804181853636;6488.935110648904;6599.373059559334;6648.03603477493;6664.900026499607;6708.865822683543;6713.227978782429;6264.624122552661;6448.097266382711;6449.903251451232;6454.419102280817;6478.54650174488;20952.895235523876;21180.78819211819;21310.254141104986;21598.89200553987;21732.782672173234;2001.579668269665;2053.37372101509;2085.18677715691;2091.5816836632735;2112.8098471137673;13777.311134443238;13800.240986745725;13901.304934753323;13903.582892513241;14052.297385130703;1879.3891985104758;1946.464722201406;1950.2004178286977;1983.1571582077704;2010.7184994100837;58543;62136.40772330512;64396;65252.3474765251;65614.3438565613;14775.41961991786;15302.540923772305;15352.539423817303;15371.923140384226;15413.46052888166;23040;23169.07323707033;23232;23281.18515851937;23318.3004509865;7630.847383052308;7672.079350477979;7711.151773304932;7869.016372953381;8238.958805205935;6381.3937675920715;6497.220333560003;6509.772157974448;6539.201719527168;6554.8361290968105;7461.589612571361;7491.662875170521;7512.812179695551;7514.774556763306;7534.510256833289;3002.24943764059;3078.8306643134397;3115.2990577119967;3116.1274843043984;3144.8584813683437;731.8865575835754;813.3574476163765;865.3769286113987;905.5472263868066;932.4871320773548;13779.379927903268;14001;14328.641783955485;14364.209968451627;14456.494022709154;806.7862016565615;852.6163226547955;864.3819668936741;865.4634126841398;916.679162293192;8415.326773858076;8489.61796719149;8510.87102435727;8658.567071646392;8687.348448866234;439610;440493;447441;453051;453507;68685.65657171683;69595.65202173957;69894.65052674703;70030.64984675146;70527.2947270531;1042.6976176908763;1046.6232156423682;1086.7935092332432;1103.1175059952006;1110.123002827757;13328.133671311334;13328.600141995756;13360.198388096745;13492;13566.796498052734;30107.69892301049;30178.396432070796;30938;30938.381232375676;31469.52795708112;42035.57964420439;42234.78882605567;43606.345904812086;43716;43895.56104439042;8830.42602230853;8875.778105547413;8964.058773828654;9032.503212323385;9123.224525915371;15660.765088523453;15912.681746364777;16021.519354419386;16195.43315983935;16276.267567959234;12895.640267497276;13503.39234734459;13660.590182294547;13910.374033168735;13929.303534823015;13050.0849745078;13426.194428334331;13476.258805765778;13798.448062077807;14039.368228429541;14114.941379396381;14400.85599144037;14448.855511444752;14466.421343146156;14731.705365892836;8446.197611226924;8592.484450932714;8674.956625217086;8765.780855478664;9035.096490350912;9387.953060234655;12368.628941131781;13963.371648276056;14194.858051419767;14276.42894284217 15:59:25 INFO - 2015-12-17 15:59:25,109 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1501.6095815088074;1633.7222672145733;1721.311475409836;1726.542466246445;1741.2512619573586;6760.5126872088185;6824.522283440155;6957.130358705162;7117.466190035749;7127.429805615551;7043.577385356869;7139.250378710226;7139.464540159496;7215.422766178706;7226;2037.8165965063142;2071.616750901088;2071.8342532597358;2073.1603700501323;2078.4803799050237;2047.3141497598322;2064.5561204341066;2065.948351291222;2090.1117025264202;2090.2997495838836;1961.764588249412;1999.310237967906;2009.547851733363;2017.1124705129769;2024.736784218057;2039.7654269759018;2059.155746144089;2062.7937206279253;2063.0716177720087;2070.327143678303;1963.6956271777897;2001.56966252255;2006.7290915726483;2006.8294194993443;2015.3853074812178;7042.929570704278;7122.2521635228595;7131.89302160468;7134.2509036551455;7142.785716428515;3990.3415936370466;4117.279476091672;4122.34042553193;4128.710990230685;4140.275451795924;2607.139643917503;2613.8954441822493;2660.5078060558667;2660.8802603882873;2666.6933302670245;839.9748007559783;898.9865152022725;915;924.9306302027375;930.8743319651828;9157.313201509913;9272.536373181381;9287.535623218811;9288.303377246733;9315.254779617615;3469.965300347015;3523.2072783623994;3572.5712914450432;3605.8918232452543;3626.256617393428;7592.696292148363;7626.69493220276;7651.426143039294;7663.080430348394;7665.923340766521;3941.2905676977844;3944.60553944609;3961.742486738353;3968.265870813909;3968.940465893014;3614.168741189541;3646.872359467406;3650.470681751131;3663.102539877747;3672.3022625701033;2927.9268018299713;2934.413117376533;2970.7474864636747;2976.64280286367;2979.031814660244;885.2121611765534;887.5207388010531;895.0691281067617;898.6944438890808;899.0155779421654;892.1569117184329;892.9955350223207;897.7531178925848;956.2111258212003;1180.8701042885275;6408.231012278557;6445.970393914852;6488.935110648833;6495.382938620824;6504;958.3483231402713;963.5230560872413;974.206022092007;1041.0578426524007;1063.4788953412772;4982.227754697955;5017.498250174954;5059.873503162376;5069.949300507022;5083.847484575394;7935.682572697143;7950.403719721044;8085;8100.71647492335;8159.79600509992;8254.174582541818;8254.174582541818;8263.793405164799;8295.751127466187;8331.791705207419;6500.154979852589;6524.543281970216;6576.145101136917;6607.9669601651685;6650.401463868275;6515.73937042513;6548.508861835287;6554.672266386567;6565.671716414065;6572.277049524453;7399;7449.702011919462;7554.395648348229;7567.432442566939;7594.8101297468;7521.172671006294;7668.233176682287;7777.688892444239;7797.571133587707;7851.254130857559;5835.708214589338;5852.239208902815;5887.470127688529;5910.468057874812;5952.8809423812145;6657.53397262187;6919.308069193041;6928.4803639726215;6937.861242775217;6942.757003504853;6337.493000559852;6439.774607888701;6480.513961452815;6555.344465553407;6585.539012269095;5042.319286896222;6150.415710507495;6154.415330543591;6233.625982441068;6284.214473190851;6320.178376811169;6347.936520634735;6383.297837237993;6401;6412.519061070531;5960.433758792908;5986.491148252448;5993.130996005468;6003.189569408074;6008.459238668541;5872.442117998783;6023.66869822164;6062.848428789315;6069.817905462666;6071.696415179135 15:59:25 INFO - 2015-12-17 15:59:25,112 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.15027172558206;304.64813140822343;304.8597645083262;311.7661753684736;312.2365815580903;5402.945970540293;5431.972840135803;5521.696306703129;5538.833834984952;5577.553795696344;5383.730813459321;5523.502884740373;5534.446555344473;5537.916931246034;5549.278593782813;4297.914041719164;4327.632151267146;4334.783260836962;4337.956620433787;4342.044750154961;4330;4336.392904993303;4343.609075183233;4347.760873151976;4351.760653164075;4104.651104656108;4222.619964203221;4300.80646370914;4312.331588603772;4317.870463886073;4213.389058586503;4216.64158546524;4227.534971153171;4255.595718406777;4274;3709.703223742094;3709.888703338904;3710.777353358807;3712.9443058354145;3714.294284086015;5368.0605893968395;5379.838604841861;5391.083515802323;5397.055515284848;5408.621396502246;4661.743604101773;4814.229723244299;4890.290907818382;4901.43633482147;4916.50834916509;5635.718214089279;5795.565332600029;5842.678652674102;5847.619904706181;5854.034084376073;4022.9195416091807;4025.134596061861;4026.798660067014;4030.6573941215033;4031.23406552754;6062.969685151546;6112.235970503687;6147.754089836401;6155.322914479404;6164.167837341946;3986.900327491836;4112.691548133902;4145.564715704868;4149.25313443583;4168;4192.266353388145;4193.727407718488;4194.748315101104;4195.4336164618;4195.8741237762915;4827.637927155477;4840.6127509799135;4841.225403935354;4851.708897466164;4854.101991131652;5840.591158618856;5842.328132264759;5851.063829787214;5851.444112809277;5855;1440.2942558146433;1446.2913172545586;1452.4045141491938;1468.5961360625913;1486.5466032860081;969.4958621516772;991.5587563534158;992.2062350119875;1000.2598077422655;1005.5424781724298;5042.873928151826;5054.974725126424;5067.847964560995;5070.41690205631;5071.568916642127;5986.580939334205;5995.790147344822;5996.640201587918;6023.909641355383;6041.033434650435;5059.873503162376;5060.063888180698;5061.6962982221185;5066.695998240118;5068.214426763858;3194.329190869897;3238.8218647974586;3241.5137729340317;3273.476243801028;3275.770696051301;5633.718314084279;5636.351819540805;5675.971620141873;5676.858078548069;5682.062459694187;6202.193714817045;6212.72042758077;6212.9068063979075;6215.192025036717;6223.906641400383;5498.945010549844;5666.518345940559;5671.688057156896;5681.403452637496;5693.487586117187;6030.517558595389;6039.879202415839;6042.425969532887;6055.788047418319;6064.302605200459;5832.12518122285;5848.4151584841175;5868.471837534642;5878.647281163144;5889.703015823747;5633.211350410864;5634.577406694432;5666.744996475086;5682.261306030355;5690.715464226855;4062.5531191569494;4150.522689890701;4152.480939882515;4160.45914031174;4164.604362585549;5949.464548190511;5994.490468310242;6005.579609427473;6011.939880601138;6029.849253768691;5871.6183448075735;5902.852428689145;5911.970440147944;5913.142594323885;5918.615290006308;5881.411858814085;5889.087191485327;5892.793752218652;5909.409059094228;5911.467967882912;5639.520640745419;5751.281089863767;5781.103928891029;5782.987977104074;5784.1034639630925;5908.497777688945;5918.911216331672;5922.3485416605;5936.703164841654;5943.613665111754;5789.623674461147;5803.622764520293;5806.361300256884;5808.041673124057;5811.389804070681 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: |5;yui.html;549.4917201588532;558.5447859994107;586.2700937333021;627.6892937995691;711.7402148215899;10260.948695256522;10274.948625256882;10289.22830787692;10293.691189264324;10346;10752.946235268813;10982.890171098306;11551.480183391746;11683.766324673501;11784.823227651592;779.1273773373829;794.7258195922398;795.7016118955363;796.2873228460525;797.2067792546395;768.4313607930119;777.9027621547307;779.7309928074806;779.9649015794274;781.5232708048086;820.3765138494757;822.5558198572763;824.6783754335814;833.1959658929133;833.6457005772553;818.2840014986887;820.3437250199876;821.8191997760483;824.8803923431099;825.5170725125779;607.5746977116037;610.7160170520684;615.1787363869195;615.4030590327375;615.547572534187;9481.620735170654;9653.806923861554;9663.806723865484;9668.70993870185;9681.903180968242;9028.097190280985;9132.680356187502;9337.112974267433;9471.289653276031;9653.951730241304;8117.837643247102;8231.917680823175;8302.252797248277;8357.456765310297;8405.495670259805;3090.6136732908385;3190.7287880529952;3192.345569158317;3199.9680003200137;3209.6950789674943;37718.622813771784;37859;37981.24037519234;38466.615333846865;38662.613373866465;8472.83054338922;8494.617742201615;8513.276371508491;8539.615717292736;8590.1839325264;14749;14826.258687065603;14867.479638212611;14870.479533216501;14875.181864997528;6015.157877897098;6173.660448675276;6183.072539119168;6314.0528920661345;6376.3623637635865;3534.5228394166975;3596.8381422836037;3616.150204701893;3616.9819150904077;3645.5807582127863;2572.897084116614;2604.0234911908033;2608.1914606471673;2608.4522250327645;2612.4513852090895;466.56143225368044;470.43547742708887;472.7116458960032;474.0400688605601;475.7835184990821;421.2081287180082;423.7626928919815;431.94600674915637;465.5902805531111;564.7797359029981;6646.83382915431;6735.932640673628;6894.551854129466;7045.68294426752;7076.363127318566;462.38041025026627;468.7867020505662;502.30180049730905;528.4556906386429;582.9038208695603;3287.145342211042;3355.9496607550905;3393.701100123156;3395.9151021224175;3415.9658403416147;47350.28974565384;48383.274250886265;48652.75673621609;48662.5133748665;48692.7565362178;43324.566754332685;44051.559484405385;44122.338164927554;44332.3350149748;44426;38181.84545086433;39288.214235715124;39472.210555788726;39813.20373592512;40830.795846021174;6965.059716938148;7307.1231452226075;7407.8148046299275;7439.942631767598;7502.212267711811;29898.85050574733;30038.399232015676;30145.09564713062;30276.24309392283;30698.386032279675;37426.43860342151;38684.6131538681;38757;38916.41625375565;39102.4134637975;9426.434413935185;9622;9791.363561368487;9859.47178187382;9937.20502359795;10634.30876992993;11036.227464077758;11105.444727763417;11177.66467005991;11276;9643.903560964582;10056.19550435978;10061.346012509164;10087;10386.74033149147;10033.14718248957;10156.18750499973;10291.53688084053;10581.206409519164;10621.840672389766;9838.754031148992;10010.849837252592;10096.949515252376;10564.418956957441;10591.4704264788;8665.43674661145;8787.34094942869;8850.601722922613;8950.731478055408;9187.954060229924;7747.225277472207;8335.333173346238;8414.368922330726;8443.788905277172;8569.185927336894 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: __startTimestamp1450396765099__endTimestamp 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4720.20 Median:4834.15 stddev:491.80 (10.2%) stddev-sans-first:465.94 15:59:25 INFO - 2015-12-17 15:59:25,113 DEBUG : BROWSER_OUTPUT: Values: 2657.7 2709.9 2738.9 2741.4 2746.0 4661.0 4810.4 4814.4 4845.9 4878.8 4692.9 4711.0 4727.8 4871.4 4879.9 4353.8 4434.6 4491.8 4493.9 4535.1 4432.6 4485.0 4502.9 4567.5 4592.1 4277.2 4374.0 4383.3 4474.7 4486.1 4434.4 4455.5 4459.4 4460.1 4466.0 4416.6 4417.4 4431.0 4447.2 4478.0 4476.3 4593.3 4604.7 4607.0 4698.8 4997.4 5021.8 5081.5 5107.3 5144.5 5146.8 5152.0 5159.0 5176.7 5204.2 4627.7 4770.4 4772.2 4787.6 4789.8 5187.9 5242.6 5273.1 5284.6 5322.8 5087.8 5119.2 5133.2 5136.8 5160.9 4833.3 4950.8 4991.6 5216.2 5221.4 5081.7 5147.3 5148.3 5148.4 5149.8 5104.4 5113.8 5116.7 5125.9 5175.7 4026.5 4136.7 4207.3 4276.0 4303.5 3732.5 3742.9 3745.3 3794.2 3797.2 4447.4 4447.4 4467.8 4471.6 4509.9 4891.8 4947.8 5064.8 5142.8 5197.1 4440.8 4451.4 4455.2 4456.8 4489.8 4321.4 4556.9 4561.4 4575.3 4622.9 4739.6 4761.0 4830.2 4834.2 4876.8 5170.8 5172.5 5184.7 5227.1 5249.2 4559.6 4662.5 4878.7 4889.9 4933.6 4919.9 4957.2 4967.4 4986.5 5013.3 5174.1 5176.8 5181.8 5192.7 5231.4 4806.1 4899.8 4924.9 5010.0 5013.8 4878.8 4896.5 4911.2 4927.3 4946.5 4814.7 4826.1 4828.9 4853.5 4908.0 4773.2 4846.4 4914.2 4969.6 4995.4 4899.6 4903.2 4913.1 4914.5 4973.1 15:59:25 INFO - 2015-12-17 15:59:25,114 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,114 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40874.09 Median:3563.35 stddev:63451.69 (1780.7%) stddev-sans-first:63557.41 15:59:25 INFO - 2015-12-17 15:59:25,114 DEBUG : BROWSER_OUTPUT: Values: 540.5 548.9 570.8 576.7 581.7 34303.8 35381.0 35385.1 35506.6 35586.8 40448.6 40781.2 41065.8 41136.6 41190.6 7796.9 7923.4 7934.2 7958.5 7964.7 7816.6 7947.9 7957.5 8007.1 8009.6 7600.7 7717.8 7734.7 7736.7 7738.5 7890.7 7922.8 7950.0 7965.3 7973.4 7762.2 7930.1 7959.5 7961.5 7963.6 37470.3 37646.0 37703.8 37959.0 38012.8 2843.8 2931.5 3012.4 3615.7 3650.4 27787.9 28150.3 28180.4 28294.2 28345.7 3351.9 3502.5 3562.8 3563.9 3631.7 218842.0 220602.0 221339.9 221744.0 222607.0 49867.8 53330.7 53343.2 53383.0 53408.7 44606.0 61077.4 62051.4 62206.7 62437.7 14169.4 14530.6 14535.7 14542.4 14554.9 9800.8 9920.0 9927.2 9998.5 10007.7 18634.4 18865.9 18897.4 18934.2 19788.2 7577.3 7804.0 7813.6 8022.3 8027.2 857.6 968.9 992.6 995.0 997.6 25707.5 26107.3 26338.5 26389.9 26582.0 984.6 996.3 1012.3 1061.6 1075.4 13633.0 13928.4 14003.6 14096.2 14205.8 262717.0 263538.0 264055.0 265521.0 266645.0 46560.8 47028.0 47204.0 47217.5 47477.8 1210.6 1218.7 1225.5 1231.5 1232.1 24835.3 24911.8 25292.0 25424.0 25596.2 40644.6 41047.2 41092.8 41158.0 41246.8 241360.0 244266.0 244781.0 245166.0 245236.0 29831.9 41659.6 42552.8 42854.0 43032.4 37637.4 37802.1 37994.0 38494.6 38854.8 32929.0 33138.7 33479.7 33607.8 34028.7 32598.7 32859.7 33046.7 33062.5 33081.5 33416.3 33693.3 33694.7 34011.0 34249.3 28164.6 29825.4 30679.8 30695.8 30721.0 23877.5 24289.3 25861.2 26616.2 26774.7 15:59:25 INFO - 2015-12-17 15:59:25,114 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,114 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26153.52 Median:332.28 stddev:72952.83 (21954.9%) stddev-sans-first:73131.69 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: Values: 319.8 323.7 340.9 343.0 343.2 10087.2 10233.5 10552.0 15167.8 15587.8 15653.5 15968.4 15972.3 16124.8 16486.7 5551.8 5584.4 5615.6 5618.0 5630.8 5661.2 5680.7 5703.4 5708.1 5716.5 4107.3 4239.2 5579.4 5594.8 6488.9 6599.4 6648.0 6664.9 6708.9 6713.2 6264.6 6448.1 6449.9 6454.4 6478.5 20952.9 21180.8 21310.3 21598.9 21732.8 2001.6 2053.4 2085.2 2091.6 2112.8 13777.3 13800.2 13901.3 13903.6 14052.3 1879.4 1946.5 1950.2 1983.2 2010.7 58543.0 62136.4 64396.0 65252.3 65614.3 14775.4 15302.5 15352.5 15371.9 15413.5 23040.0 23169.1 23232.0 23281.2 23318.3 7630.8 7672.1 7711.2 7869.0 8239.0 6381.4 6497.2 6509.8 6539.2 6554.8 7461.6 7491.7 7512.8 7514.8 7534.5 3002.2 3078.8 3115.3 3116.1 3144.9 731.9 813.4 865.4 905.5 932.5 13779.4 14001.0 14328.6 14364.2 14456.5 806.8 852.6 864.4 865.5 916.7 8415.3 8489.6 8510.9 8658.6 8687.3 439610.0 440493.0 447441.0 453051.0 453507.0 68685.7 69595.7 69894.7 70030.6 70527.3 1042.7 1046.6 1086.8 1103.1 1110.1 13328.1 13328.6 13360.2 13492.0 13566.8 30107.7 30178.4 30938.0 30938.4 31469.5 42035.6 42234.8 43606.3 43716.0 43895.6 8830.4 8875.8 8964.1 9032.5 9123.2 15660.8 15912.7 16021.5 16195.4 16276.3 12895.6 13503.4 13660.6 13910.4 13929.3 13050.1 13426.2 13476.3 13798.4 14039.4 14114.9 14400.9 14448.9 14466.4 14731.7 8446.2 8592.5 8675.0 8765.8 9035.1 9388.0 12368.6 13963.4 14194.9 14276.4 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4844.86 Median:6365.62 stddev:2513.39 (39.5%) stddev-sans-first:2507.88 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: Values: 1501.6 1633.7 1721.3 1726.5 1741.3 6760.5 6824.5 6957.1 7117.5 7127.4 7043.6 7139.3 7139.5 7215.4 7226.0 2037.8 2071.6 2071.8 2073.2 2078.5 2047.3 2064.6 2065.9 2090.1 2090.3 1961.8 1999.3 2009.5 2017.1 2024.7 2039.8 2059.2 2062.8 2063.1 2070.3 1963.7 2001.6 2006.7 2006.8 2015.4 7042.9 7122.3 7131.9 7134.3 7142.8 3990.3 4117.3 4122.3 4128.7 4140.3 2607.1 2613.9 2660.5 2660.9 2666.7 840.0 899.0 915.0 924.9 930.9 9157.3 9272.5 9287.5 9288.3 9315.3 3470.0 3523.2 3572.6 3605.9 3626.3 7592.7 7626.7 7651.4 7663.1 7665.9 3941.3 3944.6 3961.7 3968.3 3968.9 3614.2 3646.9 3650.5 3663.1 3672.3 2927.9 2934.4 2970.7 2976.6 2979.0 885.2 887.5 895.1 898.7 899.0 892.2 893.0 897.8 956.2 1180.9 6408.2 6446.0 6488.9 6495.4 6504.0 958.3 963.5 974.2 1041.1 1063.5 4982.2 5017.5 5059.9 5069.9 5083.8 7935.7 7950.4 8085.0 8100.7 8159.8 8254.2 8254.2 8263.8 8295.8 8331.8 6500.2 6524.5 6576.1 6608.0 6650.4 6515.7 6548.5 6554.7 6565.7 6572.3 7399.0 7449.7 7554.4 7567.4 7594.8 7521.2 7668.2 7777.7 7797.6 7851.3 5835.7 5852.2 5887.5 5910.5 5952.9 6657.5 6919.3 6928.5 6937.9 6942.8 6337.5 6439.8 6480.5 6555.3 6585.5 5042.3 6150.4 6154.4 6233.6 6284.2 6320.2 6347.9 6383.3 6401.0 6412.5 5960.4 5986.5 5993.1 6003.2 6008.5 5872.4 6023.7 6062.8 6069.8 6071.7 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4824.55 Median:5510.32 stddev:1429.01 (25.9%) stddev-sans-first:1392.05 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: Values: 298.2 304.6 304.9 311.8 312.2 5402.9 5432.0 5521.7 5538.8 5577.6 5383.7 5523.5 5534.4 5537.9 5549.3 4297.9 4327.6 4334.8 4338.0 4342.0 4330.0 4336.4 4343.6 4347.8 4351.8 4104.7 4222.6 4300.8 4312.3 4317.9 4213.4 4216.6 4227.5 4255.6 4274.0 3709.7 3709.9 3710.8 3712.9 3714.3 5368.1 5379.8 5391.1 5397.1 5408.6 4661.7 4814.2 4890.3 4901.4 4916.5 5635.7 5795.6 5842.7 5847.6 5854.0 4022.9 4025.1 4026.8 4030.7 4031.2 6063.0 6112.2 6147.8 6155.3 6164.2 3986.9 4112.7 4145.6 4149.3 4168.0 4192.3 4193.7 4194.7 4195.4 4195.9 4827.6 4840.6 4841.2 4851.7 4854.1 5840.6 5842.3 5851.1 5851.4 5855.0 1440.3 1446.3 1452.4 1468.6 1486.5 969.5 991.6 992.2 1000.3 1005.5 5042.9 5055.0 5067.8 5070.4 5071.6 5986.6 5995.8 5996.6 6023.9 6041.0 5059.9 5060.1 5061.7 5066.7 5068.2 3194.3 3238.8 3241.5 3273.5 3275.8 5633.7 5636.4 5676.0 5676.9 5682.1 6202.2 6212.7 6212.9 6215.2 6223.9 5498.9 5666.5 5671.7 5681.4 5693.5 6030.5 6039.9 6042.4 6055.8 6064.3 5832.1 5848.4 5868.5 5878.6 5889.7 5633.2 5634.6 5666.7 5682.3 5690.7 4062.6 4150.5 4152.5 4160.5 4164.6 5949.5 5994.5 6005.6 6011.9 6029.8 5871.6 5902.9 5912.0 5913.1 5918.6 5881.4 5889.1 5892.8 5909.4 5911.5 5639.5 5751.3 5781.1 5783.0 5784.1 5908.5 5918.9 5922.3 5936.7 5943.6 5789.6 5803.6 5806.4 5808.0 5811.4 15:59:25 INFO - 2015-12-17 15:59:25,115 DEBUG : BROWSER_OUTPUT: 15:59:25 INFO - 2015-12-17 15:59:25,116 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11630.56 Median:48518.02 stddev:13438.56 (27.7%) stddev-sans-first:13450.50 15:59:25 INFO - 2015-12-17 15:59:25,117 DEBUG : BROWSER_OUTPUT: Values: 549.5 558.5 586.3 627.7 711.7 10260.9 10274.9 10289.2 10293.7 10346.0 10752.9 10982.9 11551.5 11683.8 11784.8 779.1 794.7 795.7 796.3 797.2 768.4 777.9 779.7 780.0 781.5 820.4 822.6 824.7 833.2 833.6 818.3 820.3 821.8 824.9 825.5 607.6 610.7 615.2 615.4 615.5 9481.6 9653.8 9663.8 9668.7 9681.9 9028.1 9132.7 9337.1 9471.3 9654.0 8117.8 8231.9 8302.3 8357.5 8405.5 3090.6 3190.7 3192.3 3200.0 3209.7 37718.6 37859.0 37981.2 38466.6 38662.6 8472.8 8494.6 8513.3 8539.6 8590.2 14749.0 14826.3 14867.5 14870.5 14875.2 6015.2 6173.7 6183.1 6314.1 6376.4 3534.5 3596.8 3616.2 3617.0 3645.6 2572.9 2604.0 2608.2 2608.5 2612.5 466.6 470.4 472.7 474.0 475.8 421.2 423.8 431.9 465.6 564.8 6646.8 6735.9 6894.6 7045.7 7076.4 462.4 468.8 502.3 528.5 582.9 3287.1 3355.9 3393.7 3395.9 3416.0 47350.3 48383.3 48652.8 48662.5 48692.8 43324.6 44051.6 44122.3 44332.3 44426.0 38181.8 39288.2 39472.2 39813.2 40830.8 6965.1 7307.1 7407.8 7439.9 7502.2 29898.9 30038.4 30145.1 30276.2 30698.4 37426.4 38684.6 38757.0 38916.4 39102.4 9426.4 9622.0 9791.4 9859.5 9937.2 10634.3 11036.2 11105.4 11177.7 11276.0 9643.9 10056.2 10061.3 10087.0 10386.7 10033.1 10156.2 10291.5 10581.2 10621.8 9838.8 10010.8 10096.9 10564.4 10591.5 8665.4 8787.3 8850.6 8950.7 9188.0 7747.2 8335.3 8414.4 8443.8 8569.2 15:59:25 INFO - 2015-12-17 15:59:25,117 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:59:25 INFO - 2015-12-17 15:59:25,117 DEBUG : BROWSER_OUTPUT: 15:59:26 INFO - 2015-12-17 15:59:26,607 INFO : Browser exited with error code: 0 15:59:26 INFO - 2015-12-17 15:59:26,628 INFO : Completed test dromaeo_css (00:19:31) 15:59:26 INFO - 2015-12-17 15:59:26,628 INFO : Starting test kraken 15:59:26 INFO - 2015-12-17 15:59:26,628 DEBUG : operating with platform_type : linux_ 15:59:26 INFO - 2015-12-17 15:59:26,628 INFO : Initialising browser for kraken test... 15:59:26 INFO - 2015-12-17 15:59:26,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4lI6yr/profile http://localhost:44572/getInfo.html 15:59:41 INFO - 2015-12-17 15:59:41,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:59:41 INFO - 2015-12-17 15:59:41,519 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:59:41 INFO - 2015-12-17 15:59:41,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:59:41 INFO - 2015-12-17 15:59:41,519 DEBUG : BROWSER_OUTPUT: __metrics 15:59:41 INFO - 2015-12-17 15:59:41,931 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] 15:59:42 INFO - 2015-12-17 15:59:42,499 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:59:46 INFO - 2015-12-17 15:59:46,047 INFO : Browser initialized. 15:59:46 INFO - 2015-12-17 15:59:46,047 INFO : Running cycle 1/1 for kraken test... 15:59:46 INFO - 2015-12-17 15:59:46,047 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4lI6yr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:59:58 INFO - 2015-12-17 15:59:58,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 151040000 15:59:58 INFO - 2015-12-17 15:59:58,112 DEBUG : BROWSER_OUTPUT: 16:00:00 INFO - 2015-12-17 16:00:00,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44572/tests/kraken/driver.html?testName=audio-beat-detection) 16:00:01 INFO - 2015-12-17 16:00:01,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 149667840 16:00:01 INFO - 2015-12-17 16:00:01,309 DEBUG : BROWSER_OUTPUT: 16:00:04 INFO - 2015-12-17 16:00:04,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44572/tests/kraken/driver.html?testName=audio-dft) 16:00:04 INFO - 2015-12-17 16:00:04,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 150601728 16:00:04 INFO - 2015-12-17 16:00:04,685 DEBUG : BROWSER_OUTPUT: 16:00:07 INFO - 2015-12-17 16:00:07,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44572/tests/kraken/driver.html?testName=audio-fft) 16:00:08 INFO - 2015-12-17 16:00:08,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 145330176 16:00:08 INFO - 2015-12-17 16:00:08,181 DEBUG : BROWSER_OUTPUT: 16:00:10 INFO - 2015-12-17 16:00:10,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44572/tests/kraken/driver.html?testName=audio-oscillator) 16:00:10 INFO - 2015-12-17 16:00:10,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 145928192 16:00:10 INFO - 2015-12-17 16:00:10,844 DEBUG : BROWSER_OUTPUT: 16:00:13 INFO - 2015-12-17 16:00:13,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:00:13 INFO - 2015-12-17 16:00:13,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 146817024 16:00:13 INFO - 2015-12-17 16:00:13,687 DEBUG : BROWSER_OUTPUT: 16:00:16 INFO - 2015-12-17 16:00:16,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44572/tests/kraken/driver.html?testName=imaging-darkroom) 16:00:17 INFO - 2015-12-17 16:00:17,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 146661376 16:00:17 INFO - 2015-12-17 16:00:17,360 DEBUG : BROWSER_OUTPUT: 16:00:20 INFO - 2015-12-17 16:00:20,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44572/tests/kraken/driver.html?testName=imaging-desaturate) 16:00:21 INFO - 2015-12-17 16:00:21,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 145469440 16:00:21 INFO - 2015-12-17 16:00:21,416 DEBUG : BROWSER_OUTPUT: 16:00:24 INFO - 2015-12-17 16:00:24,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44572/tests/kraken/driver.html?testName=json-parse-financial) 16:00:24 INFO - 2015-12-17 16:00:24,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 146550784 16:00:24 INFO - 2015-12-17 16:00:24,888 DEBUG : BROWSER_OUTPUT: 16:00:26 INFO - 2015-12-17 16:00:26,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:00:27 INFO - 2015-12-17 16:00:27,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 148205568 16:00:27 INFO - 2015-12-17 16:00:27,223 DEBUG : BROWSER_OUTPUT: 16:00:29 INFO - 2015-12-17 16:00:29,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:00:29 INFO - 2015-12-17 16:00:29,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 147644416 16:00:29 INFO - 2015-12-17 16:00:29,728 DEBUG : BROWSER_OUTPUT: 16:00:31 INFO - 2015-12-17 16:00:31,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:00:32 INFO - 2015-12-17 16:00:32,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 147755008 16:00:32 INFO - 2015-12-17 16:00:32,454 DEBUG : BROWSER_OUTPUT: 16:00:34 INFO - 2015-12-17 16:00:34,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:35 INFO - 2015-12-17 16:00:35,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 148328448 16:00:35 INFO - 2015-12-17 16:00:35,596 DEBUG : BROWSER_OUTPUT: 16:00:38 INFO - 2015-12-17 16:00:38,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:38 INFO - 2015-12-17 16:00:38,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 149299200 16:00:38 INFO - 2015-12-17 16:00:38,775 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44572/tests/kraken/driver.html?testName=ai-astar) 16:00:40 INFO - 2015-12-17 16:00:40,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 147906560 16:00:40 INFO - 2015-12-17 16:00:40,800 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:00:40 INFO - 2015-12-17 16:00:40,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:00:40 INFO - 2015-12-17 16:00:40,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;111;113;113;115;123;113;113;112;113 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;153;165;142;164;165;139;173;132 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;164;163;164;166;167;163;165;162 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;72;73;82;131;73;72;73;72;92 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;131;95;94;95;129;95;95;129 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;114;109;109;111;110;110;109;109;111 16:00:40 INFO - 2015-12-17 16:00:40,801 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;150;147;147;147;147;147;148 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;98;96;95;96;96;96;95;95 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;72;73;74;73;71;72;70;71 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;69;68;69;68;67;68;68;67;68 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;87;87;85;85;90;92;83;84;82 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;117;131;122;118;119;126;124;123;130 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;158;149;159;148;136;152;146;157;133 16:00:40 INFO - 2015-12-17 16:00:40,802 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;69;71;70;69;72;71;71;70 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,765 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1450396840798__endTimestamp 16:00:40 INFO - 2015-12-17 16:00:40,803 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:3.33 (2.9%) stddev-sans-first:3.54 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: Values: 114.0 111.0 113.0 113.0 115.0 123.0 113.0 113.0 112.0 113.0 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.50 stddev:15.03 (9.5%) stddev-sans-first:15.94 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 153.0 165.0 142.0 164.0 165.0 139.0 173.0 132.0 16:00:40 INFO - 2015-12-17 16:00:40,811 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.81 (1.1%) stddev-sans-first:1.90 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 164.0 163.0 164.0 166.0 167.0 163.0 165.0 162.0 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:73.00 stddev:18.49 (25.3%) stddev-sans-first:19.50 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: Values: 76.0 72.0 73.0 82.0 131.0 73.0 72.0 73.0 72.0 92.0 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:95.00 stddev:16.83 (17.7%) stddev-sans-first:17.35 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 131.0 95.0 94.0 95.0 129.0 95.0 95.0 129.0 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.55 (1.4%) stddev-sans-first:1.64 16:00:40 INFO - 2015-12-17 16:00:40,812 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 109.0 109.0 111.0 110.0 110.0 109.0 109.0 111.0 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 150.0 147.0 147.0 147.0 147.0 147.0 148.0 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 98.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.50 stddev:1.20 (1.7%) stddev-sans-first:1.27 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 73.0 74.0 73.0 71.0 72.0 70.0 71.0 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,813 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:0.71 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 68.0 69.0 68.0 67.0 68.0 68.0 67.0 68.0 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:3.33 (3.9%) stddev-sans-first:3.26 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: Values: 82.0 87.0 87.0 85.0 85.0 90.0 92.0 83.0 84.0 82.0 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.50 stddev:5.01 (4.1%) stddev-sans-first:5.00 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: Values: 118.0 117.0 131.0 122.0 118.0 119.0 126.0 124.0 123.0 130.0 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:150.50 stddev:9.49 (6.3%) stddev-sans-first:9.27 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: Values: 137.0 158.0 149.0 159.0 148.0 136.0 152.0 146.0 157.0 133.0 16:00:40 INFO - 2015-12-17 16:00:40,814 DEBUG : BROWSER_OUTPUT: 16:00:40 INFO - 2015-12-17 16:00:40,815 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.07 (1.5%) stddev-sans-first:1.01 16:00:40 INFO - 2015-12-17 16:00:40,815 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 69.0 71.0 70.0 69.0 72.0 71.0 71.0 70.0 16:00:40 INFO - 2015-12-17 16:00:40,815 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:00:40 INFO - 2015-12-17 16:00:40,815 DEBUG : BROWSER_OUTPUT: 16:00:42 INFO - 2015-12-17 16:00:42,563 INFO : Browser exited with error code: 0 16:00:42 INFO - 2015-12-17 16:00:42,611 INFO : Completed test kraken (00:01:15) 16:00:42 INFO - 2015-12-17 16:00:42,611 INFO : Starting test v8_7 16:00:42 INFO - 2015-12-17 16:00:42,611 DEBUG : operating with platform_type : linux_ 16:00:42 INFO - 2015-12-17 16:00:42,611 INFO : Initialising browser for v8_7 test... 16:00:42 INFO - 2015-12-17 16:00:42,617 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQWisK/profile http://localhost:44572/getInfo.html 16:00:59 INFO - 2015-12-17 16:00:59,749 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:00:59 INFO - 2015-12-17 16:00:59,749 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:00:59 INFO - 2015-12-17 16:00:59,749 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:00:59 INFO - 2015-12-17 16:00:59,749 DEBUG : BROWSER_OUTPUT: __metrics 16:01:00 INFO - 2015-12-17 16:01:00,476 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] 16:01:01 INFO - 2015-12-17 16:01:01,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:01:05 INFO - 2015-12-17 16:01:05,203 INFO : Browser initialized. 16:01:05 INFO - 2015-12-17 16:01:05,203 INFO : Running cycle 1/1 for v8_7 test... 16:01:05 INFO - 2015-12-17 16:01:05,203 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQWisK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:01:17 INFO - 2015-12-17 16:01:17,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 150585344 16:01:17 INFO - 2015-12-17 16:01:17,232 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44572/tests/v8_7/run.html (next: http://localhost:44572/tests/v8_7/run.html) 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 145502208 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:01:38 INFO - 2015-12-17 16:01:38,903 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |0;Richards;166.05778811026238 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.94901661256444 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1082.2510822510822 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |5;Earley;696.3788300835655 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |8;Splay;591.0430170889806 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: __startTimestamp1450396898896__endTimestamp 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:01:38 INFO - 2015-12-17 16:01:38,904 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: Values: 166.1 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: Values: 190.9 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: Values: 278.2 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: Values: 5170.1 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: Values: 1082.3 16:01:38 INFO - 2015-12-17 16:01:38,905 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:696.38 Median:696.38 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: Values: 696.4 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: Values: 12256.1 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: Values: 26342.1 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:591.04 Median:591.04 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: Values: 591.0 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:01:38 INFO - 2015-12-17 16:01:38,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:01:38 INFO - 2015-12-17 16:01:38,907 DEBUG : BROWSER_OUTPUT: 16:01:40 INFO - 2015-12-17 16:01:40,459 INFO : Browser exited with error code: 0 16:01:40 INFO - 2015-12-17 16:01:40,473 INFO : Completed test v8_7 (00:00:57) 16:01:40 INFO - 2015-12-17 16:01:40,715 INFO : Completed test suite (00:21:45) 16:01:40 INFO - 2015-12-17 16:01:40,715 DEBUG : Working with test: dromaeo_css 16:01:40 INFO - 2015-12-17 16:01:40,715 DEBUG : Generating results file: dromaeo_css 16:01:40 INFO - 2015-12-17 16:01:40,716 DEBUG : Working with test: kraken 16:01:40 INFO - 2015-12-17 16:01:40,717 DEBUG : Generating results file: kraken 16:01:40 INFO - 2015-12-17 16:01:40,717 INFO : javascript benchmark 16:01:40 INFO - 2015-12-17 16:01:40,717 DEBUG : Working with test: v8_7 16:01:40 INFO - 2015-12-17 16:01:40,717 DEBUG : Generating results file: v8_7 16:01:40 INFO - 2015-12-17 16:01:40,718 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:40 INFO - 2015-12-17 16:01:40,843 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:01:40 INFO - 2015-12-17 16:01:40,843 DEBUG : process_Request line: dromaeo_css 6389.27 graph.html#tests=[[72,132,43]] 16:01:40 INFO - 2015-12-17 16:01:40,844 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:40 INFO - 2015-12-17 16:01:40,892 DEBUG : process_Request line: kraken 1536.90 graph.html#tests=[[232,132,43]] 16:01:40 INFO - 2015-12-17 16:01:40,893 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:01:40 INFO - 2015-12-17 16:01:40,923 DEBUG : process_Request line: v8_7 21349.15 graph.html#tests=[[230,132,43]] 16:01:40 INFO - 2015-12-17 16:01:40,924 INFO : javascript benchmark 16:01:40 INFO - 2015-12-17 16:01:40,927 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2657.694365148008, 2709.945801083977, 2738.9041383551566, 2741.410596721704, 2745.9999999999986, 4660.953390466094, 4810.374651295336, 4814.3741313629225, 4845.854624361266, 4878.78045487953, 4692.929606055904, 4711.034237981215, 4727.787249573769, 4871.391076115486, 4879.926801097987, 4353.760543170132, 4434.578715022068, 4491.797869095899, 4493.910121797562, 4535.115652447774, 4432.556744325558, 4484.955150448486, 4502.909941801162, 4567.474740404846, 4592.08158368326, 4277.165952639237, 4373.956260437387, 4383.276759334706, 4474.709143905636, 4486.125205584913, 4434.379186913835, 4455.509893911667, 4459.375687403766, 4460.130274596455, 4466.039801442673, 4416.580424859633, 4417.3815665806815, 4431.047324825146, 4447.177272204653, 4477.955220447787, 4476.2837945928495, 4593.311003349491, 4604.654650901196, 4606.953930460686, 4698.765061746899, 4997.350344455234, 5021.824236151754, 5081.517255860687, 5107.310513080761, 5144.485551444825, 5146.819861304836, 5152.0, 5158.974205128988, 5176.7411629418375, 5204.245384419238, 4627.676062675648, 4770.42754869411, 4772.188727916263, 4787.593054590329, 4789.760511974388, 5187.922181167285, 5242.606804489678, 5273.1035723927025, 5284.630075894651, 5322.787088516416, 5087.821926232638, 5119.180931051014, 5133.153029750124, 5136.8202112925865, 5160.870978225499, 4833.32333473314, 4950.77721502526, 4991.575716064102, 5216.191490319006, 5221.399539052982, 5081.669691470042, 5147.253648220987, 5148.330717006766, 5148.4079330876675, 5149.819756308511, 5104.412992505835, 5113.769880355393, 5116.667416617908, 5125.923111153335, 5175.689458632494, 4026.516817981861, 4136.669066474675, 4207.326827707552, 4276.016516201291, 4303.505096913832, 3732.4774531565604, 3742.9064273392837, 3745.3071181831447, 3794.241151769602, 3797.1646237828186, 4447.3773671685985, 4447.421835161408, 4467.754273514923, 4471.552844715502, 4509.864704058883, 4891.777055736066, 4947.826826061142, 5064.848054558369, 5142.845714628567, 5197.090509160882, 4440.822367105279, 4451.376807246988, 4455.198064348384, 4456.821727130943, 4489.842855500042, 4321.351797230441, 4556.863294101182, 4561.384213131251, 4575.290829921368, 4622.884427889329, 4739.597134243559, 4760.95239047612, 4830.178869592108, 4834.154023046023, 4876.78054487556, 5170.793168273377, 5172.482751724798, 5184.714840683799, 5227.111391063452, 5249.160134378481, 4559.589636932559, 4662.5104364042645, 4878.731669758055, 4889.9022019560125, 4933.58064564516, 4919.901601967869, 4957.206846904478, 4967.379077615298, 4986.526280003394, 5013.348264725562, 5174.120399532013, 5176.844694659016, 5181.792728290826, 5192.662476938987, 5231.372235331784, 4806.062817750505, 4899.779509921991, 4924.926126108039, 5010.048090862724, 5013.799448022039, 4878.756062196805, 4896.510348965075, 4911.165101932608, 4927.334809800631, 4946.455889852042, 4814.735189564608, 4826.0830442215865, 4828.8792780180775, 4853.51464853526, 4907.993861258362, 4773.236282194832, 4846.418429788448, 4914.164592019437, 4969.577585905238, 4995.425526064549, 4899.583535399531, 4903.215485522299, 4913.115639184981, 4914.459409465027, 4973.104841128632], "unit": "score", "name": "dojo.html", "value": 4689.640035354911}, {"lowerIsBetter": false, "replicates": [540.5459414092162, 548.876502786873, 570.7602806821135, 576.700115939711, 581.6684489840792, 34303.82848085759, 35381.0, 35385.11537211571, 35506.644933550655, 35586.82206588963, 40448.59551404485, 40781.184376312456, 41065.79467102668, 41136.58863411372, 41190.58809411905, 7796.883046754303, 7923.445358824884, 7934.246246606592, 7958.4826986246, 7964.681412743512, 7816.609169541529, 7947.880781788278, 7957.482763620375, 8007.119216886138, 8009.599520024005, 7600.657970391346, 7717.845643087163, 7734.690612375498, 7736.690532378726, 7738.49699769516, 7890.723824666109, 7922.801929951768, 7950.045994480642, 7965.322947549465, 7973.362131029504, 7762.184970578121, 7930.1276859545405, 7959.522428654299, 7961.482503637245, 7963.601819908981, 37470.25059498795, 37646.0, 37703.81148094242, 37959.0, 38012.80993595014, 2843.843588602626, 2931.5016447204025, 3012.4276387486307, 3615.692666123383, 3650.3976843820737, 27787.86106069477, 28150.296242593893, 28180.436391272266, 28294.15117546477, 28345.716542834514, 3351.949720754191, 3502.5271588335504, 3562.8040457774814, 3563.893083207482, 3631.673149416565, 218842.0, 220602.0, 221339.89330053408, 221744.0, 222607.0, 49867.750661247184, 53330.73334633302, 53343.19985200225, 53383.0, 53408.73295633497, 44606.0, 61077.38922610717, 62051.379486205464, 62206.68896655488, 62437.68781156065, 14169.433222670978, 14530.564083077525, 14535.709285814224, 14542.41830326775, 14554.854451455562, 9800.754981125529, 9920.0, 9927.15619172364, 9998.500074996222, 10007.749806254902, 18634.440966771017, 18865.905670471835, 18897.43307700771, 18934.24263029491, 19788.20847166126, 7577.280158384945, 7803.9609801951765, 7813.648385822652, 8022.318102961197, 8027.197280272043, 857.6140736668399, 968.9031096890254, 992.5682328187262, 994.9651762188289, 997.6358629100326, 25707.485850283265, 26107.347316316864, 26338.473230535667, 26389.868050659625, 26582.0, 984.625842179967, 996.2976101848179, 1012.3015119567475, 1061.6496556136456, 1075.4461452352045, 13633.02541454139, 13928.37322320498, 14003.579892603238, 14096.154230746188, 14205.78691319631, 262717.0, 263538.0, 264055.0, 265521.0, 266645.0, 46560.8359791008, 47028.0, 47204.0, 47217.527824722, 47477.76261118741, 1210.6489118155637, 1218.7196944702769, 1225.522046401904, 1231.4950870143377, 1232.1436601562007, 24835.25494235176, 24911.750882490942, 25292.0, 25424.0, 25596.23211303664, 40644.561326320516, 41047.17905641811, 41092.794536027126, 41158.0, 41246.793766030976, 241360.0, 244266.0, 244781.0, 245166.0, 245236.0, 29831.850840745657, 41659.58340416557, 42552.787236063625, 42854.0, 43032.354514681676, 37637.435438467895, 37802.0549486254, 37994.0, 38494.615053850226, 38854.80572597232, 32929.0, 33138.66861331356, 33479.66520334766, 33607.83196084004, 34028.65971340255, 32598.674013259562, 32859.67140328566, 33046.66953330436, 33062.5040624386, 33081.50377744288, 33416.33167336688, 33693.3261334767, 33694.66305336915, 34011.0, 34249.315013700085, 28164.577531336636, 29825.403491929606, 30679.846600766854, 30695.846520767253, 30721.0, 23877.52244955126, 24289.27132186037, 25861.224163275132, 26616.201513954613, 26774.732252677222], "unit": "score", "name": "ext.html", "value": 17137.772313475027}, {"lowerIsBetter": false, "replicates": [319.7665704036054, 323.70704512416273, 340.8619509098815, 342.98799542016036, 343.2140398487464, 10087.193024558026, 10233.48832558371, 10552.0, 15167.848321516782, 15587.766183507256, 15653.45212917548, 15968.441104561343, 15972.281247343868, 16124.75812862808, 16486.67026659466, 5551.750171242284, 5584.357798853133, 5615.578831587647, 5617.9719101404435, 5630.802921897734, 5661.150827375906, 5680.744366503496, 5703.429657034305, 5708.058170401879, 5716.514096301798, 4107.342825147977, 4239.173361194568, 5579.442055794429, 5594.804181853636, 6488.935110648904, 6599.373059559334, 6648.03603477493, 6664.900026499607, 6708.865822683543, 6713.227978782429, 6264.624122552661, 6448.097266382711, 6449.903251451232, 6454.419102280817, 6478.54650174488, 20952.895235523876, 21180.78819211819, 21310.254141104986, 21598.89200553987, 21732.782672173234, 2001.579668269665, 2053.37372101509, 2085.18677715691, 2091.5816836632735, 2112.8098471137673, 13777.311134443238, 13800.240986745725, 13901.304934753323, 13903.582892513241, 14052.297385130703, 1879.3891985104758, 1946.464722201406, 1950.2004178286977, 1983.1571582077704, 2010.7184994100837, 58543.0, 62136.40772330512, 64396.0, 65252.3474765251, 65614.3438565613, 14775.41961991786, 15302.540923772305, 15352.539423817303, 15371.923140384226, 15413.46052888166, 23040.0, 23169.07323707033, 23232.0, 23281.18515851937, 23318.3004509865, 7630.847383052308, 7672.079350477979, 7711.151773304932, 7869.016372953381, 8238.958805205935, 6381.3937675920715, 6497.220333560003, 6509.772157974448, 6539.201719527168, 6554.8361290968105, 7461.589612571361, 7491.662875170521, 7512.812179695551, 7514.774556763306, 7534.510256833289, 3002.24943764059, 3078.8306643134397, 3115.2990577119967, 3116.1274843043984, 3144.8584813683437, 731.8865575835754, 813.3574476163765, 865.3769286113987, 905.5472263868066, 932.4871320773548, 13779.379927903268, 14001.0, 14328.641783955485, 14364.209968451627, 14456.494022709154, 806.7862016565615, 852.6163226547955, 864.3819668936741, 865.4634126841398, 916.679162293192, 8415.326773858076, 8489.61796719149, 8510.87102435727, 8658.567071646392, 8687.348448866234, 439610.0, 440493.0, 447441.0, 453051.0, 453507.0, 68685.65657171683, 69595.65202173957, 69894.65052674703, 70030.64984675146, 70527.2947270531, 1042.6976176908763, 1046.6232156423682, 1086.7935092332432, 1103.1175059952006, 1110.123002827757, 13328.133671311334, 13328.600141995756, 13360.198388096745, 13492.0, 13566.796498052734, 30107.69892301049, 30178.396432070796, 30938.0, 30938.381232375676, 31469.52795708112, 42035.57964420439, 42234.78882605567, 43606.345904812086, 43716.0, 43895.56104439042, 8830.42602230853, 8875.778105547413, 8964.058773828654, 9032.503212323385, 9123.224525915371, 15660.765088523453, 15912.681746364777, 16021.519354419386, 16195.43315983935, 16276.267567959234, 12895.640267497276, 13503.39234734459, 13660.590182294547, 13910.374033168735, 13929.303534823015, 13050.0849745078, 13426.194428334331, 13476.258805765778, 13798.448062077807, 14039.368228429541, 14114.941379396381, 14400.85599144037, 14448.855511444752, 14466.421343146156, 14731.705365892836, 8446.197611226924, 8592.484450932714, 8674.956625217086, 8765.780855478664, 9035.096490350912, 9387.953060234655, 12368.628941131781, 13963.371648276056, 14194.858051419767, 14276.42894284217], "unit": "score", "name": "jquery.html", "value": 9100.998405067583}, {"lowerIsBetter": false, "replicates": [1501.6095815088074, 1633.7222672145733, 1721.311475409836, 1726.542466246445, 1741.2512619573586, 6760.5126872088185, 6824.522283440155, 6957.130358705162, 7117.466190035749, 7127.429805615551, 7043.577385356869, 7139.250378710226, 7139.464540159496, 7215.422766178706, 7226.0, 2037.8165965063142, 2071.616750901088, 2071.8342532597358, 2073.1603700501323, 2078.4803799050237, 2047.3141497598322, 2064.5561204341066, 2065.948351291222, 2090.1117025264202, 2090.2997495838836, 1961.764588249412, 1999.310237967906, 2009.547851733363, 2017.1124705129769, 2024.736784218057, 2039.7654269759018, 2059.155746144089, 2062.7937206279253, 2063.0716177720087, 2070.327143678303, 1963.6956271777897, 2001.56966252255, 2006.7290915726483, 2006.8294194993443, 2015.3853074812178, 7042.929570704278, 7122.2521635228595, 7131.89302160468, 7134.2509036551455, 7142.785716428515, 3990.3415936370466, 4117.279476091672, 4122.34042553193, 4128.710990230685, 4140.275451795924, 2607.139643917503, 2613.8954441822493, 2660.5078060558667, 2660.8802603882873, 2666.6933302670245, 839.9748007559783, 898.9865152022725, 915.0, 924.9306302027375, 930.8743319651828, 9157.313201509913, 9272.536373181381, 9287.535623218811, 9288.303377246733, 9315.254779617615, 3469.965300347015, 3523.2072783623994, 3572.5712914450432, 3605.8918232452543, 3626.256617393428, 7592.696292148363, 7626.69493220276, 7651.426143039294, 7663.080430348394, 7665.923340766521, 3941.2905676977844, 3944.60553944609, 3961.742486738353, 3968.265870813909, 3968.940465893014, 3614.168741189541, 3646.872359467406, 3650.470681751131, 3663.102539877747, 3672.3022625701033, 2927.9268018299713, 2934.413117376533, 2970.7474864636747, 2976.64280286367, 2979.031814660244, 885.2121611765534, 887.5207388010531, 895.0691281067617, 898.6944438890808, 899.0155779421654, 892.1569117184329, 892.9955350223207, 897.7531178925848, 956.2111258212003, 1180.8701042885275, 6408.231012278557, 6445.970393914852, 6488.935110648833, 6495.382938620824, 6504.0, 958.3483231402713, 963.5230560872413, 974.206022092007, 1041.0578426524007, 1063.4788953412772, 4982.227754697955, 5017.498250174954, 5059.873503162376, 5069.949300507022, 5083.847484575394, 7935.682572697143, 7950.403719721044, 8085.0, 8100.71647492335, 8159.79600509992, 8254.174582541818, 8254.174582541818, 8263.793405164799, 8295.751127466187, 8331.791705207419, 6500.154979852589, 6524.543281970216, 6576.145101136917, 6607.9669601651685, 6650.401463868275, 6515.73937042513, 6548.508861835287, 6554.672266386567, 6565.671716414065, 6572.277049524453, 7399.0, 7449.702011919462, 7554.395648348229, 7567.432442566939, 7594.8101297468, 7521.172671006294, 7668.233176682287, 7777.688892444239, 7797.571133587707, 7851.254130857559, 5835.708214589338, 5852.239208902815, 5887.470127688529, 5910.468057874812, 5952.8809423812145, 6657.53397262187, 6919.308069193041, 6928.4803639726215, 6937.861242775217, 6942.757003504853, 6337.493000559852, 6439.774607888701, 6480.513961452815, 6555.344465553407, 6585.539012269095, 5042.319286896222, 6150.415710507495, 6154.415330543591, 6233.625982441068, 6284.214473190851, 6320.178376811169, 6347.936520634735, 6383.297837237993, 6401.0, 6412.519061070531, 5960.433758792908, 5986.491148252448, 5993.130996005468, 6003.189569408074, 6008.459238668541, 5872.442117998783, 6023.66869822164, 6062.848428789315, 6069.817905462666, 6071.696415179135], "unit": "score", "name": "mootools.html", "value": 3972.7521643602126}, {"lowerIsBetter": false, "replicates": [298.15027172558206, 304.64813140822343, 304.8597645083262, 311.7661753684736, 312.2365815580903, 5402.945970540293, 5431.972840135803, 5521.696306703129, 5538.833834984952, 5577.553795696344, 5383.730813459321, 5523.502884740373, 5534.446555344473, 5537.916931246034, 5549.278593782813, 4297.914041719164, 4327.632151267146, 4334.783260836962, 4337.956620433787, 4342.044750154961, 4330.0, 4336.392904993303, 4343.609075183233, 4347.760873151976, 4351.760653164075, 4104.651104656108, 4222.619964203221, 4300.80646370914, 4312.331588603772, 4317.870463886073, 4213.389058586503, 4216.64158546524, 4227.534971153171, 4255.595718406777, 4274.0, 3709.703223742094, 3709.888703338904, 3710.777353358807, 3712.9443058354145, 3714.294284086015, 5368.0605893968395, 5379.838604841861, 5391.083515802323, 5397.055515284848, 5408.621396502246, 4661.743604101773, 4814.229723244299, 4890.290907818382, 4901.43633482147, 4916.50834916509, 5635.718214089279, 5795.565332600029, 5842.678652674102, 5847.619904706181, 5854.034084376073, 4022.9195416091807, 4025.134596061861, 4026.798660067014, 4030.6573941215033, 4031.23406552754, 6062.969685151546, 6112.235970503687, 6147.754089836401, 6155.322914479404, 6164.167837341946, 3986.900327491836, 4112.691548133902, 4145.564715704868, 4149.25313443583, 4168.0, 4192.266353388145, 4193.727407718488, 4194.748315101104, 4195.4336164618, 4195.8741237762915, 4827.637927155477, 4840.6127509799135, 4841.225403935354, 4851.708897466164, 4854.101991131652, 5840.591158618856, 5842.328132264759, 5851.063829787214, 5851.444112809277, 5855.0, 1440.2942558146433, 1446.2913172545586, 1452.4045141491938, 1468.5961360625913, 1486.5466032860081, 969.4958621516772, 991.5587563534158, 992.2062350119875, 1000.2598077422655, 1005.5424781724298, 5042.873928151826, 5054.974725126424, 5067.847964560995, 5070.41690205631, 5071.568916642127, 5986.580939334205, 5995.790147344822, 5996.640201587918, 6023.909641355383, 6041.033434650435, 5059.873503162376, 5060.063888180698, 5061.6962982221185, 5066.695998240118, 5068.214426763858, 3194.329190869897, 3238.8218647974586, 3241.5137729340317, 3273.476243801028, 3275.770696051301, 5633.718314084279, 5636.351819540805, 5675.971620141873, 5676.858078548069, 5682.062459694187, 6202.193714817045, 6212.72042758077, 6212.9068063979075, 6215.192025036717, 6223.906641400383, 5498.945010549844, 5666.518345940559, 5671.688057156896, 5681.403452637496, 5693.487586117187, 6030.517558595389, 6039.879202415839, 6042.425969532887, 6055.788047418319, 6064.302605200459, 5832.12518122285, 5848.4151584841175, 5868.471837534642, 5878.647281163144, 5889.703015823747, 5633.211350410864, 5634.577406694432, 5666.744996475086, 5682.261306030355, 5690.715464226855, 4062.5531191569494, 4150.522689890701, 4152.480939882515, 4160.45914031174, 4164.604362585549, 5949.464548190511, 5994.490468310242, 6005.579609427473, 6011.939880601138, 6029.849253768691, 5871.6183448075735, 5902.852428689145, 5911.970440147944, 5913.142594323885, 5918.615290006308, 5881.411858814085, 5889.087191485327, 5892.793752218652, 5909.409059094228, 5911.467967882912, 5639.520640745419, 5751.281089863767, 5781.103928891029, 5782.987977104074, 5784.1034639630925, 5908.497777688945, 5918.911216331672, 5922.3485416605, 5936.703164841654, 5943.613665111754, 5789.623674461147, 5803.622764520293, 5806.361300256884, 5808.041673124057, 5811.389804070681], "unit": "score", "name": "prototype.html", "value": 4359.551708007571}, {"lowerIsBetter": false, "replicates": [549.4917201588532, 558.5447859994107, 586.2700937333021, 627.6892937995691, 711.7402148215899, 10260.948695256522, 10274.948625256882, 10289.22830787692, 10293.691189264324, 10346.0, 10752.946235268813, 10982.890171098306, 11551.480183391746, 11683.766324673501, 11784.823227651592, 779.1273773373829, 794.7258195922398, 795.7016118955363, 796.2873228460525, 797.2067792546395, 768.4313607930119, 777.9027621547307, 779.7309928074806, 779.9649015794274, 781.5232708048086, 820.3765138494757, 822.5558198572763, 824.6783754335814, 833.1959658929133, 833.6457005772553, 818.2840014986887, 820.3437250199876, 821.8191997760483, 824.8803923431099, 825.5170725125779, 607.5746977116037, 610.7160170520684, 615.1787363869195, 615.4030590327375, 615.547572534187, 9481.620735170654, 9653.806923861554, 9663.806723865484, 9668.70993870185, 9681.903180968242, 9028.097190280985, 9132.680356187502, 9337.112974267433, 9471.289653276031, 9653.951730241304, 8117.837643247102, 8231.917680823175, 8302.252797248277, 8357.456765310297, 8405.495670259805, 3090.6136732908385, 3190.7287880529952, 3192.345569158317, 3199.9680003200137, 3209.6950789674943, 37718.622813771784, 37859.0, 37981.24037519234, 38466.615333846865, 38662.613373866465, 8472.83054338922, 8494.617742201615, 8513.276371508491, 8539.615717292736, 8590.1839325264, 14749.0, 14826.258687065603, 14867.479638212611, 14870.479533216501, 14875.181864997528, 6015.157877897098, 6173.660448675276, 6183.072539119168, 6314.0528920661345, 6376.3623637635865, 3534.5228394166975, 3596.8381422836037, 3616.150204701893, 3616.9819150904077, 3645.5807582127863, 2572.897084116614, 2604.0234911908033, 2608.1914606471673, 2608.4522250327645, 2612.4513852090895, 466.56143225368044, 470.43547742708887, 472.7116458960032, 474.0400688605601, 475.7835184990821, 421.2081287180082, 423.7626928919815, 431.94600674915637, 465.5902805531111, 564.7797359029981, 6646.83382915431, 6735.932640673628, 6894.551854129466, 7045.68294426752, 7076.363127318566, 462.38041025026627, 468.7867020505662, 502.30180049730905, 528.4556906386429, 582.9038208695603, 3287.145342211042, 3355.9496607550905, 3393.701100123156, 3395.9151021224175, 3415.9658403416147, 47350.28974565384, 48383.274250886265, 48652.75673621609, 48662.5133748665, 48692.7565362178, 43324.566754332685, 44051.559484405385, 44122.338164927554, 44332.3350149748, 44426.0, 38181.84545086433, 39288.214235715124, 39472.210555788726, 39813.20373592512, 40830.795846021174, 6965.059716938148, 7307.1231452226075, 7407.8148046299275, 7439.942631767598, 7502.212267711811, 29898.85050574733, 30038.399232015676, 30145.09564713062, 30276.24309392283, 30698.386032279675, 37426.43860342151, 38684.6131538681, 38757.0, 38916.41625375565, 39102.4134637975, 9426.434413935185, 9622.0, 9791.363561368487, 9859.47178187382, 9937.20502359795, 10634.30876992993, 11036.227464077758, 11105.444727763417, 11177.66467005991, 11276.0, 9643.903560964582, 10056.19550435978, 10061.346012509164, 10087.0, 10386.74033149147, 10033.14718248957, 10156.18750499973, 10291.53688084053, 10581.206409519164, 10621.840672389766, 9838.754031148992, 10010.849837252592, 10096.949515252376, 10564.418956957441, 10591.4704264788, 8665.43674661145, 8787.34094942869, 8850.601722922613, 8950.731478055408, 9187.954060229924, 7747.225277472207, 8335.333173346238, 8414.368922330726, 8443.788905277172, 8569.185927336894], "unit": "score", "name": "yui.html", "value": 5369.621571849948}], "name": "dromaeo_css", "value": 6389.2702233230775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 113.0, 113.0, 115.0, 123.0, 113.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 153.0, 165.0, 142.0, 164.0, 165.0, 139.0, 173.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 164.0, 163.0, 164.0, 166.0, 167.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 73.0, 82.0, 131.0, 73.0, 72.0, 73.0, 72.0, 92.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 131.0, 95.0, 94.0, 95.0, 129.0, 95.0, 95.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 114.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 150.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 73.0, 74.0, 73.0, 71.0, 72.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 87.0, 85.0, 85.0, 90.0, 92.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 131.0, 122.0, 118.0, 119.0, 126.0, 124.0, 123.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [137.0, 158.0, 149.0, 159.0, 148.0, 136.0, 152.0, 146.0, 157.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 69.0, 71.0, 70.0, 69.0, 72.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1536.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [696.3788300835655], "unit": "score", "name": "Earley", "value": 957.0408679999998}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [591.0430170889806], "unit": "score", "name": "Splay", "value": 137.87659720837487}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21349.153002552575}]} 16:01:40 INFO - RETURN: dromaeo_css: 6389.27 16:01:40 INFO - RETURN: kraken: 1536.90 16:01:40 INFO - RETURN: v8_7: 21349.15 16:01:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21349.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1536.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6389.27"}}} 16:01:41 INFO - Return code: 0 16:01:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:01:41 INFO - # TBPL SUCCESS # 16:01:41 INFO - Running post-action listener: _resource_record_post_action 16:01:41 INFO - Running post-run listener: _resource_record_post_run 16:01:42 INFO - Total resource usage - Wall time: 1336s; CPU: 14.0%; Read bytes: 4096; Write bytes: 547385344; Read time: 2556; Write time: 7378112 16:01:42 INFO - install - Wall time: 30s; CPU: 22.0%; Read bytes: 0; Write bytes: 160538624; Read time: 0; Write time: 2175768 16:01:42 INFO - run-tests - Wall time: 1307s; CPU: 13.0%; Read bytes: 4096; Write bytes: 386846720; Read time: 2556; Write time: 5202344 16:01:42 INFO - Running post-run listener: _upload_blobber_files 16:01:42 INFO - Blob upload gear active. 16:01:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:01:42 INFO - Copying logs to upload dir... 16:01:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1383.460764 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-12-17 16:01:42.083947) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 16:01:42.087446) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010200 build_url: 'https://queue.taskcluster.net/v1/task/y_6J5kguTNe7vY9OBhKIXg/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 16:01:42.138926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:01:42.139264) ========= 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=256b35f542ca8bede9e27f1f00000291-1450394420.815424-1236469412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 16:01:42.189012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 16:01:42.189331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 16:01:42.189622) ========= ========= Total master_lag: 0.23 =========