builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1450354773.43 results: success (0) buildid: 20151217030552 builduid: 76c8f3156a9d48fbbba55951f9593fcf revision: 44861df2f79ee7929ee08f1cdf1ce5a13f1b314f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.427251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.427702) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.428005) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.451480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.452006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.478441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.478784) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.527770) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.528030) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.528373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.528646) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 04:19:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 84.5M=0s 2015-12-17 04:19:33 (84.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.713883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.714189) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016183 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:33.769124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 04:19:33.769463) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44861df2f79ee7929ee08f1cdf1ce5a13f1b314f --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 44861df2f79ee7929ee08f1cdf1ce5a13f1b314f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 04:19:34,014 truncating revision to first 12 chars 2015-12-17 04:19:34,014 Setting DEBUG logging. 2015-12-17 04:19:34,014 attempt 1/10 2015-12-17 04:19:34,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44861df2f79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 04:19:35,149 unpacking tar archive at: fx-team-44861df2f79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 04:19:35.216394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:35.216696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:35.225285) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:35.225636) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 04:19:35.226101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-17 04:19:35.226422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:35 INFO - MultiFileLogger online at 20151217 04:19:35 in /builds/slave/test 04:19:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:19:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:35 INFO - {'append_to_log': False, 04:19:35 INFO - 'base_work_dir': '/builds/slave/test', 04:19:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:19:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:35 INFO - 'branch': 'Fx-Team-Non-PGO', 04:19:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:35 INFO - 'config_files': ('talos/linux_config.py',), 04:19:35 INFO - 'default_actions': ('clobber', 04:19:35 INFO - 'read-buildbot-config', 04:19:35 INFO - 'download-and-extract', 04:19:35 INFO - 'populate-webroot', 04:19:35 INFO - 'create-virtualenv', 04:19:35 INFO - 'install', 04:19:35 INFO - 'run-tests'), 04:19:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:35 INFO - 'download_minidump_stackwalk': True, 04:19:35 INFO - 'download_symbols': 'ondemand', 04:19:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:35 INFO - 'installer_path': 'installer.exe', 04:19:35 INFO - 'log_level': 'info', 04:19:35 INFO - 'log_name': 'talos', 04:19:35 INFO - 'log_to_console': True, 04:19:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:35 INFO - 'opt_config_files': (), 04:19:35 INFO - 'pip_index': False, 04:19:35 INFO - 'sps_profile': False, 04:19:35 INFO - 'sps_profile_interval': 0, 04:19:35 INFO - 'suite': 'dromaeojs', 04:19:35 INFO - 'system_bits': '64', 04:19:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:35 INFO - 'title': 'talos-linux64-ix-022', 04:19:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:35 INFO - 'use_talos_json': True, 04:19:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:35 INFO - 'work_dir': 'build'} 04:19:35 INFO - ##### 04:19:35 INFO - ##### Running clobber step. 04:19:35 INFO - ##### 04:19:35 INFO - Running pre-action listener: _resource_record_pre_action 04:19:35 INFO - Running main action method: clobber 04:19:35 INFO - rmtree: /builds/slave/test/build 04:19:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:36 INFO - Running post-action listener: _resource_record_post_action 04:19:36 INFO - ##### 04:19:36 INFO - ##### Running read-buildbot-config step. 04:19:36 INFO - ##### 04:19:36 INFO - Running pre-action listener: _resource_record_pre_action 04:19:36 INFO - Running main action method: read_buildbot_config 04:19:36 INFO - Using buildbot properties: 04:19:36 INFO - { 04:19:36 INFO - "project": "", 04:19:36 INFO - "product": "firefox", 04:19:36 INFO - "script_repo_revision": "production", 04:19:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:19:36 INFO - "repository": "", 04:19:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:19:36 INFO - "buildid": "20151217030552", 04:19:36 INFO - "pgo_build": "False", 04:19:36 INFO - "basedir": "/builds/slave/test", 04:19:36 INFO - "buildnumber": 1021, 04:19:36 INFO - "slavename": "talos-linux64-ix-022", 04:19:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:19:36 INFO - "platform": "ubuntu64_hw", 04:19:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:19:36 INFO - "branch": "fx-team", 04:19:36 INFO - "repo_path": "integration/fx-team", 04:19:36 INFO - "revision": "44861df2f79ee7929ee08f1cdf1ce5a13f1b314f", 04:19:36 INFO - "stage_platform": "linux64", 04:19:36 INFO - "builduid": "76c8f3156a9d48fbbba55951f9593fcf", 04:19:36 INFO - "slavebuilddir": "test" 04:19:36 INFO - } 04:19:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:19:36 INFO - Running post-action listener: _resource_record_post_action 04:19:36 INFO - ##### 04:19:36 INFO - ##### Running download-and-extract step. 04:19:36 INFO - ##### 04:19:36 INFO - Running pre-action listener: _resource_record_pre_action 04:19:36 INFO - Running main action method: download_and_extract 04:19:36 INFO - mkdir: /builds/slave/test/build/tests 04:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:36 INFO - https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/test_packages.json 04:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/test_packages.json 04:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:19:40 INFO - Downloaded 1302 bytes. 04:19:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:19:40 INFO - Using the following test package requirements: 04:19:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'jsshell-linux-x86_64.zip'], 04:19:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:40 INFO - https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:45 INFO - Downloaded 21870957 bytes. 04:19:45 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 04:19:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:45 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 04:19:46 INFO - Return code: 0 04:19:46 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 04:19: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')]} 04:19:46 INFO - https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:48 INFO - Downloaded 21870957 bytes. 04:19:48 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 04:19:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 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 04:19:49 INFO - Return code: 0 04:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:49 INFO - https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:50 INFO - Downloaded 11132039 bytes. 04:19:50 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 04:19:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:50 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 04:19:50 INFO - Return code: 0 04:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:50 INFO - https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:19:51 INFO - Downloaded 53018827 bytes. 04:19:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:51 INFO - mkdir: /builds/slave/test/properties 04:19:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:51 INFO - Contents: 04:19:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:51 INFO - Running post-action listener: _resource_record_post_action 04:19:51 INFO - Running post-action listener: set_extra_try_arguments 04:19:51 INFO - ##### 04:19:51 INFO - ##### Running populate-webroot step. 04:19:51 INFO - ##### 04:19:51 INFO - Running pre-action listener: _resource_record_pre_action 04:19:51 INFO - Running main action method: populate_webroot 04:19:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:51 INFO - '--tppagecycles', 04:19:51 INFO - '7'], 04:19:51 INFO - 'tests': ['tsvgm']}}, 04:19:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:19:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'tests': ['damp', 'tps']}, 04:19:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['damp', 'tps']}, 04:19:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:19:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:51 INFO - 'other': {'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'other_l64': {'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'other_nol64': {'tests': ['a11yr', 04:19:51 INFO - 'ts_paint', 04:19:51 INFO - 'tpaint', 04:19:51 INFO - 'sessionrestore', 04:19:51 INFO - 'sessionrestore_no_auto_restore']}, 04:19:51 INFO - 'svgr': {'tests': ['tsvgx', 04:19:51 INFO - 'tsvgr_opacity', 04:19:51 INFO - 'tart', 04:19:51 INFO - 'tscrollx', 04:19:51 INFO - 'cart']}, 04:19:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['tsvgx', 04:19:51 INFO - 'tsvgr_opacity', 04:19:51 INFO - 'tart', 04:19:51 INFO - 'tscrollx', 04:19:51 INFO - 'cart']}, 04:19:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'tests': ['tp5o']}, 04:19:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'talos_options': ['--e10s'], 04:19:51 INFO - 'tests': ['tp5o']}, 04:19:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'talos_options': ['--xperf_path', 04:19:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:51 INFO - 'tests': ['tp5n']}, 04:19:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:51 INFO - 'talos_options': ['--e10s', 04:19:51 INFO - '--xperf_path', 04:19:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:51 INFO - 'tests': ['tp5n']}}, 04:19:51 INFO - 'talos.zip': {'path': '', 04:19:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:51 INFO - Running post-action listener: _resource_record_post_action 04:19:51 INFO - ##### 04:19:51 INFO - ##### Running create-virtualenv step. 04:19:51 INFO - ##### 04:19:51 INFO - Running pre-action listener: _resource_record_pre_action 04:19:51 INFO - Running main action method: create_virtualenv 04:19:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:51 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 04:19:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:52 INFO - Using real prefix '/usr' 04:19:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:54 INFO - Installing pip.................done. 04:19:54 INFO - Return code: 0 04:19:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:19:54 INFO - Using env: {'DISPLAY': ':0', 04:19:54 INFO - 'HOME': '/home/cltbld', 04:19:54 INFO - 'LANG': 'en_US.UTF-8', 04:19:54 INFO - 'LANGUAGE': 'en_US:en', 04:19:54 INFO - 'LOGNAME': 'cltbld', 04:19:54 INFO - 'MAIL': '/var/mail/cltbld', 04:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:54 INFO - 'MOZ_NO_REMOTE': '1', 04:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:54 INFO - 'NO_EM_RESTART': '1', 04:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:54 INFO - 'PWD': '/builds/slave/test', 04:19:54 INFO - 'SHELL': '/bin/bash', 04:19:54 INFO - 'SHLVL': '1', 04:19:54 INFO - 'TERM': 'linux', 04:19:54 INFO - 'TMOUT': '86400', 04:19:54 INFO - 'USER': 'cltbld', 04:19:54 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:54 INFO - '_': '/tools/buildbot/bin/python'} 04:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:54 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 04:19:54 INFO - Cleaning up... 04:19:54 INFO - Return code: 0 04:19:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:19:54 INFO - Using env: {'DISPLAY': ':0', 04:19:54 INFO - 'HOME': '/home/cltbld', 04:19:54 INFO - 'LANG': 'en_US.UTF-8', 04:19:54 INFO - 'LANGUAGE': 'en_US:en', 04:19:54 INFO - 'LOGNAME': 'cltbld', 04:19:54 INFO - 'MAIL': '/var/mail/cltbld', 04:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:54 INFO - 'MOZ_NO_REMOTE': '1', 04:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:54 INFO - 'NO_EM_RESTART': '1', 04:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:54 INFO - 'PWD': '/builds/slave/test', 04:19:54 INFO - 'SHELL': '/bin/bash', 04:19:54 INFO - 'SHLVL': '1', 04:19:54 INFO - 'TERM': 'linux', 04:19:54 INFO - 'TMOUT': '86400', 04:19:54 INFO - 'USER': 'cltbld', 04:19:54 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:54 INFO - '_': '/tools/buildbot/bin/python'} 04:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:54 INFO - Downloading/unpacking psutil>=0.7.1 04:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:19:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:56 INFO - Installing collected packages: psutil 04:19:56 INFO - Running setup.py install for psutil 04:19:57 INFO - building 'psutil._psutil_linux' extension 04:19:57 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 04:19:57 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 04:19:57 INFO - building 'psutil._psutil_posix' extension 04:19:57 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 04:19:57 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 04:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:57 INFO - Successfully installed psutil 04:19:57 INFO - Cleaning up... 04:19:57 INFO - Return code: 0 04:19:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:57 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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:19:57 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 04:19:57 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 04:19:57 INFO - Using env: {'DISPLAY': ':0', 04:19:57 INFO - 'HOME': '/home/cltbld', 04:19:57 INFO - 'LANG': 'en_US.UTF-8', 04:19:57 INFO - 'LANGUAGE': 'en_US:en', 04:19:57 INFO - 'LOGNAME': 'cltbld', 04:19:57 INFO - 'MAIL': '/var/mail/cltbld', 04:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:57 INFO - 'MOZ_NO_REMOTE': '1', 04:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:57 INFO - 'NO_EM_RESTART': '1', 04:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:57 INFO - 'PWD': '/builds/slave/test', 04:19:57 INFO - 'SHELL': '/bin/bash', 04:19:57 INFO - 'SHLVL': '1', 04:19:57 INFO - 'TERM': 'linux', 04:19:57 INFO - 'TMOUT': '86400', 04:19:57 INFO - 'USER': 'cltbld', 04:19:57 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:57 INFO - '_': '/tools/buildbot/bin/python'} 04:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:19:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:19:59 INFO - Installing collected packages: mozsystemmonitor 04:19:59 INFO - Running setup.py install for mozsystemmonitor 04:19:59 INFO - Successfully installed mozsystemmonitor 04:19:59 INFO - Cleaning up... 04:19:59 INFO - Return code: 0 04:19:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19:59 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')]} 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:59 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')]} 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:59 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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:19:59 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 04:19:59 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 04:19:59 INFO - Using env: {'DISPLAY': ':0', 04:19:59 INFO - 'HOME': '/home/cltbld', 04:19:59 INFO - 'LANG': 'en_US.UTF-8', 04:19:59 INFO - 'LANGUAGE': 'en_US:en', 04:19:59 INFO - 'LOGNAME': 'cltbld', 04:19:59 INFO - 'MAIL': '/var/mail/cltbld', 04:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:59 INFO - 'MOZ_NO_REMOTE': '1', 04:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:59 INFO - 'NO_EM_RESTART': '1', 04:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:59 INFO - 'PWD': '/builds/slave/test', 04:19:59 INFO - 'SHELL': '/bin/bash', 04:19:59 INFO - 'SHLVL': '1', 04:19:59 INFO - 'TERM': 'linux', 04:19:59 INFO - 'TMOUT': '86400', 04:19:59 INFO - 'USER': 'cltbld', 04:19:59 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:59 INFO - '_': '/tools/buildbot/bin/python'} 04:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:59 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 04:19:59 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 04:19:59 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 04:19:59 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 04:19:59 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 04:19:59 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 04:20:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:01 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 04:20:01 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 04:20:01 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 04:20:01 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 04:20:01 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 04:20:01 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 04:20:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:02 INFO - Downloading docopt-0.6.1.tar.gz 04:20:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:02 INFO - Running setup.py install for blobuploader 04:20:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:02 INFO - Running setup.py install for requests 04:20:02 INFO - Running setup.py install for docopt 04:20:02 INFO - Successfully installed blobuploader requests docopt 04:20:02 INFO - Cleaning up... 04:20:02 INFO - Return code: 0 04:20:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:02 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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:20:02 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 04:20:02 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 04:20:02 INFO - Using env: {'DISPLAY': ':0', 04:20:02 INFO - 'HOME': '/home/cltbld', 04:20:02 INFO - 'LANG': 'en_US.UTF-8', 04:20:02 INFO - 'LANGUAGE': 'en_US:en', 04:20:02 INFO - 'LOGNAME': 'cltbld', 04:20:02 INFO - 'MAIL': '/var/mail/cltbld', 04:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:02 INFO - 'MOZ_NO_REMOTE': '1', 04:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:02 INFO - 'NO_EM_RESTART': '1', 04:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:02 INFO - 'PWD': '/builds/slave/test', 04:20:02 INFO - 'SHELL': '/bin/bash', 04:20:02 INFO - 'SHLVL': '1', 04:20:02 INFO - 'TERM': 'linux', 04:20:02 INFO - 'TMOUT': '86400', 04:20:02 INFO - 'USER': 'cltbld', 04:20:02 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:02 INFO - '_': '/tools/buildbot/bin/python'} 04:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:03 INFO - Running setup.py (path:/tmp/pip-NnZfzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:03 INFO - Running setup.py (path:/tmp/pip-y4DEI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:03 INFO - Running setup.py (path:/tmp/pip-fTYm_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:03 INFO - Running setup.py (path:/tmp/pip-zLBZrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:03 INFO - Running setup.py (path:/tmp/pip-P2OUr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:03 INFO - Running setup.py (path:/tmp/pip-i4RWHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:03 INFO - Running setup.py (path:/tmp/pip-ghHfbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:03 INFO - Running setup.py (path:/tmp/pip-qdQguM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:03 INFO - Running setup.py (path:/tmp/pip-SpekQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:03 INFO - Running setup.py (path:/tmp/pip-wk_KYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:03 INFO - Running setup.py (path:/tmp/pip-eY1Nc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:03 INFO - Running setup.py (path:/tmp/pip-0kZAtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:03 INFO - Running setup.py (path:/tmp/pip-S18x79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:04 INFO - Running setup.py (path:/tmp/pip-vZg1n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:04 INFO - Running setup.py (path:/tmp/pip-A1nMNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:04 INFO - Running setup.py (path:/tmp/pip-ZUBfeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:04 INFO - Running setup.py (path:/tmp/pip-HZpDXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:04 INFO - Running setup.py install for manifestparser 04:20:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozcrash 04:20:04 INFO - Running setup.py install for mozdebug 04:20:04 INFO - Running setup.py install for mozdevice 04:20:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozfile 04:20:04 INFO - Running setup.py install for mozhttpd 04:20:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozinfo 04:20:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozInstall 04:20:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Running setup.py install for mozleak 04:20:05 INFO - Running setup.py install for mozlog 04:20:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Running setup.py install for moznetwork 04:20:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Running setup.py install for mozprocess 04:20:05 INFO - Running setup.py install for mozprofile 04:20:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Running setup.py install for mozrunner 04:20:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Running setup.py install for mozscreenshot 04:20:05 INFO - Running setup.py install for moztest 04:20:05 INFO - Running setup.py install for mozversion 04:20:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:06 INFO - Cleaning up... 04:20:06 INFO - Return code: 0 04:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', '-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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:20:06 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 04:20:06 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 04:20:06 INFO - Using env: {'DISPLAY': ':0', 04:20:06 INFO - 'HOME': '/home/cltbld', 04:20:06 INFO - 'LANG': 'en_US.UTF-8', 04:20:06 INFO - 'LANGUAGE': 'en_US:en', 04:20:06 INFO - 'LOGNAME': 'cltbld', 04:20:06 INFO - 'MAIL': '/var/mail/cltbld', 04:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:06 INFO - 'MOZ_NO_REMOTE': '1', 04:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:06 INFO - 'NO_EM_RESTART': '1', 04:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:06 INFO - 'PWD': '/builds/slave/test', 04:20:06 INFO - 'SHELL': '/bin/bash', 04:20:06 INFO - 'SHLVL': '1', 04:20:06 INFO - 'TERM': 'linux', 04:20:06 INFO - 'TMOUT': '86400', 04:20:06 INFO - 'USER': 'cltbld', 04:20:06 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:06 INFO - '_': '/tools/buildbot/bin/python'} 04:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:06 INFO - Running setup.py (path:/tmp/pip-2KCrn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:06 INFO - Running setup.py (path:/tmp/pip-dlw6c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:06 INFO - Running setup.py (path:/tmp/pip-c_bajl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:06 INFO - Running setup.py (path:/tmp/pip-ztvGJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:06 INFO - Running setup.py (path:/tmp/pip-C1Z_7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:06 INFO - Running setup.py (path:/tmp/pip-TjR62C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:06 INFO - Running setup.py (path:/tmp/pip-7DZK45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:06 INFO - Running setup.py (path:/tmp/pip-7qmKes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:06 INFO - Running setup.py (path:/tmp/pip-nIPXti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:06 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)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:06 INFO - Running setup.py (path:/tmp/pip-8quJ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:07 INFO - Running setup.py (path:/tmp/pip-mx5oKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:07 INFO - Running setup.py (path:/tmp/pip-9OMH6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:07 INFO - Running setup.py (path:/tmp/pip-X6AclU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:07 INFO - Running setup.py (path:/tmp/pip-eozf42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:07 INFO - Running setup.py (path:/tmp/pip-hOMLoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:07 INFO - Running setup.py (path:/tmp/pip-wP4yXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:07 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)) 04:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:07 INFO - Running setup.py (path:/tmp/pip-NxlnAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:07 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)) 04:20:07 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)) 04:20:07 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)) 04:20:07 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)) 04:20:07 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)) 04:20:07 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)) 04:20:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:09 INFO - Downloading blessings-1.5.1.tar.gz 04:20:09 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 04:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:09 INFO - Installing collected packages: blessings 04:20:09 INFO - Running setup.py install for blessings 04:20:09 INFO - Successfully installed blessings 04:20:09 INFO - Cleaning up... 04:20:09 INFO - Return code: 0 04:20:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:09 INFO - Reading from file tmpfile_stdout 04:20:09 INFO - Current package versions: 04:20:09 INFO - argparse == 1.2.1 04:20:09 INFO - blessings == 1.5.1 04:20:09 INFO - blobuploader == 1.2.4 04:20:09 INFO - docopt == 0.6.1 04:20:09 INFO - manifestparser == 1.1 04:20:09 INFO - mozInstall == 1.12 04:20:09 INFO - mozcrash == 0.16 04:20:09 INFO - mozdebug == 0.1 04:20:09 INFO - mozdevice == 0.47 04:20:09 INFO - mozfile == 1.2 04:20:09 INFO - mozhttpd == 0.7 04:20:09 INFO - mozinfo == 0.9 04:20:09 INFO - mozleak == 0.1 04:20:09 INFO - mozlog == 3.1 04:20:09 INFO - moznetwork == 0.27 04:20:09 INFO - mozprocess == 0.22 04:20:09 INFO - mozprofile == 0.27 04:20:09 INFO - mozrunner == 6.11 04:20:09 INFO - mozscreenshot == 0.1 04:20:09 INFO - mozsystemmonitor == 0.0 04:20:09 INFO - moztest == 0.7 04:20:09 INFO - mozversion == 1.4 04:20:09 INFO - psutil == 3.1.1 04:20:09 INFO - requests == 1.2.3 04:20:09 INFO - wsgiref == 0.1.2 04:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', '-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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:20:09 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 04:20:09 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 04:20:09 INFO - Using env: {'DISPLAY': ':0', 04:20:09 INFO - 'HOME': '/home/cltbld', 04:20:09 INFO - 'LANG': 'en_US.UTF-8', 04:20:09 INFO - 'LANGUAGE': 'en_US:en', 04:20:09 INFO - 'LOGNAME': 'cltbld', 04:20:09 INFO - 'MAIL': '/var/mail/cltbld', 04:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:09 INFO - 'MOZ_NO_REMOTE': '1', 04:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:09 INFO - 'NO_EM_RESTART': '1', 04:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:09 INFO - 'PWD': '/builds/slave/test', 04:20:09 INFO - 'SHELL': '/bin/bash', 04:20:09 INFO - 'SHLVL': '1', 04:20:09 INFO - 'TERM': 'linux', 04:20:09 INFO - 'TMOUT': '86400', 04:20:09 INFO - 'USER': 'cltbld', 04:20:09 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:09 INFO - '_': '/tools/buildbot/bin/python'} 04:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 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)) 04:20:10 INFO - Cleaning up... 04:20:10 INFO - Return code: 0 04:20:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:10 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')]} 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:10 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')]} 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:10 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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:20:10 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 04:20:10 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 04:20:10 INFO - Using env: {'DISPLAY': ':0', 04:20:10 INFO - 'HOME': '/home/cltbld', 04:20:10 INFO - 'LANG': 'en_US.UTF-8', 04:20:10 INFO - 'LANGUAGE': 'en_US:en', 04:20:10 INFO - 'LOGNAME': 'cltbld', 04:20:10 INFO - 'MAIL': '/var/mail/cltbld', 04:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:10 INFO - 'MOZ_NO_REMOTE': '1', 04:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:10 INFO - 'NO_EM_RESTART': '1', 04:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:10 INFO - 'PWD': '/builds/slave/test', 04:20:10 INFO - 'SHELL': '/bin/bash', 04:20:10 INFO - 'SHLVL': '1', 04:20:10 INFO - 'TERM': 'linux', 04:20:10 INFO - 'TMOUT': '86400', 04:20:10 INFO - 'USER': 'cltbld', 04:20:10 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:10 INFO - '_': '/tools/buildbot/bin/python'} 04:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:10 INFO - Downloading/unpacking jsonschema 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:11 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 04:20:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:12 INFO - warning: no files found matching '*.txt' 04:20:12 INFO - no previously-included directories found matching 'build' 04:20:12 INFO - no previously-included directories found matching 'dist' 04:20:12 INFO - no previously-included directories found matching '.git*' 04:20:12 INFO - Installing collected packages: jsonschema, functools32 04:20:12 INFO - Running setup.py install for functools32 04:20:12 INFO - warning: no files found matching '*.txt' 04:20:12 INFO - no previously-included directories found matching 'build' 04:20:12 INFO - no previously-included directories found matching 'dist' 04:20:12 INFO - no previously-included directories found matching '.git*' 04:20:12 INFO - Successfully installed jsonschema functools32 04:20:12 INFO - Cleaning up... 04:20:12 INFO - Return code: 0 04:20:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:12 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 0x7ff04ea78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', '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 04:20:12 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 04:20:12 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 04:20:12 INFO - Using env: {'DISPLAY': ':0', 04:20:12 INFO - 'HOME': '/home/cltbld', 04:20:12 INFO - 'LANG': 'en_US.UTF-8', 04:20:12 INFO - 'LANGUAGE': 'en_US:en', 04:20:12 INFO - 'LOGNAME': 'cltbld', 04:20:12 INFO - 'MAIL': '/var/mail/cltbld', 04:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:12 INFO - 'MOZ_NO_REMOTE': '1', 04:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:12 INFO - 'NO_EM_RESTART': '1', 04:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:12 INFO - 'PWD': '/builds/slave/test', 04:20:12 INFO - 'SHELL': '/bin/bash', 04:20:12 INFO - 'SHLVL': '1', 04:20:12 INFO - 'TERM': 'linux', 04:20:12 INFO - 'TMOUT': '86400', 04:20:12 INFO - 'USER': 'cltbld', 04:20:12 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:12 INFO - '_': '/tools/buildbot/bin/python'} 04:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:12 INFO - Downloading/unpacking flake8 04:20:12 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 04:20:12 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 04:20:12 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 04:20:12 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 04:20:12 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 04:20:12 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 04:20:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:14 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 04:20:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:14 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 04:20:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 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 04:20:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:14 INFO - no previously-included directories found matching 'docs/_build' 04:20:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:15 INFO - Running setup.py install for pep8 04:20:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:15 INFO - no previously-included directories found matching 'docs/_build' 04:20:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:15 INFO - Cleaning up... 04:20:15 INFO - Return code: 0 04:20:15 INFO - Running post-action listener: _resource_record_post_action 04:20:15 INFO - Running post-action listener: _start_resource_monitoring 04:20:15 INFO - Starting resource monitoring. 04:20:15 INFO - ##### 04:20:15 INFO - ##### Running install step. 04:20:15 INFO - ##### 04:20:15 INFO - Running pre-action listener: _resource_record_pre_action 04:20:15 INFO - Running main action method: install 04:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:15 INFO - Reading from file tmpfile_stdout 04:20:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:15 INFO - Reading from file tmpfile_stdout 04:20:15 INFO - Output received: 04:20:15 INFO - Usage: mozinstall [options] installer 04:20:15 INFO - Options: 04:20:15 INFO - -h, --help show this help message and exit 04:20:15 INFO - -d DEST, --destination=DEST 04:20:15 INFO - Directory to install application into. [default: 04:20:15 INFO - "/builds/slave/test"] 04:20:15 INFO - --app=APP Application being installed. [default: firefox] 04:20:15 INFO - mkdir: /builds/slave/test/build/application 04:20:15 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'] 04:20:15 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 04:20:31 INFO - Reading from file tmpfile_stdout 04:20:31 INFO - Output received: 04:20:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:31 INFO - Running post-action listener: _resource_record_post_action 04:20:31 INFO - ##### 04:20:31 INFO - ##### Running run-tests step. 04:20:31 INFO - ##### 04:20:31 INFO - Running pre-action listener: _resource_record_pre_action 04:20:31 INFO - Running main action method: run_tests 04:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:31 INFO - Python 2.7.3 04:20:31 INFO - Return code: 0 04:20:31 INFO - grabbing minidump binary from tooltool 04:20:31 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')]} 04:20:31 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 0x241b0b0>, '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 0x241bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:31 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 04:20:31 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 04:20:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:31 INFO - Return code: 0 04:20:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:32 INFO - Return code: 0 04:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 04:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 04:20:32 INFO - Using env: {'DISPLAY': ':0', 04:20:32 INFO - 'HOME': '/home/cltbld', 04:20:32 INFO - 'LANG': 'en_US.UTF-8', 04:20:32 INFO - 'LANGUAGE': 'en_US:en', 04:20:32 INFO - 'LOGNAME': 'cltbld', 04:20:32 INFO - 'MAIL': '/var/mail/cltbld', 04:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:32 INFO - 'MOZ_NO_REMOTE': '1', 04:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:32 INFO - 'NO_EM_RESTART': '1', 04:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:32 INFO - 'PWD': '/builds/slave/test', 04:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:32 INFO - 'SHELL': '/bin/bash', 04:20:32 INFO - 'SHLVL': '1', 04:20:32 INFO - 'TERM': 'linux', 04:20:32 INFO - 'TMOUT': '86400', 04:20:32 INFO - 'USER': 'cltbld', 04:20:32 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519', 04:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:32 INFO - '_': '/tools/buildbot/bin/python'} 04:20:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 04:20:32 INFO - mozversion INFO | application_buildid: 20151217030552 04:20:32 INFO - mozversion INFO | application_changeset: 44861df2f79ee7929ee08f1cdf1ce5a13f1b314f 04:20:32 INFO - mozversion INFO | application_display_name: Nightly 04:20:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:32 INFO - mozversion INFO | application_name: Firefox 04:20:32 INFO - mozversion INFO | application_remotingname: firefox 04:20:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:20:32 INFO - mozversion INFO | application_vendor: Mozilla 04:20:32 INFO - mozversion INFO | application_version: 46.0a1 04:20:32 INFO - mozversion INFO | platform_buildid: 20151217030552 04:20:32 INFO - mozversion INFO | platform_changeset: 44861df2f79ee7929ee08f1cdf1ce5a13f1b314f 04:20:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:20:32 INFO - mozversion INFO | platform_version: 46.0a1 04:20:32 INFO - 2015-12-17 04:20:32,243 DEBUG : using testdate: 1450354832 04:20:32 INFO - 2015-12-17 04:20:32,243 DEBUG : actual date: 1450354832 04:20:32 INFO - 2015-12-17 04:20:32,252 INFO : starting webserver on 'localhost:40096' 04:20:32 INFO - 2015-12-17 04:20:32,253 INFO : Starting test suite talos-linux64-ix-022 04:20:32 INFO - 2015-12-17 04:20:32,253 INFO : Starting test dromaeo_css 04:20:32 INFO - 2015-12-17 04:20:32,253 DEBUG : operating with platform_type : linux_ 04:20:32 INFO - 2015-12-17 04:20:32,254 INFO : Initialising browser for dromaeo_css test... 04:20:32 INFO - 2015-12-17 04:20:32,268 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprptVps/profile http://localhost:40096/getInfo.html 04:20:37 INFO - 2015-12-17 04:20:37,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:20:37 INFO - 2015-12-17 04:20:37,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:20:37 INFO - 2015-12-17 04:20:37,053 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:20:37 INFO - 2015-12-17 04:20:37,053 DEBUG : BROWSER_OUTPUT: __metrics 04:20:37 INFO - 2015-12-17 04:20:37,154 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] 04:20:37 INFO - 2015-12-17 04:20:37,215 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:20:38 INFO - 2015-12-17 04:20:38,189 INFO : Browser initialized. 04:20:38 INFO - 2015-12-17 04:20:38,189 INFO : Running cycle 1/1 for dromaeo_css test... 04:20:38 INFO - 2015-12-17 04:20:38,190 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprptVps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:20:50 INFO - 2015-12-17 04:20:50,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 150044672 04:20:50 INFO - 2015-12-17 04:20:50,151 DEBUG : BROWSER_OUTPUT: 04:21:41 INFO - 2015-12-17 04:21:41,718 DEBUG : BROWSER_OUTPUT: 1450354901711 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] 04:23:54 INFO - 2015-12-17 04:23:54,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40096/tests/dromaeo/cssquery-ext.html) 04:23:55 INFO - 2015-12-17 04:23:55,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 252121088 04:23:55 INFO - 2015-12-17 04:23:55,104 DEBUG : BROWSER_OUTPUT: 04:26:57 INFO - 2015-12-17 04:26:57,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-ext.html (next: http://localhost:40096/tests/dromaeo/cssquery-jquery.html) 04:26:58 INFO - 2015-12-17 04:26:58,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 228511744 04:26:58 INFO - 2015-12-17 04:26:58,092 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-17 04:30:00,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40096/tests/dromaeo/cssquery-mootools.html) 04:30:00 INFO - 2015-12-17 04:30:00,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 222552064 04:30:00 INFO - 2015-12-17 04:30:00,883 DEBUG : BROWSER_OUTPUT: 04:33:02 INFO - 2015-12-17 04:33:02,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40096/tests/dromaeo/cssquery-prototype.html) 04:33:03 INFO - 2015-12-17 04:33:03,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 213315584 04:33:03 INFO - 2015-12-17 04:33:03,380 DEBUG : BROWSER_OUTPUT: 04:36:06 INFO - 2015-12-17 04:36:06,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40096/tests/dromaeo/cssquery-yui.html) 04:36:06 INFO - 2015-12-17 04:36:06,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 215044096 04:36:06 INFO - 2015-12-17 04:36:06,846 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-yui.html (next: http://localhost:40096/tests/dromaeo/cssquery-dojo.html) 04:39:09 INFO - 2015-12-17 04:39:09,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 257667072 04:39:09 INFO - 2015-12-17 04:39:09,533 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:39:09 INFO - 2015-12-17 04:39:09,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:39:09 INFO - 2015-12-17 04:39:09,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:39:09 INFO - 2015-12-17 04:39:09,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:39:09 INFO - 2015-12-17 04:39:09,536 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2609.843409395436;2699.0688212566656;2701.959470607941;2714.2535802654265;2714.78281737461;4525.547445255473;4671.74305413203;4719.150552900481;4724.126036683212;4733.4793172751015;4579.908401831962;4588.816447342102;4651.720896746189;4688.109259240742;4710.2228132358205;4353.0205703716565;4385.320275357325;4406.669499787521;4492.258777301741;4506.954930450703;4197.8530751423705;4417.801198946056;4440.955590444103;4508.594226519613;4534.274516077428;4278.700490965633;4283.250431174532;4333.371661109153;4348.130373925196;4385.846495372647;4301.268784306644;4341.175176716414;4350.390945267665;4387.692861499696;4389.604935555783;4124.4019617155345;4334.1981733379425;4349.9130017399475;4364.803583838703;4389.31965545341;4546.090781843644;4548.840790572314;4550.817967281305;4638.373819534353;4689.320048592969;5132.435432102466;5134.691918484866;5139.820106296299;5143.074246635604;5169.922451163236;4829.975850120762;5153.2785410042625;5155.32980712505;5156.432792392834;5173.689578625294;4617.399738034068;4624.26011838111;4652.720836749738;4712.6229901607785;4781;5231.921521177185;5247.658902171346;5254.054270231395;5265.815696450606;5330.360356757214;4751.501092385319;5043.445221025684;5045.167547354718;5049.899002019939;5106;4866.245731911559;4950.331705219821;4973.850784476472;5050.84847454577;5067.569256613156;4946.431160416526;4957.752112394438;4958.107540642719;4958.925616115761;4993.1262029144755;4902.681325713817;4909.729964851896;4925.655204135676;4931.211006238985;4971.502849715;4019.8392064317686;4064.1262128641893;4071.755694658271;4108.055147316134;4171.791410429466;3676.5220521332058;3687.9262414751556;3694.058015206105;3707;3720.925581488409;4330.7401555906745;4337.327714204303;4339;4370.54109318517;4378.387025816388;4795.160846851787;4907.018596280686;4921.0157968406465;4925.359703238556;5080.974595127001;4244.830206791694;4312.374705667723;4326.372675961968;4340.240457919851;4368.694191406635;4497.617702495325;4505.864824055284;4510.075434535912;4550.47669518003;4598.839040633562;4580.748058856661;4690;4818.734969576567;4821.63837712166;4833.637477189225;4967.875803104951;4974.278729584263;5073.985202959349;5086.745662716923;5103.617228707936;4828.251620998611;4829.7585120744525;4840.346553215411;4847;4869.902601947871;4742.620590352833;5022.422421421583;5036.748162591783;5038.1183292924325;5082.491750824888;4994.525520075587;4995.275685025578;5030.647854650139;5078.08594453002;5128.230765385222;4955.1576232039915;5003.77483013258;5004.84985450437;5011;5060.974695126501;4723.456802467623;4995.15082435994;4999.250112483157;5001.474845141353;5006.674566153189;4693.812247510198;4702.177119004092;4719.976400118115;4785.353977213032;4827.372441582572;4930.890549626305;4957.429895561912;4957.429895562056;4961.1318019345745;4991.550760431579;4617.607503362117;4814.5907597854575;4828.2998965150555;4837.395325584302;4876.634252431153 04:39:09 INFO - 2015-12-17 04:39:09,536 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.9305283365997;580.0516156084801;587.1486344800041;592.8725324055328;602.4186659873221;26878.731212687868;27486.0379886704;32524.349513009725;32765.5085173722;32790.8360458198;38387.61612383875;39234.60765392345;39305.21389572214;39315.803420982855;39333.80333098338;6946.826329341781;7843.294103530681;8017.198280171965;8022.438429309951;8030.5181689098545;7089.22018577956;7157.3916217121605;7200.963995180016;10059.899401005969;10349.793004139912;10007.349522281065;10017.348872323311;10087.344322619007;10140.340877842953;10150.3402278852;9909.355891867006;10050.396976181453;10064.446455444948;10106.696799095966;10119.797604047877;7171.497995140342;7370.152432470281;10093.545790439448;10379.636712715093;10397.740056498573;36359.27281454356;36720.63279367199;36721.449178262345;36739.26521469556;36813.07967300812;2700.729927007303;2768.9723102769117;2813.6153567404085;3162.7153556179824;3314.4034073866696;28531.017369727047;29160;29286.41427171466;29352.559711604343;29501.40997180066;3405.6934875861043;3488.1105318143964;3495.982520087409;3536.7701099428455;3607.6753092221566;213721;213907;215763;215907;216517;50439;54502.45497545053;55086.9999999992;55102.72448637731;55119.448805512235;44114.338284925754;62753.68623156855;64021.679891600244;64065.67967160134;64095;11908.345041022827;12099;12114.939425302993;12115.273083615011;12146.817797733042;8978.595963181673;9043.683471078612;9045.819083618291;9055.456672599665;9056.275497960147;18463.446096617125;18564.44306670802;18593.628127437376;18613.534661633566;18613.81386186148;7095.687297849811;7268.418526517866;7333.2666733327305;7364.374028207662;7414.592197429085;885.7741275974586;929.6095639831287;941.868138460616;966.5747071288611;1025.5692609104194;25903.611445828326;26127.608085878728;26550.336241594116;26623;26725.599116013276;855.2302927365297;864.1401805203863;882.2148288023664;934.8924873639619;1023.976023976024;13424.395902184426;13636.250006249751;13671.453141874412;13929.164250145024;13937.790933136012;268654;274328;275667;275792;276638;45512.77243613761;45606.54393456089;45649;45668.54331456709;45684.77157614191;1204.7349583091707;1219.0928075517943;1229.0843321725372;1233.3524899427694;1236.017366193878;24644.630330544696;25697.229083127535;26271.211863644123;26283.868580656974;26288.737112628627;36142.277154456235;39745.60254397535;40132.59867401289;40159.79920100381;40207.798961005006;174519;243175;248429;248804;248930;24528.386790330384;24846.50306993814;24922.750772492043;24929.127480538093;24942.87528562418;32781;33053.17367065843;33418.66581334253;33586;39437.21125577415;30986.690133098382;31276.218094547818;31548;32006;32255.677443225268;31542.369152617277;38335.80832095822;40405.393919090646;41078.79460602797;43012;34300.828495857364;34945.65054349424;35337.64662353446;35459.468107978915;37719.622803771614;35248.64751352556;36051.459228111074;36511.81744091262;36672.449913251854;36909.446358305184;28335.43329133447;28420.289492762848;28866;29084.7091529082;29255.122346329645 04:39:09 INFO - 2015-12-17 04:39:09,537 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.6456309467323;329.89773170317187;332.97835640683354;335.6576292181973;336.5238187964031;12374.628761137157;12884.291363975;14463.566093017213;14972.32624531896;15250.313735881884;11760.823587646171;14489.565313040626;15104.320305586247;15559.29983150758;15589.766153507706;4729.385179926613;4739.0758802033615;4833.347498087766;4926.285688575154;4951.702897826142;3632.273545290939;3726.7577607455564;4931.926021109686;4968.031233909389;5562;5784.074548072309;5785.913211301834;5801.7389217485315;5817.62185457946;5821.214136091637;5608.9439105609035;5733.283339582552;5743.597948143632;5744.080947048452;5755.82732518023;5030.647854650176;5035.29505869175;5039.848804535834;5041.092603331399;5045.949540504585;18553.443396697985;18588.44234672962;18867.150978205875;18909.7163542547;19131.33040343581;1881.9811801882079;1947.8441724661993;1968.271739456396;1969.7045443183495;2069.6067747128;8034.9598252008955;8160.795980100485;8363;8430.32557395407;9765;1721.148031724292;1730.524105870883;1799.6490684316564;1812.3656720147974;1906.161289032835;54549.1817622736;57211;57402.85194296132;57786;58751.70624146895;9232.7691807704;9400.576974036185;9549.427034377959;9609.423434593808;9688.90311096894;12113.454894529767;12206.75586488283;12210.26738395699;12210.328431936152;12223.755524889453;6574.112494813139;6581.835454113685;6607.900881486781;6609.537332386687;6614.173228346457;6119.296280927751;6120.969395152996;6174.536909731788;6190.164327815687;6194.256689197326;3943.4873466449176;4001.55982841893;4009.218202450494;4019.256437559061;4056.350983842571;1593.6015996001;1626.6502701919144;1636.4354297767488;1667.1914121650989;1730.3165249726287;818.108261994429;823.995880020596;836.786619412046;945.6028468043438;984.871966644346;14334.569962901129;14459.566213013626;15024.17367044823;15225.923870380577;15674.68650626981;767.7005967672612;843.4559708987669;874.2699845628844;911.6991392840347;948.6964171465203;8081.3130883874355;8623.827523449496;9026.503542305105;9210.907890921006;9481.620735170516;436028;457317;468569;477617;477760;71997.64001179961;72593.19991801039;72933.27066729264;73526;75681.24318756851;1056.8427571808857;1069.4866464097277;1071.7159952612565;1075.6396607136696;1094.3488624268389;14189.29053547298;14215.715685686435;14304;14462.927685361507;14624.634384140481;31677;32238.838805805823;33018.66981330156;33531.497027544116;33590.81659692112;41035.7948210257;41210.38184427296;41231;41455.37816932809;41500.1699966005;8154.83690326202;8539.359548034046;8772.29821614282;8775.210231079234;8775.341849361195;10041.598336066476;10159.339642923187;11537.769244615229;16094.356225750838;16296.429624963544;13300.733985320432;13449.260290684106;13509.392077356346;13668.726625467634;13867.23730194849;8731.170538798804;8941.37410381293;13191.67020824487;13443.596692099252;13483.460661573426;7832.608369581384;8054.556999364857;9173;9301.767455813659;9325.766855828388;13007;13133;13497.190168589916;13607.79588306196;13669.266146770487;13905.235212063433;13909.930450347683;14451.205183714997;14452.494162704255;14460.349284282443 04:39:09 INFO - 2015-12-17 04:39:09,539 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1250.8498980122386;1596.5769071196135;1667.0497816244738;1671.0725547321235;1682.2177687375377;6284.151639528663;6964.860702785948;7172.21105678375;7174.677139528727;7198.640067996593;7117.7864664060035;7233;7262.891056634155;7274.3816775574005;7284.307990740871;2078.5842831433697;2108.3569511299047;2109.0298462707174;2112.9260475883348;2115.079940225999;2074.4191626344646;2096.7693553709078;2124.91500339987;2136.9893150534226;2137.732783402075;2051.046263487478;2057.567910738747;2058.969115463269;2085.35354040248;2088.812006919377;2024.6355655981918;2057.269669267411;2058.7941205879442;2059.608674351883;2061.072517367191;2042.2647846775149;2071.8135367816817;2091.4144039668918;2094.2356040045424;2097.035363732685;7224.385927196142;7325;7326.96336518314;7330.303621155982;7330.67011984462;4101.815418306153;4176.770277634729;4189.07840275139;4196.622303992624;4198.097409057037;2654.5089158505543;2669.3460102275067;2707.323169207698;2708.471847989643;2720.319920019995;889.5596679643618;892.1390857822167;900.8379190843804;910.0626354854511;928.0626567167142;9543.236541076698;9570.856437153448;9586.233101351874;9586.424814511081;9597.616095356178;3682.0794801299676;3701.7408781385584;3765.8870233893026;3806.600306967784;3811.0472381904524;8329.708460203863;8338.458000229966;8346.081930987586;8347.707830225912;8368.456050356708;4146.170765846843;4152.43942067823;4163.854265100707;4171.666266698657;4174.728642638219;3184.3153721949893;3284.293876816496;3689.0961714379614;3808.4858544096746;3820.0449887528116;3474.635163307816;3480.547528821237;3482.3035392921515;3495.4582039783872;3530.8411121499594;1104.2435931387026;1110.722319420145;1112.3770688414513;1114.8104822180248;1121.1815374776459;1175.4651633506735;1185.4132204558798;1190.892819646236;1203.181836351272;1205.1684337806885;6657.866842663119;6713.530052896251;6719.596824190564;6726.3609957054005;6754.696038678271;411.65626701703815;414.2729509710439;414.66619371405704;416.25905887520264;416.8520175337772;5321.627486075938;5349.652272602269;5357.946420535744;5360.70516121617;5362.383325917492;8635.266002389742;8659.523726194993;8659.696910608098;8833.293336533063;8846.46921184731;8658.740237792876;8733.432326898732;8734.0829212933;8740.213380795632;8752.124787521198;6701.128853249046;6769.966150169218;6831.351021652935;6869.450443964471;6891.3797758202;6546.24718157418;6548.116004339353;6551.246606640298;6561.212654481493;6561.475081993524;7665.731699390494;7705;7764.61176941162;7845.529268243924;7919.16848730898;7819.100803407681;7963.402744794048;7980.441369104107;8089.393295502743;8093.271605555528;5566.610337276352;5698.031334673033;5700.543956483554;5885;5938.435848594377;6034.762873610812;6711.530192886451;6713.6307503085845;6720.966395167993;6734.3602357775935;6378.2346118466085;6660.101870966945;6693.966530167318;6717.798466046026;6761.019652150312;6411.4229719325485;6450.258220304538;6494.935050649433;6514.609123452608;6609.173853268341;6541.476681865534;6561;6566.24488183865;6584.736610535525;6586.80239592813;5608.831735047955;5710.885782284414;5753.568482363756;6051.909221361595;6083.209182806384;6157.199564056823;6180.81457556274;6196.0705894116245;6201.0388389799655;6207.255129384503 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.7374363073235;296.06148509225767;299.7317400926171;302.93184033592445;307.16298087710993;5286.101362768334;5292.417834038252;5375.354957405112;5433.48381903719;5435.592330575203;5188.974055129719;5320.9467905320935;5344.599155063376;5350.946490535093;5354.116570765819;4157.584241575849;4159.729617574863;4165.645920096796;4166.395872598471;4167.187398457309;3945.842166313344;4025.5974402559805;4058.69559783016;4136.069384388518;4139.19285739281;4095.221907837516;4105.4252404663375;4115.403266526352;4119.155573107506;4120.835166593348;4106.958930410688;4112.568180341051;4112.732672376301;4115.218108559364;4132.752034877917;3630.1287690954246;3630.6550877666577;3632.7275454340765;3635.0367152704553;3642.1440961374055;5041.924371134436;5149.510796474329;5151.793928242866;5171.689698618095;5207.973960130175;4821.300911367832;4828.927566086511;4829.903401931977;4831.251156070814;4838;5706.3722990471015;5717.571182161313;5718.656880587137;5720.513756330717;5721.4850663440075;3782.9432558511644;3887.941680874789;3899.1421887184774;3981.442598036277;4013.97993010036;5849.473547380713;5851.23933888596;5904.232449781501;5916.497097746696;5927.525797936111;4142.026623743418;4143.005678637105;4143.274926887842;4144.585541445831;4145.274576949022;4206.747595144301;4210.768407737603;4213.262679031157;4213.283741763847;4215.051613387025;4591.1965406053805;4745.264484004984;4774.092922344744;4776.904461910812;4779;5641.294838145232;5642.802501912413;5651.8304450866535;5658.886822263614;5660.377358490563;1449.6593300574357;1449.8187726534184;1450.0719539494733;1452.3899962015978;1461.5396150212648;972.2610815779917;994.751312171957;1014.9086582207636;1018.4805749068029;1039.0285083447002;4910.410750709938;4913.557779799835;4915.58217551505;4916.803327866845;4921.926171107436;5855.59010869235;5859.882802344015;5863.765449382062;5864.794732184353;5870.031444811559;4879.902401951941;4888.853334399973;4890.217565189552;4897.99591083827;4901.950980490221;3070.217094640897;3128.9374212515622;3130.029690795815;3158.6841315868687;3170.619525656936;5543.667379957215;5593.552515798727;5598.44015598445;5608.523275521545;5612.550995920316;6071.362506936708;6074.787382441594;6086.360932102154;6086.817395478142;6087.878242435127;5573.191887176336;5592.916106258409;5605.439456054362;5612.214289999403;5612.97193514038;5700.857478563069;5914.733836977261;5925.9407405925385;5932.347441781487;5941.287045554561;5569.637973531708;5582.553395728413;5691.743871525874;5789.56578256624;5821.476067153807;5569.972150139223;5570.86072848182;5600.971995139998;5611.38274789781;5615.298087739033;3986.980065099656;4019.0756126090578;4021.879343619696;4023.114914718757;4024.91327341622;5628.240187574625;5808.332041815245;5812.709364531841;5821.592488525763;5823.097419899922;5642.379338272704;5679.858003549944;5683.204351390891;5692.203091567101;5694.544436444991;5667.829965101054;5674.943250567441;5680.857978550569;5681.659100453986;5692.260006199168;5563.109902415594;5569.997400467954;5575.107982722745;5575.2473416088305;5576.749046293007;5538.861528461821;5653.180288858175;5658;5661.424052056387;5699.145128230799;5511.393746687781;5529.917051244154;5573.665580065209;5576.1356989666665;5578 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.979840604782;676.8916973284275;685.6366125953247;691.6023286610199;700.6391708270238;10443;10945.398003109825;10955.835662465059;10957.671269861918;10968.287061341018;11637.592684256053;11645.18483706141;11653.883461165386;11655.358955257458;11670.533178672864;634.5050860328951;642.7364780440021;776.957267350294;792.8652129138061;793.5595744361876;797.4099166616691;799.1369321133162;799.2886331165267;802.9598520074002;803.9035315762117;824.4599787139433;840.7603832907622;841.2891107014563;841.9410641255115;842.2083241752733;648.5200951296031;656.8259411256021;806.2260230179006;816.603947085663;817.5748610722451;610.3682688417466;610.8167549735061;611.8256296955346;611.8653896142841;612.6997771092133;10865.293755905841;11035.83446248307;11051.557937682483;11052.557897684082;11059.889401105966;10387.27289089764;10553.736156596147;10620.150387968944;10723.410212438313;10906.400147991857;8600.225979661798;8973.41672791273;9037.186653201177;9084.636614535411;9136.223421009223;3133.138386943586;3159.415508131003;3178.7298079663256;3181.8249996250197;3218.2115381731624;38328.80835595804;38357;38411.23177536461;38435.615643843485;39206.803965980274;8283.420160588701;8305.37709671765;8349.206825351583;8357.707480238285;8410.453320534145;14643.56069317922;14655.413783448543;14660.706785864437;14667.339969701388;14687;6089.634621922699;6239.438450539383;6324.462420694293;6369.20384951881;6402.391772781578;3373.1061268763797;3418.5897692277085;3447.6897079262985;3460.498227756961;3487.3897068013;2458.938526536851;2615.6468876701783;2673.4118493931305;2683.3023413912524;2691.744284292989;460.5486623109372;463.85852315044235;464.3916469425064;465.65308844910084;473.5879784587431;427.8203154675044;431.28191561051125;464.5633104881401;505.1992591742056;519.7583123847429;7521.962390188014;7567.394608431312;7575.053118360205;7651.4261430391825;7703.1911649277135;447.68438251032944;505.5197562315815;520.2872065270603;527.8522013836132;537.3632245788752;3237.6762323767434;3307.58655168104;3411.6076651184935;3510;3584.928301434009;48112.7594362033;48125.27812082822;50923.49076509262;51024;51083.23375149376;41417.378739318934;42090;42337.364939525934;42375;42492.150156997304;39256.80371598124;39270.21459570793;39358.60641393607;39514.2097158061;39674.2065158701;6916.965415172892;7202.135743710788;7346.33882950537;7370.262973702587;7370.262973702801;28713.42573148567;29280.41439171247;29772.255693607833;30002;30758.53862192024;36272.09319767027;36948.07629809276;37456.625433745314;37659;38434.2313153741;8592.183742544448;8947.642094316154;8996.595153218252;9446.669366572138;9510.809783804147;9473.052694730472;9487.66793162236;9544.761380965532;9548.809023819624;9685.6610018649;10045.849312260469;10191.235657325582;10203.591856325664;10210.234232432449;10214.438205898747;9066.682666106655;9329.440233586007;9476.431414115175;9519.286053545873;9539.809203815747;8562.57187140628;8700.390972631854;9835.606575737176;9874.654387096418;9983.650572229937;8783.341249406192;8812.823743524965;8857.291416686778;9099.636014559343;9314.394564353295;7871.606419679108;7905;8455.788605284917;8988.46069235848;9067.455952642598 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: __startTimestamp1450355949533__endTimestamp 04:39:09 INFO - 2015-12-17 04:39:09,540 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4652.24 Median:4751.50 stddev:492.97 (10.4%) stddev-sans-first:467.72 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: Values: 2609.8 2699.1 2702.0 2714.3 2714.8 4525.5 4671.7 4719.2 4724.1 4733.5 4579.9 4588.8 4651.7 4688.1 4710.2 4353.0 4385.3 4406.7 4492.3 4507.0 4197.9 4417.8 4441.0 4508.6 4534.3 4278.7 4283.3 4333.4 4348.1 4385.8 4301.3 4341.2 4350.4 4387.7 4389.6 4124.4 4334.2 4349.9 4364.8 4389.3 4546.1 4548.8 4550.8 4638.4 4689.3 5132.4 5134.7 5139.8 5143.1 5169.9 4830.0 5153.3 5155.3 5156.4 5173.7 4617.4 4624.3 4652.7 4712.6 4781.0 5231.9 5247.7 5254.1 5265.8 5330.4 4751.5 5043.4 5045.2 5049.9 5106.0 4866.2 4950.3 4973.9 5050.8 5067.6 4946.4 4957.8 4958.1 4958.9 4993.1 4902.7 4909.7 4925.7 4931.2 4971.5 4019.8 4064.1 4071.8 4108.1 4171.8 3676.5 3687.9 3694.1 3707.0 3720.9 4330.7 4337.3 4339.0 4370.5 4378.4 4795.2 4907.0 4921.0 4925.4 5081.0 4244.8 4312.4 4326.4 4340.2 4368.7 4497.6 4505.9 4510.1 4550.5 4598.8 4580.7 4690.0 4818.7 4821.6 4833.6 4967.9 4974.3 5074.0 5086.7 5103.6 4828.3 4829.8 4840.3 4847.0 4869.9 4742.6 5022.4 5036.7 5038.1 5082.5 4994.5 4995.3 5030.6 5078.1 5128.2 4955.2 5003.8 5004.8 5011.0 5061.0 4723.5 4995.2 4999.3 5001.5 5006.7 4693.8 4702.2 4720.0 4785.4 4827.4 4930.9 4957.4 4957.4 4961.1 4991.6 4617.6 4814.6 4828.3 4837.4 4876.6 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40421.31 Median:32785.92 stddev:63187.84 (192.7%) stddev-sans-first:63294.28 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: Values: 578.9 580.1 587.1 592.9 602.4 26878.7 27486.0 32524.3 32765.5 32790.8 38387.6 39234.6 39305.2 39315.8 39333.8 6946.8 7843.3 8017.2 8022.4 8030.5 7089.2 7157.4 7201.0 10059.9 10349.8 10007.3 10017.3 10087.3 10140.3 10150.3 9909.4 10050.4 10064.4 10106.7 10119.8 7171.5 7370.2 10093.5 10379.6 10397.7 36359.3 36720.6 36721.4 36739.3 36813.1 2700.7 2769.0 2813.6 3162.7 3314.4 28531.0 29160.0 29286.4 29352.6 29501.4 3405.7 3488.1 3496.0 3536.8 3607.7 213721.0 213907.0 215763.0 215907.0 216517.0 50439.0 54502.5 55087.0 55102.7 55119.4 44114.3 62753.7 64021.7 64065.7 64095.0 11908.3 12099.0 12114.9 12115.3 12146.8 8978.6 9043.7 9045.8 9055.5 9056.3 18463.4 18564.4 18593.6 18613.5 18613.8 7095.7 7268.4 7333.3 7364.4 7414.6 885.8 929.6 941.9 966.6 1025.6 25903.6 26127.6 26550.3 26623.0 26725.6 855.2 864.1 882.2 934.9 1024.0 13424.4 13636.3 13671.5 13929.2 13937.8 268654.0 274328.0 275667.0 275792.0 276638.0 45512.8 45606.5 45649.0 45668.5 45684.8 1204.7 1219.1 1229.1 1233.4 1236.0 24644.6 25697.2 26271.2 26283.9 26288.7 36142.3 39745.6 40132.6 40159.8 40207.8 174519.0 243175.0 248429.0 248804.0 248930.0 24528.4 24846.5 24922.8 24929.1 24942.9 32781.0 33053.2 33418.7 33586.0 39437.2 30986.7 31276.2 31548.0 32006.0 32255.7 31542.4 38335.8 40405.4 41078.8 43012.0 34300.8 34945.7 35337.6 35459.5 37719.6 35248.6 36051.5 36511.8 36672.4 36909.4 28335.4 28420.3 28866.0 29084.7 29255.1 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,542 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25499.01 Median:41123.09 stddev:75841.52 (184.4%) stddev-sans-first:76030.73 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: Values: 329.6 329.9 333.0 335.7 336.5 12374.6 12884.3 14463.6 14972.3 15250.3 11760.8 14489.6 15104.3 15559.3 15589.8 4729.4 4739.1 4833.3 4926.3 4951.7 3632.3 3726.8 4931.9 4968.0 5562.0 5784.1 5785.9 5801.7 5817.6 5821.2 5608.9 5733.3 5743.6 5744.1 5755.8 5030.6 5035.3 5039.8 5041.1 5045.9 18553.4 18588.4 18867.2 18909.7 19131.3 1882.0 1947.8 1968.3 1969.7 2069.6 8035.0 8160.8 8363.0 8430.3 9765.0 1721.1 1730.5 1799.6 1812.4 1906.2 54549.2 57211.0 57402.9 57786.0 58751.7 9232.8 9400.6 9549.4 9609.4 9688.9 12113.5 12206.8 12210.3 12210.3 12223.8 6574.1 6581.8 6607.9 6609.5 6614.2 6119.3 6121.0 6174.5 6190.2 6194.3 3943.5 4001.6 4009.2 4019.3 4056.4 1593.6 1626.7 1636.4 1667.2 1730.3 818.1 824.0 836.8 945.6 984.9 14334.6 14459.6 15024.2 15225.9 15674.7 767.7 843.5 874.3 911.7 948.7 8081.3 8623.8 9026.5 9210.9 9481.6 436028.0 457317.0 468569.0 477617.0 477760.0 71997.6 72593.2 72933.3 73526.0 75681.2 1056.8 1069.5 1071.7 1075.6 1094.3 14189.3 14215.7 14304.0 14462.9 14624.6 31677.0 32238.8 33018.7 33531.5 33590.8 41035.8 41210.4 41231.0 41455.4 41500.2 8154.8 8539.4 8772.3 8775.2 8775.3 10041.6 10159.3 11537.8 16094.4 16296.4 13300.7 13449.3 13509.4 13668.7 13867.2 8731.2 8941.4 13191.7 13443.6 13483.5 7832.6 8054.6 9173.0 9301.8 9325.8 13007.0 13133.0 13497.2 13607.8 13669.3 13905.2 13909.9 14451.2 14452.5 14460.3 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4988.83 Median:6120.20 stddev:2625.56 (42.9%) stddev-sans-first:2617.89 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: Values: 1250.8 1596.6 1667.0 1671.1 1682.2 6284.2 6964.9 7172.2 7174.7 7198.6 7117.8 7233.0 7262.9 7274.4 7284.3 2078.6 2108.4 2109.0 2112.9 2115.1 2074.4 2096.8 2124.9 2137.0 2137.7 2051.0 2057.6 2059.0 2085.4 2088.8 2024.6 2057.3 2058.8 2059.6 2061.1 2042.3 2071.8 2091.4 2094.2 2097.0 7224.4 7325.0 7327.0 7330.3 7330.7 4101.8 4176.8 4189.1 4196.6 4198.1 2654.5 2669.3 2707.3 2708.5 2720.3 889.6 892.1 900.8 910.1 928.1 9543.2 9570.9 9586.2 9586.4 9597.6 3682.1 3701.7 3765.9 3806.6 3811.0 8329.7 8338.5 8346.1 8347.7 8368.5 4146.2 4152.4 4163.9 4171.7 4174.7 3184.3 3284.3 3689.1 3808.5 3820.0 3474.6 3480.5 3482.3 3495.5 3530.8 1104.2 1110.7 1112.4 1114.8 1121.2 1175.5 1185.4 1190.9 1203.2 1205.2 6657.9 6713.5 6719.6 6726.4 6754.7 411.7 414.3 414.7 416.3 416.9 5321.6 5349.7 5357.9 5360.7 5362.4 8635.3 8659.5 8659.7 8833.3 8846.5 8658.7 8733.4 8734.1 8740.2 8752.1 6701.1 6770.0 6831.4 6869.5 6891.4 6546.2 6548.1 6551.2 6561.2 6561.5 7665.7 7705.0 7764.6 7845.5 7919.2 7819.1 7963.4 7980.4 8089.4 8093.3 5566.6 5698.0 5700.5 5885.0 5938.4 6034.8 6711.5 6713.6 6721.0 6734.4 6378.2 6660.1 6694.0 6717.8 6761.0 6411.4 6450.3 6494.9 6514.6 6609.2 6541.5 6561.0 6566.2 6584.7 6586.8 5608.8 5710.9 5753.6 6051.9 6083.2 6157.2 6180.8 6196.1 6201.0 6207.3 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4692.17 Median:5306.68 stddev:1380.10 (26.0%) stddev-sans-first:1343.87 04:39:09 INFO - 2015-12-17 04:39:09,544 DEBUG : BROWSER_OUTPUT: Values: 291.7 296.1 299.7 302.9 307.2 5286.1 5292.4 5375.4 5433.5 5435.6 5189.0 5320.9 5344.6 5350.9 5354.1 4157.6 4159.7 4165.6 4166.4 4167.2 3945.8 4025.6 4058.7 4136.1 4139.2 4095.2 4105.4 4115.4 4119.2 4120.8 4107.0 4112.6 4112.7 4115.2 4132.8 3630.1 3630.7 3632.7 3635.0 3642.1 5041.9 5149.5 5151.8 5171.7 5208.0 4821.3 4828.9 4829.9 4831.3 4838.0 5706.4 5717.6 5718.7 5720.5 5721.5 3782.9 3887.9 3899.1 3981.4 4014.0 5849.5 5851.2 5904.2 5916.5 5927.5 4142.0 4143.0 4143.3 4144.6 4145.3 4206.7 4210.8 4213.3 4213.3 4215.1 4591.2 4745.3 4774.1 4776.9 4779.0 5641.3 5642.8 5651.8 5658.9 5660.4 1449.7 1449.8 1450.1 1452.4 1461.5 972.3 994.8 1014.9 1018.5 1039.0 4910.4 4913.6 4915.6 4916.8 4921.9 5855.6 5859.9 5863.8 5864.8 5870.0 4879.9 4888.9 4890.2 4898.0 4902.0 3070.2 3128.9 3130.0 3158.7 3170.6 5543.7 5593.6 5598.4 5608.5 5612.6 6071.4 6074.8 6086.4 6086.8 6087.9 5573.2 5592.9 5605.4 5612.2 5613.0 5700.9 5914.7 5925.9 5932.3 5941.3 5569.6 5582.6 5691.7 5789.6 5821.5 5570.0 5570.9 5601.0 5611.4 5615.3 3987.0 4019.1 4021.9 4023.1 4024.9 5628.2 5808.3 5812.7 5821.6 5823.1 5642.4 5679.9 5683.2 5692.2 5694.5 5667.8 5674.9 5680.9 5681.7 5692.3 5563.1 5570.0 5575.1 5575.2 5576.7 5538.9 5653.2 5658.0 5661.4 5699.1 5511.4 5529.9 5573.7 5576.1 5578.0 04:39:09 INFO - 2015-12-17 04:39:09,545 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2015-12-17 04:39:09,545 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11605.77 Median:25801.50 stddev:13356.82 (51.8%) stddev-sans-first:13369.06 04:39:09 INFO - 2015-12-17 04:39:09,545 DEBUG : BROWSER_OUTPUT: Values: 672.0 676.9 685.6 691.6 700.6 10443.0 10945.4 10955.8 10957.7 10968.3 11637.6 11645.2 11653.9 11655.4 11670.5 634.5 642.7 777.0 792.9 793.6 797.4 799.1 799.3 803.0 803.9 824.5 840.8 841.3 841.9 842.2 648.5 656.8 806.2 816.6 817.6 610.4 610.8 611.8 611.9 612.7 10865.3 11035.8 11051.6 11052.6 11059.9 10387.3 10553.7 10620.2 10723.4 10906.4 8600.2 8973.4 9037.2 9084.6 9136.2 3133.1 3159.4 3178.7 3181.8 3218.2 38328.8 38357.0 38411.2 38435.6 39206.8 8283.4 8305.4 8349.2 8357.7 8410.5 14643.6 14655.4 14660.7 14667.3 14687.0 6089.6 6239.4 6324.5 6369.2 6402.4 3373.1 3418.6 3447.7 3460.5 3487.4 2458.9 2615.6 2673.4 2683.3 2691.7 460.5 463.9 464.4 465.7 473.6 427.8 431.3 464.6 505.2 519.8 7522.0 7567.4 7575.1 7651.4 7703.2 447.7 505.5 520.3 527.9 537.4 3237.7 3307.6 3411.6 3510.0 3584.9 48112.8 48125.3 50923.5 51024.0 51083.2 41417.4 42090.0 42337.4 42375.0 42492.2 39256.8 39270.2 39358.6 39514.2 39674.2 6917.0 7202.1 7346.3 7370.3 7370.3 28713.4 29280.4 29772.3 30002.0 30758.5 36272.1 36948.1 37456.6 37659.0 38434.2 8592.2 8947.6 8996.6 9446.7 9510.8 9473.1 9487.7 9544.8 9548.8 9685.7 10045.8 10191.2 10203.6 10210.2 10214.4 9066.7 9329.4 9476.4 9519.3 9539.8 8562.6 8700.4 9835.6 9874.7 9983.7 8783.3 8812.8 8857.3 9099.6 9314.4 7871.6 7905.0 8455.8 8988.5 9067.5 04:39:09 INFO - 2015-12-17 04:39:09,545 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:39:09 INFO - 2015-12-17 04:39:09,545 DEBUG : BROWSER_OUTPUT: 04:39:10 INFO - 2015-12-17 04:39:10,307 INFO : Browser exited with error code: 0 04:39:10 INFO - 2015-12-17 04:39:10,324 INFO : Completed test dromaeo_css (00:18:38) 04:39:10 INFO - 2015-12-17 04:39:10,324 INFO : Starting test kraken 04:39:10 INFO - 2015-12-17 04:39:10,324 DEBUG : operating with platform_type : linux_ 04:39:10 INFO - 2015-12-17 04:39:10,324 INFO : Initialising browser for kraken test... 04:39:10 INFO - 2015-12-17 04:39:10,330 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPGU0C/profile http://localhost:40096/getInfo.html 04:39:14 INFO - 2015-12-17 04:39:14,855 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:39:14 INFO - 2015-12-17 04:39:14,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:39:14 INFO - 2015-12-17 04:39:14,856 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:39:14 INFO - 2015-12-17 04:39:14,856 DEBUG : BROWSER_OUTPUT: __metrics 04:39:14 INFO - 2015-12-17 04:39:14,972 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] 04:39:15 INFO - 2015-12-17 04:39:15,033 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:15 ERROR - 2015-12-17 04:39:15,048 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:39:16 INFO - 2015-12-17 04:39:16,001 INFO : Browser initialized. 04:39:16 INFO - 2015-12-17 04:39:16,002 INFO : Running cycle 1/1 for kraken test... 04:39:16 INFO - 2015-12-17 04:39:16,002 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPGU0C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:39:28 INFO - 2015-12-17 04:39:28,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 150061056 04:39:28 INFO - 2015-12-17 04:39:28,018 DEBUG : BROWSER_OUTPUT: 04:39:30 INFO - 2015-12-17 04:39:30,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:31 INFO - 2015-12-17 04:39:31,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 185921536 04:39:31 INFO - 2015-12-17 04:39:31,180 DEBUG : BROWSER_OUTPUT: 04:39:33 INFO - 2015-12-17 04:39:33,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-dft) 04:39:34 INFO - 2015-12-17 04:39:34,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 177385472 04:39:34 INFO - 2015-12-17 04:39:34,496 DEBUG : BROWSER_OUTPUT: 04:39:37 INFO - 2015-12-17 04:39:37,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-fft) 04:39:38 INFO - 2015-12-17 04:39:38,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 161783808 04:39:38 INFO - 2015-12-17 04:39:38,082 DEBUG : BROWSER_OUTPUT: 04:39:40 INFO - 2015-12-17 04:39:40,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-oscillator) 04:39:40 INFO - 2015-12-17 04:39:40,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 163590144 04:39:40 INFO - 2015-12-17 04:39:40,721 DEBUG : BROWSER_OUTPUT: 04:39:42 INFO - 2015-12-17 04:39:42,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:43 INFO - 2015-12-17 04:39:43,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 166453248 04:39:43 INFO - 2015-12-17 04:39:43,534 DEBUG : BROWSER_OUTPUT: 04:39:46 INFO - 2015-12-17 04:39:46,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:47 INFO - 2015-12-17 04:39:47,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 164163584 04:39:47 INFO - 2015-12-17 04:39:47,119 DEBUG : BROWSER_OUTPUT: 04:39:50 INFO - 2015-12-17 04:39:50,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:51 INFO - 2015-12-17 04:39:51,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 04:39:51 INFO - 2015-12-17 04:39:51,089 DEBUG : BROWSER_OUTPUT: 04:39:53 INFO - 2015-12-17 04:39:53,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40096/tests/kraken/driver.html?testName=json-parse-financial) 04:39:54 INFO - 2015-12-17 04:39:54,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 165187584 04:39:54 INFO - 2015-12-17 04:39:54,543 DEBUG : BROWSER_OUTPUT: 04:39:56 INFO - 2015-12-17 04:39:56,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:56 INFO - 2015-12-17 04:39:56,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 173711360 04:39:56 INFO - 2015-12-17 04:39:56,880 DEBUG : BROWSER_OUTPUT: 04:39:58 INFO - 2015-12-17 04:39:58,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:59 INFO - 2015-12-17 04:39:59,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 174546944 04:39:59 INFO - 2015-12-17 04:39:59,337 DEBUG : BROWSER_OUTPUT: 04:40:01 INFO - 2015-12-17 04:40:01,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:02 INFO - 2015-12-17 04:40:02,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 183033856 04:40:02 INFO - 2015-12-17 04:40:02,019 DEBUG : BROWSER_OUTPUT: 04:40:04 INFO - 2015-12-17 04:40:04,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:05 INFO - 2015-12-17 04:40:05,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 190607360 04:40:05 INFO - 2015-12-17 04:40:05,152 DEBUG : BROWSER_OUTPUT: 04:40:07 INFO - 2015-12-17 04:40:07,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:08 INFO - 2015-12-17 04:40:08,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 186982400 04:40:08 INFO - 2015-12-17 04:40:08,290 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40096/tests/kraken/driver.html?testName=ai-astar) 04:40:10 INFO - 2015-12-17 04:40:10,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 246116352 04:40:10 INFO - 2015-12-17 04:40:10,274 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,277 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:40:10 INFO - 2015-12-17 04:40:10,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;105;111;113;112;101;112;113;120 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;158;164;136;150;156;130;169;130 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;162;161;161;162;163;162;161 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;88;93;71;72;72;95;104;72 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;132;96;95;95;133;94;95;131 04:40:10 INFO - 2015-12-17 04:40:10,278 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;109;110;110;109;109;110;109 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;146;146;146;146;146;146;146 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;102;94;95;95 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;72;70;71;72;71;81;69;69 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;67;68;70;69;68;68;69 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;83;84;82;82;82;83;91;82 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;135;121;122;117;129;121;136;131;119;122 04:40:10 INFO - 2015-12-17 04:40:10,279 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;147;138;146;138;136;146;146;145;134 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;71;68;70;68;68;68;68;69 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1008 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1450356010275__endTimestamp 04:40:10 INFO - 2015-12-17 04:40:10,280 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,284 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:40:10 INFO - 2015-12-17 04:40:10,284 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:40:10 INFO - 2015-12-17 04:40:10,284 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:5.13 (4.6%) stddev-sans-first:5.43 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 105.0 111.0 113.0 112.0 101.0 112.0 113.0 120.0 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:155.00 stddev:15.10 (9.7%) stddev-sans-first:15.84 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 158.0 164.0 136.0 150.0 156.0 130.0 169.0 130.0 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,286 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:40:10 INFO - 2015-12-17 04:40:10,287 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 162.0 161.0 161.0 162.0 163.0 162.0 161.0 04:40:10 INFO - 2015-12-17 04:40:10,287 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,287 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:12.21 (16.4%) stddev-sans-first:12.72 04:40:10 INFO - 2015-12-17 04:40:10,287 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 88.0 93.0 71.0 72.0 72.0 95.0 104.0 72.0 04:40:10 INFO - 2015-12-17 04:40:10,287 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:17.82 (18.8%) stddev-sans-first:18.43 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 132.0 96.0 95.0 95.0 133.0 94.0 95.0 131.0 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 04:40:10 INFO - 2015-12-17 04:40:10,288 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,289 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 04:40:10 INFO - 2015-12-17 04:40:10,289 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 04:40:10 INFO - 2015-12-17 04:40:10,289 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,289 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.25 (2.4%) stddev-sans-first:2.39 04:40:10 INFO - 2015-12-17 04:40:10,289 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 102.0 94.0 95.0 95.0 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:3.47 (4.9%) stddev-sans-first:3.63 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 70.0 71.0 72.0 71.0 81.0 69.0 69.0 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 04:40:10 INFO - 2015-12-17 04:40:10,290 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 67.0 68.0 70.0 69.0 68.0 68.0 69.0 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.76 (3.3%) stddev-sans-first:2.92 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 83.0 84.0 82.0 82.0 82.0 83.0 91.0 82.0 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:125.50 stddev:6.85 (5.5%) stddev-sans-first:6.30 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: Values: 135.0 121.0 122.0 117.0 129.0 121.0 136.0 131.0 119.0 122.0 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:145.50 stddev:5.20 (3.6%) stddev-sans-first:5.17 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: Values: 136.0 147.0 138.0 146.0 138.0 136.0 146.0 146.0 145.0 134.0 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 04:40:10 INFO - 2015-12-17 04:40:10,291 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 68.0 70.0 68.0 68.0 68.0 68.0 69.0 04:40:10 INFO - 2015-12-17 04:40:10,292 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:40:10 INFO - 2015-12-17 04:40:10,292 DEBUG : BROWSER_OUTPUT: 04:40:11 INFO - 2015-12-17 04:40:11,183 INFO : Browser exited with error code: 0 04:40:11 INFO - 2015-12-17 04:40:11,232 INFO : Completed test kraken (00:01:00) 04:40:11 INFO - 2015-12-17 04:40:11,233 INFO : Starting test v8_7 04:40:11 INFO - 2015-12-17 04:40:11,233 DEBUG : operating with platform_type : linux_ 04:40:11 INFO - 2015-12-17 04:40:11,233 INFO : Initialising browser for v8_7 test... 04:40:11 INFO - 2015-12-17 04:40:11,239 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5_SNm/profile http://localhost:40096/getInfo.html 04:40:15 INFO - 2015-12-17 04:40:15,339 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:40:15 INFO - 2015-12-17 04:40:15,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:40:15 INFO - 2015-12-17 04:40:15,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:40:15 INFO - 2015-12-17 04:40:15,339 DEBUG : BROWSER_OUTPUT: __metrics 04:40:15 INFO - 2015-12-17 04:40:15,463 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] 04:40:15 INFO - 2015-12-17 04:40:15,519 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:16 INFO - 2015-12-17 04:40:16,758 INFO : Browser initialized. 04:40:16 INFO - 2015-12-17 04:40:16,759 INFO : Running cycle 1/1 for v8_7 test... 04:40:16 INFO - 2015-12-17 04:40:16,759 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5_SNm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:40:28 INFO - 2015-12-17 04:40:28,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 150515712 04:40:28 INFO - 2015-12-17 04:40:28,741 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40096/tests/v8_7/run.html (next: http://localhost:40096/tests/v8_7/run.html) 04:40:50 INFO - 2015-12-17 04:40:50,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 449880064 04:40:50 INFO - 2015-12-17 04:40:50,394 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,395 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: |0;Richards;165.89250165892503 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.4975755315181 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 04:40:50 INFO - 2015-12-17 04:40:50,396 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |5;Earley;791.9303797468355 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:40:50 INFO - 2015-12-17 04:40:50,397 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:40:50 INFO - 2015-12-17 04:40:50,398 DEBUG : BROWSER_OUTPUT: __startTimestamp1450356050395__endTimestamp 04:40:50 INFO - 2015-12-17 04:40:50,398 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,398 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:40:50 INFO - 2015-12-17 04:40:50,398 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:40:50 INFO - 2015-12-17 04:40:50,398 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: Values: 165.9 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.50 Median:186.50 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: Values: 186.5 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,400 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: Values: 281.3 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: Values: 5181.3 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,401 DEBUG : BROWSER_OUTPUT: Values: 2006.0 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.93 Median:791.93 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: Values: 791.9 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: Values: 12120.5 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,402 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: Values: 26657.9 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: Values: 622.7 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:40:50 INFO - 2015-12-17 04:40:50,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:40:50 INFO - 2015-12-17 04:40:50,404 DEBUG : BROWSER_OUTPUT: 04:40:51 INFO - 2015-12-17 04:40:51,411 INFO : Browser exited with error code: 0 04:40:51 INFO - 2015-12-17 04:40:51,430 INFO : Completed test v8_7 (00:00:40) 04:40:51 INFO - 2015-12-17 04:40:51,434 INFO : Completed test suite (00:20:19) 04:40:51 INFO - 2015-12-17 04:40:51,434 DEBUG : Working with test: dromaeo_css 04:40:51 INFO - 2015-12-17 04:40:51,434 DEBUG : Generating results file: dromaeo_css 04:40:51 INFO - 2015-12-17 04:40:51,435 DEBUG : Working with test: kraken 04:40:51 INFO - 2015-12-17 04:40:51,435 DEBUG : Generating results file: kraken 04:40:51 INFO - 2015-12-17 04:40:51,436 INFO : javascript benchmark 04:40:51 INFO - 2015-12-17 04:40:51,436 DEBUG : Working with test: v8_7 04:40:51 INFO - 2015-12-17 04:40:51,436 DEBUG : Generating results file: v8_7 04:40:51 INFO - 2015-12-17 04:40:51,436 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:51 INFO - 2015-12-17 04:40:51,491 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:40:51 INFO - 2015-12-17 04:40:51,491 DEBUG : process_Request line: dromaeo_css 6233.24 graph.html#tests=[[72,132,35]] 04:40:51 INFO - 2015-12-17 04:40:51,491 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:51 INFO - 2015-12-17 04:40:51,522 DEBUG : process_Request line: kraken 1518.20 graph.html#tests=[[232,132,35]] 04:40:51 INFO - 2015-12-17 04:40:51,522 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:51 INFO - 2015-12-17 04:40:51,558 DEBUG : process_Request line: v8_7 19732.45 graph.html#tests=[[230,132,35]] 04:40:51 INFO - 2015-12-17 04:40:51,559 INFO : javascript benchmark 04:40:51 INFO - 2015-12-17 04:40:51,563 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.843409395436, 2699.0688212566656, 2701.959470607941, 2714.2535802654265, 2714.78281737461, 4525.547445255473, 4671.74305413203, 4719.150552900481, 4724.126036683212, 4733.4793172751015, 4579.908401831962, 4588.816447342102, 4651.720896746189, 4688.109259240742, 4710.2228132358205, 4353.0205703716565, 4385.320275357325, 4406.669499787521, 4492.258777301741, 4506.954930450703, 4197.8530751423705, 4417.801198946056, 4440.955590444103, 4508.594226519613, 4534.274516077428, 4278.700490965633, 4283.250431174532, 4333.371661109153, 4348.130373925196, 4385.846495372647, 4301.268784306644, 4341.175176716414, 4350.390945267665, 4387.692861499696, 4389.604935555783, 4124.4019617155345, 4334.1981733379425, 4349.9130017399475, 4364.803583838703, 4389.31965545341, 4546.090781843644, 4548.840790572314, 4550.817967281305, 4638.373819534353, 4689.320048592969, 5132.435432102466, 5134.691918484866, 5139.820106296299, 5143.074246635604, 5169.922451163236, 4829.975850120762, 5153.2785410042625, 5155.32980712505, 5156.432792392834, 5173.689578625294, 4617.399738034068, 4624.26011838111, 4652.720836749738, 4712.6229901607785, 4781.0, 5231.921521177185, 5247.658902171346, 5254.054270231395, 5265.815696450606, 5330.360356757214, 4751.501092385319, 5043.445221025684, 5045.167547354718, 5049.899002019939, 5106.0, 4866.245731911559, 4950.331705219821, 4973.850784476472, 5050.84847454577, 5067.569256613156, 4946.431160416526, 4957.752112394438, 4958.107540642719, 4958.925616115761, 4993.1262029144755, 4902.681325713817, 4909.729964851896, 4925.655204135676, 4931.211006238985, 4971.502849715, 4019.8392064317686, 4064.1262128641893, 4071.755694658271, 4108.055147316134, 4171.791410429466, 3676.5220521332058, 3687.9262414751556, 3694.058015206105, 3707.0, 3720.925581488409, 4330.7401555906745, 4337.327714204303, 4339.0, 4370.54109318517, 4378.387025816388, 4795.160846851787, 4907.018596280686, 4921.0157968406465, 4925.359703238556, 5080.974595127001, 4244.830206791694, 4312.374705667723, 4326.372675961968, 4340.240457919851, 4368.694191406635, 4497.617702495325, 4505.864824055284, 4510.075434535912, 4550.47669518003, 4598.839040633562, 4580.748058856661, 4690.0, 4818.734969576567, 4821.63837712166, 4833.637477189225, 4967.875803104951, 4974.278729584263, 5073.985202959349, 5086.745662716923, 5103.617228707936, 4828.251620998611, 4829.7585120744525, 4840.346553215411, 4847.0, 4869.902601947871, 4742.620590352833, 5022.422421421583, 5036.748162591783, 5038.1183292924325, 5082.491750824888, 4994.525520075587, 4995.275685025578, 5030.647854650139, 5078.08594453002, 5128.230765385222, 4955.1576232039915, 5003.77483013258, 5004.84985450437, 5011.0, 5060.974695126501, 4723.456802467623, 4995.15082435994, 4999.250112483157, 5001.474845141353, 5006.674566153189, 4693.812247510198, 4702.177119004092, 4719.976400118115, 4785.353977213032, 4827.372441582572, 4930.890549626305, 4957.429895561912, 4957.429895562056, 4961.1318019345745, 4991.550760431579, 4617.607503362117, 4814.5907597854575, 4828.2998965150555, 4837.395325584302, 4876.634252431153], "unit": "score", "name": "dojo.html", "value": 4621.3703428567}, {"lowerIsBetter": false, "replicates": [578.9305283365997, 580.0516156084801, 587.1486344800041, 592.8725324055328, 602.4186659873221, 26878.731212687868, 27486.0379886704, 32524.349513009725, 32765.5085173722, 32790.8360458198, 38387.61612383875, 39234.60765392345, 39305.21389572214, 39315.803420982855, 39333.80333098338, 6946.826329341781, 7843.294103530681, 8017.198280171965, 8022.438429309951, 8030.5181689098545, 7089.22018577956, 7157.3916217121605, 7200.963995180016, 10059.899401005969, 10349.793004139912, 10007.349522281065, 10017.348872323311, 10087.344322619007, 10140.340877842953, 10150.3402278852, 9909.355891867006, 10050.396976181453, 10064.446455444948, 10106.696799095966, 10119.797604047877, 7171.497995140342, 7370.152432470281, 10093.545790439448, 10379.636712715093, 10397.740056498573, 36359.27281454356, 36720.63279367199, 36721.449178262345, 36739.26521469556, 36813.07967300812, 2700.729927007303, 2768.9723102769117, 2813.6153567404085, 3162.7153556179824, 3314.4034073866696, 28531.017369727047, 29160.0, 29286.41427171466, 29352.559711604343, 29501.40997180066, 3405.6934875861043, 3488.1105318143964, 3495.982520087409, 3536.7701099428455, 3607.6753092221566, 213721.0, 213907.0, 215763.0, 215907.0, 216517.0, 50439.0, 54502.45497545053, 55086.9999999992, 55102.72448637731, 55119.448805512235, 44114.338284925754, 62753.68623156855, 64021.679891600244, 64065.67967160134, 64095.0, 11908.345041022827, 12099.0, 12114.939425302993, 12115.273083615011, 12146.817797733042, 8978.595963181673, 9043.683471078612, 9045.819083618291, 9055.456672599665, 9056.275497960147, 18463.446096617125, 18564.44306670802, 18593.628127437376, 18613.534661633566, 18613.81386186148, 7095.687297849811, 7268.418526517866, 7333.2666733327305, 7364.374028207662, 7414.592197429085, 885.7741275974586, 929.6095639831287, 941.868138460616, 966.5747071288611, 1025.5692609104194, 25903.611445828326, 26127.608085878728, 26550.336241594116, 26623.0, 26725.599116013276, 855.2302927365297, 864.1401805203863, 882.2148288023664, 934.8924873639619, 1023.976023976024, 13424.395902184426, 13636.250006249751, 13671.453141874412, 13929.164250145024, 13937.790933136012, 268654.0, 274328.0, 275667.0, 275792.0, 276638.0, 45512.77243613761, 45606.54393456089, 45649.0, 45668.54331456709, 45684.77157614191, 1204.7349583091707, 1219.0928075517943, 1229.0843321725372, 1233.3524899427694, 1236.017366193878, 24644.630330544696, 25697.229083127535, 26271.211863644123, 26283.868580656974, 26288.737112628627, 36142.277154456235, 39745.60254397535, 40132.59867401289, 40159.79920100381, 40207.798961005006, 174519.0, 243175.0, 248429.0, 248804.0, 248930.0, 24528.386790330384, 24846.50306993814, 24922.750772492043, 24929.127480538093, 24942.87528562418, 32781.0, 33053.17367065843, 33418.66581334253, 33586.0, 39437.21125577415, 30986.690133098382, 31276.218094547818, 31548.0, 32006.0, 32255.677443225268, 31542.369152617277, 38335.80832095822, 40405.393919090646, 41078.79460602797, 43012.0, 34300.828495857364, 34945.65054349424, 35337.64662353446, 35459.468107978915, 37719.622803771614, 35248.64751352556, 36051.459228111074, 36511.81744091262, 36672.449913251854, 36909.446358305184, 28335.43329133447, 28420.289492762848, 28866.0, 29084.7091529082, 29255.122346329645], "unit": "score", "name": "ext.html", "value": 17035.000280280245}, {"lowerIsBetter": false, "replicates": [329.6456309467323, 329.89773170317187, 332.97835640683354, 335.6576292181973, 336.5238187964031, 12374.628761137157, 12884.291363975, 14463.566093017213, 14972.32624531896, 15250.313735881884, 11760.823587646171, 14489.565313040626, 15104.320305586247, 15559.29983150758, 15589.766153507706, 4729.385179926613, 4739.0758802033615, 4833.347498087766, 4926.285688575154, 4951.702897826142, 3632.273545290939, 3726.7577607455564, 4931.926021109686, 4968.031233909389, 5562.0, 5784.074548072309, 5785.913211301834, 5801.7389217485315, 5817.62185457946, 5821.214136091637, 5608.9439105609035, 5733.283339582552, 5743.597948143632, 5744.080947048452, 5755.82732518023, 5030.647854650176, 5035.29505869175, 5039.848804535834, 5041.092603331399, 5045.949540504585, 18553.443396697985, 18588.44234672962, 18867.150978205875, 18909.7163542547, 19131.33040343581, 1881.9811801882079, 1947.8441724661993, 1968.271739456396, 1969.7045443183495, 2069.6067747128, 8034.9598252008955, 8160.795980100485, 8363.0, 8430.32557395407, 9765.0, 1721.148031724292, 1730.524105870883, 1799.6490684316564, 1812.3656720147974, 1906.161289032835, 54549.1817622736, 57211.0, 57402.85194296132, 57786.0, 58751.70624146895, 9232.7691807704, 9400.576974036185, 9549.427034377959, 9609.423434593808, 9688.90311096894, 12113.454894529767, 12206.75586488283, 12210.26738395699, 12210.328431936152, 12223.755524889453, 6574.112494813139, 6581.835454113685, 6607.900881486781, 6609.537332386687, 6614.173228346457, 6119.296280927751, 6120.969395152996, 6174.536909731788, 6190.164327815687, 6194.256689197326, 3943.4873466449176, 4001.55982841893, 4009.218202450494, 4019.256437559061, 4056.350983842571, 1593.6015996001, 1626.6502701919144, 1636.4354297767488, 1667.1914121650989, 1730.3165249726287, 818.108261994429, 823.995880020596, 836.786619412046, 945.6028468043438, 984.871966644346, 14334.569962901129, 14459.566213013626, 15024.17367044823, 15225.923870380577, 15674.68650626981, 767.7005967672612, 843.4559708987669, 874.2699845628844, 911.6991392840347, 948.6964171465203, 8081.3130883874355, 8623.827523449496, 9026.503542305105, 9210.907890921006, 9481.620735170516, 436028.0, 457317.0, 468569.0, 477617.0, 477760.0, 71997.64001179961, 72593.19991801039, 72933.27066729264, 73526.0, 75681.24318756851, 1056.8427571808857, 1069.4866464097277, 1071.7159952612565, 1075.6396607136696, 1094.3488624268389, 14189.29053547298, 14215.715685686435, 14304.0, 14462.927685361507, 14624.634384140481, 31677.0, 32238.838805805823, 33018.66981330156, 33531.497027544116, 33590.81659692112, 41035.7948210257, 41210.38184427296, 41231.0, 41455.37816932809, 41500.1699966005, 8154.83690326202, 8539.359548034046, 8772.29821614282, 8775.210231079234, 8775.341849361195, 10041.598336066476, 10159.339642923187, 11537.769244615229, 16094.356225750838, 16296.429624963544, 13300.733985320432, 13449.260290684106, 13509.392077356346, 13668.726625467634, 13867.23730194849, 8731.170538798804, 8941.37410381293, 13191.67020824487, 13443.596692099252, 13483.460661573426, 7832.608369581384, 8054.556999364857, 9173.0, 9301.767455813659, 9325.766855828388, 13007.0, 13133.0, 13497.190168589916, 13607.79588306196, 13669.266146770487, 13905.235212063433, 13909.930450347683, 14451.205183714997, 14452.494162704255, 14460.349284282443], "unit": "score", "name": "jquery.html", "value": 8108.2419170353005}, {"lowerIsBetter": false, "replicates": [1250.8498980122386, 1596.5769071196135, 1667.0497816244738, 1671.0725547321235, 1682.2177687375377, 6284.151639528663, 6964.860702785948, 7172.21105678375, 7174.677139528727, 7198.640067996593, 7117.7864664060035, 7233.0, 7262.891056634155, 7274.3816775574005, 7284.307990740871, 2078.5842831433697, 2108.3569511299047, 2109.0298462707174, 2112.9260475883348, 2115.079940225999, 2074.4191626344646, 2096.7693553709078, 2124.91500339987, 2136.9893150534226, 2137.732783402075, 2051.046263487478, 2057.567910738747, 2058.969115463269, 2085.35354040248, 2088.812006919377, 2024.6355655981918, 2057.269669267411, 2058.7941205879442, 2059.608674351883, 2061.072517367191, 2042.2647846775149, 2071.8135367816817, 2091.4144039668918, 2094.2356040045424, 2097.035363732685, 7224.385927196142, 7325.0, 7326.96336518314, 7330.303621155982, 7330.67011984462, 4101.815418306153, 4176.770277634729, 4189.07840275139, 4196.622303992624, 4198.097409057037, 2654.5089158505543, 2669.3460102275067, 2707.323169207698, 2708.471847989643, 2720.319920019995, 889.5596679643618, 892.1390857822167, 900.8379190843804, 910.0626354854511, 928.0626567167142, 9543.236541076698, 9570.856437153448, 9586.233101351874, 9586.424814511081, 9597.616095356178, 3682.0794801299676, 3701.7408781385584, 3765.8870233893026, 3806.600306967784, 3811.0472381904524, 8329.708460203863, 8338.458000229966, 8346.081930987586, 8347.707830225912, 8368.456050356708, 4146.170765846843, 4152.43942067823, 4163.854265100707, 4171.666266698657, 4174.728642638219, 3184.3153721949893, 3284.293876816496, 3689.0961714379614, 3808.4858544096746, 3820.0449887528116, 3474.635163307816, 3480.547528821237, 3482.3035392921515, 3495.4582039783872, 3530.8411121499594, 1104.2435931387026, 1110.722319420145, 1112.3770688414513, 1114.8104822180248, 1121.1815374776459, 1175.4651633506735, 1185.4132204558798, 1190.892819646236, 1203.181836351272, 1205.1684337806885, 6657.866842663119, 6713.530052896251, 6719.596824190564, 6726.3609957054005, 6754.696038678271, 411.65626701703815, 414.2729509710439, 414.66619371405704, 416.25905887520264, 416.8520175337772, 5321.627486075938, 5349.652272602269, 5357.946420535744, 5360.70516121617, 5362.383325917492, 8635.266002389742, 8659.523726194993, 8659.696910608098, 8833.293336533063, 8846.46921184731, 8658.740237792876, 8733.432326898732, 8734.0829212933, 8740.213380795632, 8752.124787521198, 6701.128853249046, 6769.966150169218, 6831.351021652935, 6869.450443964471, 6891.3797758202, 6546.24718157418, 6548.116004339353, 6551.246606640298, 6561.212654481493, 6561.475081993524, 7665.731699390494, 7705.0, 7764.61176941162, 7845.529268243924, 7919.16848730898, 7819.100803407681, 7963.402744794048, 7980.441369104107, 8089.393295502743, 8093.271605555528, 5566.610337276352, 5698.031334673033, 5700.543956483554, 5885.0, 5938.435848594377, 6034.762873610812, 6711.530192886451, 6713.6307503085845, 6720.966395167993, 6734.3602357775935, 6378.2346118466085, 6660.101870966945, 6693.966530167318, 6717.798466046026, 6761.019652150312, 6411.4229719325485, 6450.258220304538, 6494.935050649433, 6514.609123452608, 6609.173853268341, 6541.476681865534, 6561.0, 6566.24488183865, 6584.736610535525, 6586.80239592813, 5608.831735047955, 5710.885782284414, 5753.568482363756, 6051.909221361595, 6083.209182806384, 6157.199564056823, 6180.81457556274, 6196.0705894116245, 6201.0388389799655, 6207.255129384503], "unit": "score", "name": "mootools.html", "value": 4023.4868816809453}, {"lowerIsBetter": false, "replicates": [291.7374363073235, 296.06148509225767, 299.7317400926171, 302.93184033592445, 307.16298087710993, 5286.101362768334, 5292.417834038252, 5375.354957405112, 5433.48381903719, 5435.592330575203, 5188.974055129719, 5320.9467905320935, 5344.599155063376, 5350.946490535093, 5354.116570765819, 4157.584241575849, 4159.729617574863, 4165.645920096796, 4166.395872598471, 4167.187398457309, 3945.842166313344, 4025.5974402559805, 4058.69559783016, 4136.069384388518, 4139.19285739281, 4095.221907837516, 4105.4252404663375, 4115.403266526352, 4119.155573107506, 4120.835166593348, 4106.958930410688, 4112.568180341051, 4112.732672376301, 4115.218108559364, 4132.752034877917, 3630.1287690954246, 3630.6550877666577, 3632.7275454340765, 3635.0367152704553, 3642.1440961374055, 5041.924371134436, 5149.510796474329, 5151.793928242866, 5171.689698618095, 5207.973960130175, 4821.300911367832, 4828.927566086511, 4829.903401931977, 4831.251156070814, 4838.0, 5706.3722990471015, 5717.571182161313, 5718.656880587137, 5720.513756330717, 5721.4850663440075, 3782.9432558511644, 3887.941680874789, 3899.1421887184774, 3981.442598036277, 4013.97993010036, 5849.473547380713, 5851.23933888596, 5904.232449781501, 5916.497097746696, 5927.525797936111, 4142.026623743418, 4143.005678637105, 4143.274926887842, 4144.585541445831, 4145.274576949022, 4206.747595144301, 4210.768407737603, 4213.262679031157, 4213.283741763847, 4215.051613387025, 4591.1965406053805, 4745.264484004984, 4774.092922344744, 4776.904461910812, 4779.0, 5641.294838145232, 5642.802501912413, 5651.8304450866535, 5658.886822263614, 5660.377358490563, 1449.6593300574357, 1449.8187726534184, 1450.0719539494733, 1452.3899962015978, 1461.5396150212648, 972.2610815779917, 994.751312171957, 1014.9086582207636, 1018.4805749068029, 1039.0285083447002, 4910.410750709938, 4913.557779799835, 4915.58217551505, 4916.803327866845, 4921.926171107436, 5855.59010869235, 5859.882802344015, 5863.765449382062, 5864.794732184353, 5870.031444811559, 4879.902401951941, 4888.853334399973, 4890.217565189552, 4897.99591083827, 4901.950980490221, 3070.217094640897, 3128.9374212515622, 3130.029690795815, 3158.6841315868687, 3170.619525656936, 5543.667379957215, 5593.552515798727, 5598.44015598445, 5608.523275521545, 5612.550995920316, 6071.362506936708, 6074.787382441594, 6086.360932102154, 6086.817395478142, 6087.878242435127, 5573.191887176336, 5592.916106258409, 5605.439456054362, 5612.214289999403, 5612.97193514038, 5700.857478563069, 5914.733836977261, 5925.9407405925385, 5932.347441781487, 5941.287045554561, 5569.637973531708, 5582.553395728413, 5691.743871525874, 5789.56578256624, 5821.476067153807, 5569.972150139223, 5570.86072848182, 5600.971995139998, 5611.38274789781, 5615.298087739033, 3986.980065099656, 4019.0756126090578, 4021.879343619696, 4023.114914718757, 4024.91327341622, 5628.240187574625, 5808.332041815245, 5812.709364531841, 5821.592488525763, 5823.097419899922, 5642.379338272704, 5679.858003549944, 5683.204351390891, 5692.203091567101, 5694.544436444991, 5667.829965101054, 5674.943250567441, 5680.857978550569, 5681.659100453986, 5692.260006199168, 5563.109902415594, 5569.997400467954, 5575.107982722745, 5575.2473416088305, 5576.749046293007, 5538.861528461821, 5653.180288858175, 5658.0, 5661.424052056387, 5699.145128230799, 5511.393746687781, 5529.917051244154, 5573.665580065209, 5576.1356989666665, 5578.0], "unit": "score", "name": "prototype.html", "value": 4247.442686571698}, {"lowerIsBetter": false, "replicates": [671.979840604782, 676.8916973284275, 685.6366125953247, 691.6023286610199, 700.6391708270238, 10443.0, 10945.398003109825, 10955.835662465059, 10957.671269861918, 10968.287061341018, 11637.592684256053, 11645.18483706141, 11653.883461165386, 11655.358955257458, 11670.533178672864, 634.5050860328951, 642.7364780440021, 776.957267350294, 792.8652129138061, 793.5595744361876, 797.4099166616691, 799.1369321133162, 799.2886331165267, 802.9598520074002, 803.9035315762117, 824.4599787139433, 840.7603832907622, 841.2891107014563, 841.9410641255115, 842.2083241752733, 648.5200951296031, 656.8259411256021, 806.2260230179006, 816.603947085663, 817.5748610722451, 610.3682688417466, 610.8167549735061, 611.8256296955346, 611.8653896142841, 612.6997771092133, 10865.293755905841, 11035.83446248307, 11051.557937682483, 11052.557897684082, 11059.889401105966, 10387.27289089764, 10553.736156596147, 10620.150387968944, 10723.410212438313, 10906.400147991857, 8600.225979661798, 8973.41672791273, 9037.186653201177, 9084.636614535411, 9136.223421009223, 3133.138386943586, 3159.415508131003, 3178.7298079663256, 3181.8249996250197, 3218.2115381731624, 38328.80835595804, 38357.0, 38411.23177536461, 38435.615643843485, 39206.803965980274, 8283.420160588701, 8305.37709671765, 8349.206825351583, 8357.707480238285, 8410.453320534145, 14643.56069317922, 14655.413783448543, 14660.706785864437, 14667.339969701388, 14687.0, 6089.634621922699, 6239.438450539383, 6324.462420694293, 6369.20384951881, 6402.391772781578, 3373.1061268763797, 3418.5897692277085, 3447.6897079262985, 3460.498227756961, 3487.3897068013, 2458.938526536851, 2615.6468876701783, 2673.4118493931305, 2683.3023413912524, 2691.744284292989, 460.5486623109372, 463.85852315044235, 464.3916469425064, 465.65308844910084, 473.5879784587431, 427.8203154675044, 431.28191561051125, 464.5633104881401, 505.1992591742056, 519.7583123847429, 7521.962390188014, 7567.394608431312, 7575.053118360205, 7651.4261430391825, 7703.1911649277135, 447.68438251032944, 505.5197562315815, 520.2872065270603, 527.8522013836132, 537.3632245788752, 3237.6762323767434, 3307.58655168104, 3411.6076651184935, 3510.0, 3584.928301434009, 48112.7594362033, 48125.27812082822, 50923.49076509262, 51024.0, 51083.23375149376, 41417.378739318934, 42090.0, 42337.364939525934, 42375.0, 42492.150156997304, 39256.80371598124, 39270.21459570793, 39358.60641393607, 39514.2097158061, 39674.2065158701, 6916.965415172892, 7202.135743710788, 7346.33882950537, 7370.262973702587, 7370.262973702801, 28713.42573148567, 29280.41439171247, 29772.255693607833, 30002.0, 30758.53862192024, 36272.09319767027, 36948.07629809276, 37456.625433745314, 37659.0, 38434.2313153741, 8592.183742544448, 8947.642094316154, 8996.595153218252, 9446.669366572138, 9510.809783804147, 9473.052694730472, 9487.66793162236, 9544.761380965532, 9548.809023819624, 9685.6610018649, 10045.849312260469, 10191.235657325582, 10203.591856325664, 10210.234232432449, 10214.438205898747, 9066.682666106655, 9329.440233586007, 9476.431414115175, 9519.286053545873, 9539.809203815747, 8562.57187140628, 8700.390972631854, 9835.606575737176, 9874.654387096418, 9983.650572229937, 8783.341249406192, 8812.823743524965, 8857.291416686778, 9099.636014559343, 9314.394564353295, 7871.606419679108, 7905.0, 8455.788605284917, 8988.46069235848, 9067.455952642598], "unit": "score", "name": "yui.html", "value": 5376.117453397739}], "name": "dromaeo_css", "value": 6233.2431869988}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 105.0, 111.0, 113.0, 112.0, 101.0, 112.0, 113.0, 120.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 158.0, 164.0, 136.0, 150.0, 156.0, 130.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 88.0, 93.0, 71.0, 72.0, 72.0, 95.0, 104.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 132.0, 96.0, 95.0, 95.0, 133.0, 94.0, 95.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 102.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 70.0, 71.0, 72.0, 71.0, 81.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 67.0, 68.0, 70.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 84.0, 82.0, 82.0, 82.0, 83.0, 91.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [135.0, 121.0, 122.0, 117.0, 129.0, 121.0, 136.0, 131.0, 119.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [136.0, 147.0, 138.0, 146.0, 138.0, 136.0, 146.0, 146.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1518.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [186.4975755315181], "unit": "score", "name": "DeltaBlue", "value": 354.524716}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [791.9303797468355], "unit": "score", "name": "Earley", "value": 841.5676643356645}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Splay", "value": 130.874546}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19732.44578648864}]} 04:40:51 INFO - RETURN: dromaeo_css: 6233.24 04:40:51 INFO - RETURN: kraken: 1518.20 04:40:51 INFO - RETURN: v8_7: 19732.45 04:40:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19732.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1518.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6233.24"}}} 04:40:51 INFO - Return code: 0 04:40:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:40:51 ERROR - # TBPL SUCCESS # 04:40:51 INFO - Running post-action listener: _resource_record_post_action 04:40:51 INFO - Running post-run listener: _resource_record_post_run 04:40:52 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546238464; Read time: 152; Write time: 516496 04:40:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226902016; Read time: 0; Write time: 309380 04:40:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8192; Write bytes: 318472192; Read time: 152; Write time: 207080 04:40:52 INFO - Running post-run listener: _upload_blobber_files 04:40:52 INFO - Blob upload gear active. 04:40:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:40:52 INFO - Copying logs to upload dir... 04:40:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.400297 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-17 04:40:52.642896) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:40:52.646874) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009939 build_url: 'https://queue.taskcluster.net/v1/task/Mj07rjrnTJmdBEb50ibUJg/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 04:40:52.697349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:40:52.697713) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450354504.636179-1482013519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:40:52.747202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 04:40:52.747531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 04:40:52.747823) ========= ========= Total master_lag: 0.23 =========