builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1450784869.6 results: success (0) buildid: 20151222025617 builduid: 576216e04051498d819cd578ebf42092 revision: 054fa50c23c5c0bee40ff3b389cd4711dc675ab9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.599788) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.600667) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.601358) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004509 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.640985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.641286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.682462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.682801) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035411 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.740326) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.740612) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.740947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.741216) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 03:47:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 78.7M=0s 2015-12-22 03:47:50 (78.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.230771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.986256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:49.986558) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041464 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.037870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.038177) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 054fa50c23c5c0bee40ff3b389cd4711dc675ab9 --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 054fa50c23c5c0bee40ff3b389cd4711dc675ab9 --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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 03:47:50,123 truncating revision to first 12 chars 2015-12-22 03:47:50,123 Setting DEBUG logging. 2015-12-22 03:47:50,123 attempt 1/10 2015-12-22 03:47:50,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054fa50c23c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 03:47:50,368 unpacking tar archive at: fx-team-054fa50c23c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.605147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.605544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.613058) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.613455) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 03:47:50.613927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-22 03:47:50.614221) ========= /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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:50 INFO - MultiFileLogger online at 20151222 03:47:50 in /builds/slave/test 03:47:50 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 03:47:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:50 INFO - {'append_to_log': False, 03:47:50 INFO - 'base_work_dir': '/builds/slave/test', 03:47:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:47:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:50 INFO - 'branch': 'Fx-Team-Non-PGO', 03:47:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:50 INFO - 'config_files': ('talos/linux_config.py',), 03:47:50 INFO - 'default_actions': ('clobber', 03:47:50 INFO - 'read-buildbot-config', 03:47:50 INFO - 'download-and-extract', 03:47:50 INFO - 'populate-webroot', 03:47:50 INFO - 'create-virtualenv', 03:47:50 INFO - 'install', 03:47:50 INFO - 'run-tests'), 03:47:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:50 INFO - 'download_minidump_stackwalk': True, 03:47:50 INFO - 'download_symbols': 'ondemand', 03:47:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:50 INFO - 'installer_path': 'installer.exe', 03:47:50 INFO - 'log_level': 'info', 03:47:50 INFO - 'log_name': 'talos', 03:47:50 INFO - 'log_to_console': True, 03:47:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:50 INFO - 'opt_config_files': (), 03:47:50 INFO - 'pip_index': False, 03:47:50 INFO - 'sps_profile': False, 03:47:50 INFO - 'sps_profile_interval': 0, 03:47:50 INFO - 'suite': 'dromaeojs', 03:47:50 INFO - 'system_bits': '64', 03:47:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:50 INFO - 'title': 'talos-linux64-ix-017', 03:47:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:50 INFO - 'use_talos_json': True, 03:47:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:50 INFO - 'work_dir': 'build'} 03:47:50 INFO - ##### 03:47:50 INFO - ##### Running clobber step. 03:47:50 INFO - ##### 03:47:50 INFO - Running pre-action listener: _resource_record_pre_action 03:47:50 INFO - Running main action method: clobber 03:47:50 INFO - rmtree: /builds/slave/test/build 03:47:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:51 INFO - Running post-action listener: _resource_record_post_action 03:47:51 INFO - ##### 03:47:51 INFO - ##### Running read-buildbot-config step. 03:47:51 INFO - ##### 03:47:51 INFO - Running pre-action listener: _resource_record_pre_action 03:47:51 INFO - Running main action method: read_buildbot_config 03:47:51 INFO - Using buildbot properties: 03:47:51 INFO - { 03:47:51 INFO - "project": "", 03:47:51 INFO - "product": "firefox", 03:47:51 INFO - "script_repo_revision": "production", 03:47:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:47:51 INFO - "repository": "", 03:47:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:47:51 INFO - "buildid": "20151222025617", 03:47:51 INFO - "pgo_build": "False", 03:47:51 INFO - "basedir": "/builds/slave/test", 03:47:51 INFO - "buildnumber": 1203, 03:47:51 INFO - "slavename": "talos-linux64-ix-017", 03:47:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:47:51 INFO - "platform": "ubuntu64_hw", 03:47:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:47:51 INFO - "branch": "fx-team", 03:47:51 INFO - "repo_path": "integration/fx-team", 03:47:51 INFO - "revision": "054fa50c23c5c0bee40ff3b389cd4711dc675ab9", 03:47:51 INFO - "stage_platform": "linux64", 03:47:51 INFO - "builduid": "576216e04051498d819cd578ebf42092", 03:47:51 INFO - "slavebuilddir": "test" 03:47:51 INFO - } 03:47:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:47:51 INFO - Running post-action listener: _resource_record_post_action 03:47:51 INFO - ##### 03:47:51 INFO - ##### Running download-and-extract step. 03:47:51 INFO - ##### 03:47:51 INFO - Running pre-action listener: _resource_record_pre_action 03:47:51 INFO - Running main action method: download_and_extract 03:47:51 INFO - mkdir: /builds/slave/test/build/tests 03:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:51 INFO - https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/test_packages.json 03:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/test_packages.json 03:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:47:53 INFO - Downloaded 1302 bytes. 03:47:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:47:53 INFO - Using the following test package requirements: 03:47:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:47:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'jsshell-linux-x86_64.zip'], 03:47:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:47:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:47:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:47:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:47:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:47:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:53 INFO - https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:47:54 INFO - Downloaded 21926753 bytes. 03:47:54 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 03:47:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:54 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 03:47:55 INFO - Return code: 0 03:47:55 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 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:47:58 INFO - Downloaded 21926753 bytes. 03:47:58 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 03:47:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:58 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 03:47:59 INFO - Return code: 0 03:47: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')]} 03:47:59 INFO - https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:48:00 INFO - Downloaded 11132277 bytes. 03:48:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:48:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:48:00 INFO - Return code: 0 03:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:00 INFO - https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMAgVfeJT56WqWNn5TROfw/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 03:48:04 INFO - Downloaded 53374394 bytes. 03:48:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:04 INFO - mkdir: /builds/slave/test/properties 03:48:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:04 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:04 INFO - Contents: 03:48:04 INFO - build_url:https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:04 INFO - Running post-action listener: _resource_record_post_action 03:48:04 INFO - Running post-action listener: set_extra_try_arguments 03:48:04 INFO - ##### 03:48:04 INFO - ##### Running populate-webroot step. 03:48:04 INFO - ##### 03:48:04 INFO - Running pre-action listener: _resource_record_pre_action 03:48:04 INFO - Running main action method: populate_webroot 03:48:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:04 INFO - '--tppagecycles', 03:48:04 INFO - '7'], 03:48:04 INFO - 'tests': ['tsvgm']}}, 03:48:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:48:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'tests': ['damp', 'tps']}, 03:48:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['damp', 'tps']}, 03:48:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:48:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:04 INFO - 'other': {'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'other_l64': {'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'other_nol64': {'tests': ['a11yr', 03:48:04 INFO - 'ts_paint', 03:48:04 INFO - 'tpaint', 03:48:04 INFO - 'sessionrestore', 03:48:04 INFO - 'sessionrestore_no_auto_restore']}, 03:48:04 INFO - 'svgr': {'tests': ['tsvgx', 03:48:04 INFO - 'tsvgr_opacity', 03:48:04 INFO - 'tart', 03:48:04 INFO - 'tscrollx', 03:48:04 INFO - 'cart']}, 03:48:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['tsvgx', 03:48:04 INFO - 'tsvgr_opacity', 03:48:04 INFO - 'tart', 03:48:04 INFO - 'tscrollx', 03:48:04 INFO - 'cart']}, 03:48:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'tests': ['tp5o']}, 03:48:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'talos_options': ['--e10s'], 03:48:04 INFO - 'tests': ['tp5o']}, 03:48:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'talos_options': ['--xperf_path', 03:48:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:04 INFO - 'tests': ['tp5n']}, 03:48:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:04 INFO - 'talos_options': ['--e10s', 03:48:04 INFO - '--xperf_path', 03:48:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:04 INFO - 'tests': ['tp5n']}}, 03:48:04 INFO - 'talos.zip': {'path': '', 03:48:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:04 INFO - Running post-action listener: _resource_record_post_action 03:48:04 INFO - ##### 03:48:04 INFO - ##### Running create-virtualenv step. 03:48:04 INFO - ##### 03:48:04 INFO - Running pre-action listener: _resource_record_pre_action 03:48:04 INFO - Running main action method: create_virtualenv 03:48:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:04 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 03:48:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:48:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:04 INFO - Using real prefix '/usr' 03:48:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:07 INFO - Installing pip.................done. 03:48:07 INFO - Return code: 0 03:48:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:48:07 INFO - Using env: {'DISPLAY': ':0', 03:48:07 INFO - 'HOME': '/home/cltbld', 03:48:07 INFO - 'LANG': 'en_US.UTF-8', 03:48:07 INFO - 'LANGUAGE': 'en_US:en', 03:48:07 INFO - 'LOGNAME': 'cltbld', 03:48:07 INFO - 'MAIL': '/var/mail/cltbld', 03:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:07 INFO - 'MOZ_NO_REMOTE': '1', 03:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:07 INFO - 'NO_EM_RESTART': '1', 03:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:07 INFO - 'PWD': '/builds/slave/test', 03:48:07 INFO - 'SHELL': '/bin/bash', 03:48:07 INFO - 'SHLVL': '1', 03:48:07 INFO - 'TERM': 'linux', 03:48:07 INFO - 'TMOUT': '86400', 03:48:07 INFO - 'USER': 'cltbld', 03:48:07 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:07 INFO - '_': '/tools/buildbot/bin/python'} 03:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:08 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 03:48:08 INFO - Cleaning up... 03:48:08 INFO - Return code: 0 03:48:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:48:08 INFO - Using env: {'DISPLAY': ':0', 03:48:08 INFO - 'HOME': '/home/cltbld', 03:48:08 INFO - 'LANG': 'en_US.UTF-8', 03:48:08 INFO - 'LANGUAGE': 'en_US:en', 03:48:08 INFO - 'LOGNAME': 'cltbld', 03:48:08 INFO - 'MAIL': '/var/mail/cltbld', 03:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:08 INFO - 'MOZ_NO_REMOTE': '1', 03:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:08 INFO - 'NO_EM_RESTART': '1', 03:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:08 INFO - 'PWD': '/builds/slave/test', 03:48:08 INFO - 'SHELL': '/bin/bash', 03:48:08 INFO - 'SHLVL': '1', 03:48:08 INFO - 'TERM': 'linux', 03:48:08 INFO - 'TMOUT': '86400', 03:48:08 INFO - 'USER': 'cltbld', 03:48:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:08 INFO - '_': '/tools/buildbot/bin/python'} 03:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:08 INFO - Downloading/unpacking psutil>=0.7.1 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:48:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:10 INFO - Installing collected packages: psutil 03:48:10 INFO - Running setup.py install for psutil 03:48:10 INFO - building 'psutil._psutil_linux' extension 03:48:10 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 03:48:11 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 03:48:11 INFO - building 'psutil._psutil_posix' extension 03:48:11 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 03:48:11 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 03:48:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:11 INFO - Successfully installed psutil 03:48:11 INFO - Cleaning up... 03:48:11 INFO - Return code: 0 03:48:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:11 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:11 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 03:48:11 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 03:48:11 INFO - Using env: {'DISPLAY': ':0', 03:48:11 INFO - 'HOME': '/home/cltbld', 03:48:11 INFO - 'LANG': 'en_US.UTF-8', 03:48:11 INFO - 'LANGUAGE': 'en_US:en', 03:48:11 INFO - 'LOGNAME': 'cltbld', 03:48:11 INFO - 'MAIL': '/var/mail/cltbld', 03:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:11 INFO - 'MOZ_NO_REMOTE': '1', 03:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:11 INFO - 'NO_EM_RESTART': '1', 03:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:11 INFO - 'PWD': '/builds/slave/test', 03:48:11 INFO - 'SHELL': '/bin/bash', 03:48:11 INFO - 'SHLVL': '1', 03:48:11 INFO - 'TERM': 'linux', 03:48:11 INFO - 'TMOUT': '86400', 03:48:11 INFO - 'USER': 'cltbld', 03:48:11 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:11 INFO - '_': '/tools/buildbot/bin/python'} 03:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:48:13 INFO - Installing collected packages: mozsystemmonitor 03:48:13 INFO - Running setup.py install for mozsystemmonitor 03:48:13 INFO - Successfully installed mozsystemmonitor 03:48:13 INFO - Cleaning up... 03:48:13 INFO - Return code: 0 03:48:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48:13 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')]} 03:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:13 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')]} 03:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:13 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:13 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 03:48:13 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 03:48:13 INFO - Using env: {'DISPLAY': ':0', 03:48:13 INFO - 'HOME': '/home/cltbld', 03:48:13 INFO - 'LANG': 'en_US.UTF-8', 03:48:13 INFO - 'LANGUAGE': 'en_US:en', 03:48:13 INFO - 'LOGNAME': 'cltbld', 03:48:13 INFO - 'MAIL': '/var/mail/cltbld', 03:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:13 INFO - 'MOZ_NO_REMOTE': '1', 03:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:13 INFO - 'NO_EM_RESTART': '1', 03:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:13 INFO - 'PWD': '/builds/slave/test', 03:48:13 INFO - 'SHELL': '/bin/bash', 03:48:13 INFO - 'SHLVL': '1', 03:48:13 INFO - 'TERM': 'linux', 03:48:13 INFO - 'TMOUT': '86400', 03:48:13 INFO - 'USER': 'cltbld', 03:48:13 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:13 INFO - '_': '/tools/buildbot/bin/python'} 03:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:13 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 03:48:13 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 03:48:13 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 03:48:13 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 03:48:13 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 03:48:13 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 03:48:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:15 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 03:48:15 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 03:48:15 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 03:48:15 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 03:48:15 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 03:48:15 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 03:48:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:16 INFO - Downloading docopt-0.6.1.tar.gz 03:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:16 INFO - Running setup.py install for blobuploader 03:48:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:16 INFO - Running setup.py install for requests 03:48:16 INFO - Running setup.py install for docopt 03:48:16 INFO - Successfully installed blobuploader requests docopt 03:48:16 INFO - Cleaning up... 03:48:16 INFO - Return code: 0 03:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:16 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:16 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 03:48:16 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 03:48:16 INFO - Using env: {'DISPLAY': ':0', 03:48:16 INFO - 'HOME': '/home/cltbld', 03:48:16 INFO - 'LANG': 'en_US.UTF-8', 03:48:16 INFO - 'LANGUAGE': 'en_US:en', 03:48:16 INFO - 'LOGNAME': 'cltbld', 03:48:16 INFO - 'MAIL': '/var/mail/cltbld', 03:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:16 INFO - 'MOZ_NO_REMOTE': '1', 03:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:16 INFO - 'NO_EM_RESTART': '1', 03:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:16 INFO - 'PWD': '/builds/slave/test', 03:48:16 INFO - 'SHELL': '/bin/bash', 03:48:16 INFO - 'SHLVL': '1', 03:48:16 INFO - 'TERM': 'linux', 03:48:16 INFO - 'TMOUT': '86400', 03:48:16 INFO - 'USER': 'cltbld', 03:48:16 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:16 INFO - '_': '/tools/buildbot/bin/python'} 03:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:17 INFO - Running setup.py (path:/tmp/pip-xlj6Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:17 INFO - Running setup.py (path:/tmp/pip-oydbOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:17 INFO - Running setup.py (path:/tmp/pip-HyRRLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:17 INFO - Running setup.py (path:/tmp/pip-rCVHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:17 INFO - Running setup.py (path:/tmp/pip-W286td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:17 INFO - Running setup.py (path:/tmp/pip-0hbNo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:17 INFO - Running setup.py (path:/tmp/pip-FpeWPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:17 INFO - Running setup.py (path:/tmp/pip-bVB3Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:17 INFO - Running setup.py (path:/tmp/pip-cPjTWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:17 INFO - Running setup.py (path:/tmp/pip-0YSk0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:17 INFO - Running setup.py (path:/tmp/pip-ZS7vro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:17 INFO - Running setup.py (path:/tmp/pip-bfPlpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:18 INFO - Running setup.py (path:/tmp/pip-XJZ1On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:18 INFO - Running setup.py (path:/tmp/pip-z84Axn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:18 INFO - Running setup.py (path:/tmp/pip-g1yRpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:18 INFO - Running setup.py (path:/tmp/pip-3LOjyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:18 INFO - Running setup.py (path:/tmp/pip-v9YOBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:18 INFO - Running setup.py install for manifestparser 03:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:18 INFO - Running setup.py install for mozcrash 03:48:18 INFO - Running setup.py install for mozdebug 03:48:18 INFO - Running setup.py install for mozdevice 03:48:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:18 INFO - Running setup.py install for mozfile 03:48:18 INFO - Running setup.py install for mozhttpd 03:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozinfo 03:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozInstall 03:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozleak 03:48:19 INFO - Running setup.py install for mozlog 03:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for moznetwork 03:48:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozprocess 03:48:19 INFO - Running setup.py install for mozprofile 03:48:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozrunner 03:48:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozscreenshot 03:48:19 INFO - Running setup.py install for moztest 03:48:20 INFO - Running setup.py install for mozversion 03:48:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:20 INFO - Cleaning up... 03:48:20 INFO - Return code: 0 03:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:20 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')]} 03:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:20 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')]} 03:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:20 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:20 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 03:48:20 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 03:48:20 INFO - Using env: {'DISPLAY': ':0', 03:48:20 INFO - 'HOME': '/home/cltbld', 03:48:20 INFO - 'LANG': 'en_US.UTF-8', 03:48:20 INFO - 'LANGUAGE': 'en_US:en', 03:48:20 INFO - 'LOGNAME': 'cltbld', 03:48:20 INFO - 'MAIL': '/var/mail/cltbld', 03:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:20 INFO - 'MOZ_NO_REMOTE': '1', 03:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:20 INFO - 'NO_EM_RESTART': '1', 03:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:20 INFO - 'PWD': '/builds/slave/test', 03:48:20 INFO - 'SHELL': '/bin/bash', 03:48:20 INFO - 'SHLVL': '1', 03:48:20 INFO - 'TERM': 'linux', 03:48:20 INFO - 'TMOUT': '86400', 03:48:20 INFO - 'USER': 'cltbld', 03:48:20 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:20 INFO - '_': '/tools/buildbot/bin/python'} 03:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:20 INFO - Running setup.py (path:/tmp/pip-opa9AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:20 INFO - Running setup.py (path:/tmp/pip-GxcLr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:20 INFO - Running setup.py (path:/tmp/pip-iR6ctV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:20 INFO - Running setup.py (path:/tmp/pip-Z98stq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:20 INFO - Running setup.py (path:/tmp/pip-EJNs6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:20 INFO - Running setup.py (path:/tmp/pip-7G8A_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:20 INFO - Running setup.py (path:/tmp/pip-pfh5ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:20 INFO - Running setup.py (path:/tmp/pip-CQkAvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:20 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)) 03:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:20 INFO - Running setup.py (path:/tmp/pip-eAfTbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:21 INFO - Running setup.py (path:/tmp/pip-vSDKDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:21 INFO - Running setup.py (path:/tmp/pip-uTUWyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:21 INFO - Running setup.py (path:/tmp/pip-3_Mv6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:21 INFO - Running setup.py (path:/tmp/pip-dbs_2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:21 INFO - Running setup.py (path:/tmp/pip-EMiPH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:21 INFO - Running setup.py (path:/tmp/pip-Bx1vof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:21 INFO - Running setup.py (path:/tmp/pip-Z5nR0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:21 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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:21 INFO - Running setup.py (path:/tmp/pip-pxwLaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:21 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)) 03:48:21 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)) 03:48:21 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)) 03:48:21 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)) 03:48:21 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)) 03:48:21 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)) 03:48:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:23 INFO - Downloading blessings-1.5.1.tar.gz 03:48:23 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 03:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:23 INFO - Installing collected packages: blessings 03:48:23 INFO - Running setup.py install for blessings 03:48:23 INFO - Successfully installed blessings 03:48:23 INFO - Cleaning up... 03:48:23 INFO - Return code: 0 03:48:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:23 INFO - Reading from file tmpfile_stdout 03:48:23 INFO - Current package versions: 03:48:23 INFO - argparse == 1.2.1 03:48:23 INFO - blessings == 1.5.1 03:48:23 INFO - blobuploader == 1.2.4 03:48:23 INFO - docopt == 0.6.1 03:48:23 INFO - manifestparser == 1.1 03:48:23 INFO - mozInstall == 1.12 03:48:23 INFO - mozcrash == 0.16 03:48:23 INFO - mozdebug == 0.1 03:48:23 INFO - mozdevice == 0.47 03:48:23 INFO - mozfile == 1.2 03:48:23 INFO - mozhttpd == 0.7 03:48:23 INFO - mozinfo == 0.9 03:48:23 INFO - mozleak == 0.1 03:48:23 INFO - mozlog == 3.1 03:48:23 INFO - moznetwork == 0.27 03:48:23 INFO - mozprocess == 0.22 03:48:23 INFO - mozprofile == 0.28 03:48:23 INFO - mozrunner == 6.11 03:48:23 INFO - mozscreenshot == 0.1 03:48:23 INFO - mozsystemmonitor == 0.0 03:48:23 INFO - moztest == 0.7 03:48:23 INFO - mozversion == 1.4 03:48:23 INFO - psutil == 3.1.1 03:48:23 INFO - requests == 1.2.3 03:48:23 INFO - wsgiref == 0.1.2 03:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:23 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:23 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 03:48:23 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 03:48:23 INFO - Using env: {'DISPLAY': ':0', 03:48:23 INFO - 'HOME': '/home/cltbld', 03:48:23 INFO - 'LANG': 'en_US.UTF-8', 03:48:23 INFO - 'LANGUAGE': 'en_US:en', 03:48:23 INFO - 'LOGNAME': 'cltbld', 03:48:23 INFO - 'MAIL': '/var/mail/cltbld', 03:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:23 INFO - 'MOZ_NO_REMOTE': '1', 03:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:23 INFO - 'NO_EM_RESTART': '1', 03:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:23 INFO - 'PWD': '/builds/slave/test', 03:48:23 INFO - 'SHELL': '/bin/bash', 03:48:23 INFO - 'SHLVL': '1', 03:48:23 INFO - 'TERM': 'linux', 03:48:23 INFO - 'TMOUT': '86400', 03:48:23 INFO - 'USER': 'cltbld', 03:48:23 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:23 INFO - '_': '/tools/buildbot/bin/python'} 03:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:24 INFO - Cleaning up... 03:48:24 INFO - Return code: 0 03:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:24 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')]} 03:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:24 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')]} 03:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:24 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:24 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 03:48:24 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 03:48:24 INFO - Using env: {'DISPLAY': ':0', 03:48:24 INFO - 'HOME': '/home/cltbld', 03:48:24 INFO - 'LANG': 'en_US.UTF-8', 03:48:24 INFO - 'LANGUAGE': 'en_US:en', 03:48:24 INFO - 'LOGNAME': 'cltbld', 03:48:24 INFO - 'MAIL': '/var/mail/cltbld', 03:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:24 INFO - 'MOZ_NO_REMOTE': '1', 03:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:24 INFO - 'NO_EM_RESTART': '1', 03:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:24 INFO - 'PWD': '/builds/slave/test', 03:48:24 INFO - 'SHELL': '/bin/bash', 03:48:24 INFO - 'SHLVL': '1', 03:48:24 INFO - 'TERM': 'linux', 03:48:24 INFO - 'TMOUT': '86400', 03:48:24 INFO - 'USER': 'cltbld', 03:48:24 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:24 INFO - '_': '/tools/buildbot/bin/python'} 03:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:24 INFO - Downloading/unpacking jsonschema 03:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:25 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 03:48:25 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48:25 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 03:48:25 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 03:48:25 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 03:48:25 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 03:48:25 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 03:48:25 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 03:48:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:26 INFO - warning: no files found matching '*.txt' 03:48:26 INFO - no previously-included directories found matching 'build' 03:48:26 INFO - no previously-included directories found matching 'dist' 03:48:26 INFO - no previously-included directories found matching '.git*' 03:48:26 INFO - Installing collected packages: jsonschema, functools32 03:48:26 INFO - Running setup.py install for functools32 03:48:26 INFO - warning: no files found matching '*.txt' 03:48:26 INFO - no previously-included directories found matching 'build' 03:48:26 INFO - no previously-included directories found matching 'dist' 03:48:26 INFO - no previously-included directories found matching '.git*' 03:48:26 INFO - Successfully installed jsonschema functools32 03:48:26 INFO - Cleaning up... 03:48:26 INFO - Return code: 0 03:48:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 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 0x7f77bb9f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, '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': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', '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 03:48:26 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 03:48:26 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 03:48:26 INFO - Using env: {'DISPLAY': ':0', 03:48:26 INFO - 'HOME': '/home/cltbld', 03:48:26 INFO - 'LANG': 'en_US.UTF-8', 03:48:26 INFO - 'LANGUAGE': 'en_US:en', 03:48:26 INFO - 'LOGNAME': 'cltbld', 03:48:26 INFO - 'MAIL': '/var/mail/cltbld', 03:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:26 INFO - 'MOZ_NO_REMOTE': '1', 03:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:26 INFO - 'NO_EM_RESTART': '1', 03:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:26 INFO - 'PWD': '/builds/slave/test', 03:48:26 INFO - 'SHELL': '/bin/bash', 03:48:26 INFO - 'SHLVL': '1', 03:48:26 INFO - 'TERM': 'linux', 03:48:26 INFO - 'TMOUT': '86400', 03:48:26 INFO - 'USER': 'cltbld', 03:48:26 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:26 INFO - '_': '/tools/buildbot/bin/python'} 03:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:26 INFO - Downloading/unpacking flake8 03:48:26 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 03:48:26 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 03:48:26 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 03:48:26 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 03:48:26 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 03:48:26 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 03:48:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:48:28 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 03:48:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:48:28 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 03:48:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 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 03:48:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:48:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:28 INFO - no previously-included directories found matching 'docs/_build' 03:48:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:48:29 INFO - Running setup.py install for pep8 03:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:29 INFO - no previously-included directories found matching 'docs/_build' 03:48:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:48:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:48:29 INFO - Cleaning up... 03:48:29 INFO - Return code: 0 03:48:29 INFO - Running post-action listener: _resource_record_post_action 03:48:29 INFO - Running post-action listener: _start_resource_monitoring 03:48:29 INFO - Starting resource monitoring. 03:48:29 INFO - ##### 03:48:29 INFO - ##### Running install step. 03:48:29 INFO - ##### 03:48:29 INFO - Running pre-action listener: _resource_record_pre_action 03:48:29 INFO - Running main action method: install 03:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:29 INFO - Reading from file tmpfile_stdout 03:48:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:29 INFO - Reading from file tmpfile_stdout 03:48:29 INFO - Output received: 03:48:29 INFO - Usage: mozinstall [options] installer 03:48:29 INFO - Options: 03:48:29 INFO - -h, --help show this help message and exit 03:48:29 INFO - -d DEST, --destination=DEST 03:48:29 INFO - Directory to install application into. [default: 03:48:29 INFO - "/builds/slave/test"] 03:48:29 INFO - --app=APP Application being installed. [default: firefox] 03:48:29 INFO - mkdir: /builds/slave/test/build/application 03:48:29 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'] 03:48:29 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 03:48:44 INFO - Reading from file tmpfile_stdout 03:48:44 INFO - Output received: 03:48:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:48:44 INFO - Running post-action listener: _resource_record_post_action 03:48:44 INFO - ##### 03:48:44 INFO - ##### Running run-tests step. 03:48:44 INFO - ##### 03:48:44 INFO - Running pre-action listener: _resource_record_pre_action 03:48:44 INFO - Running main action method: run_tests 03:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:44 INFO - Python 2.7.3 03:48:44 INFO - Return code: 0 03:48:44 INFO - grabbing minidump binary from tooltool 03:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:44 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 0x28543d0>, '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 0x27bfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:44 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 03:48:44 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 03:48:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:45 INFO - Return code: 0 03:48:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:48:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:48:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:48:46 INFO - Return code: 0 03:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:48:46 INFO - Using env: {'DISPLAY': ':0', 03:48:46 INFO - 'HOME': '/home/cltbld', 03:48:46 INFO - 'LANG': 'en_US.UTF-8', 03:48:46 INFO - 'LANGUAGE': 'en_US:en', 03:48:46 INFO - 'LOGNAME': 'cltbld', 03:48:46 INFO - 'MAIL': '/var/mail/cltbld', 03:48:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:46 INFO - 'MOZ_NO_REMOTE': '1', 03:48:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:46 INFO - 'NO_EM_RESTART': '1', 03:48:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:46 INFO - 'PWD': '/builds/slave/test', 03:48:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:46 INFO - 'SHELL': '/bin/bash', 03:48:46 INFO - 'SHLVL': '1', 03:48:46 INFO - 'TERM': 'linux', 03:48:46 INFO - 'TMOUT': '86400', 03:48:46 INFO - 'USER': 'cltbld', 03:48:46 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196', 03:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:46 INFO - '_': '/tools/buildbot/bin/python'} 03:48:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:48:46 INFO - mozversion application_buildid: 20151222025617 03:48:46 INFO - mozversion application_changeset: 054fa50c23c5c0bee40ff3b389cd4711dc675ab9 03:48:46 INFO - mozversion application_display_name: Nightly 03:48:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:46 INFO - mozversion application_name: Firefox 03:48:46 INFO - mozversion application_remotingname: firefox 03:48:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:48:46 INFO - mozversion application_vendor: Mozilla 03:48:46 INFO - mozversion application_version: 46.0a1 03:48:46 INFO - mozversion platform_buildid: 20151222025617 03:48:46 INFO - mozversion platform_changeset: 054fa50c23c5c0bee40ff3b389cd4711dc675ab9 03:48:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:48:46 INFO - mozversion platform_version: 46.0a1 03:48:46 INFO - using testdate: 1450784926 03:48:46 INFO - actual date: 1450784926 03:48:46 INFO - starting webserver on 'localhost:35165' 03:48:46 INFO - SUITE-START | Running 3 tests 03:48:46 INFO - TEST-START | dromaeo_css 03:48:46 INFO - operating with platform_type : linux_ 03:48:46 INFO - Initialising browser for dromaeo_css test... 03:48:46 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXbZybI/profile http://localhost:35165/getInfo.html) 03:48:54 INFO - PROCESS | 3372 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 03:48:54 INFO - PROCESS | 3372 | __metrics Screen width/height:1600/1200 03:48:54 INFO - PROCESS | 3372 | colorDepth:24 03:48:54 INFO - PROCESS | 3372 | Browser inner width/height: 1024/697 03:48:54 INFO - PROCESS | 3372 | __metrics 03:48:54 INFO - PROCESS | 3372 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:48:54 INFO - PROCESS | 3372 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:54 ERROR - PROCESS | 3372 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:48:55 INFO - TEST-INFO | 3372: exit 0 03:48:55 INFO - Browser initialized. 03:48:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:55 INFO - TEST-INFO | started process 3465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXbZybI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:07 INFO - PROCESS | 3465 | RSS: Main: 149995520 03:49:07 INFO - PROCESS | 3465 | 03:49:58 INFO - PROCESS | 3465 | 1450784998554 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] 03:52:11 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35165/tests/dromaeo/cssquery-ext.html) 03:52:12 INFO - PROCESS | 3465 | RSS: Main: 245559296 03:52:12 INFO - PROCESS | 3465 | 03:55:15 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-ext.html (next: http://localhost:35165/tests/dromaeo/cssquery-jquery.html) 03:55:16 INFO - PROCESS | 3465 | RSS: Main: 230436864 03:55:16 INFO - PROCESS | 3465 | 03:58:18 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35165/tests/dromaeo/cssquery-mootools.html) 03:58:18 INFO - PROCESS | 3465 | RSS: Main: 220684288 03:58:18 INFO - PROCESS | 3465 | 04:01:20 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35165/tests/dromaeo/cssquery-prototype.html) 04:01:21 INFO - PROCESS | 3465 | RSS: Main: 212287488 04:01:21 INFO - PROCESS | 3465 | 04:04:23 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35165/tests/dromaeo/cssquery-yui.html) 04:04:24 INFO - PROCESS | 3465 | RSS: Main: 197832704 04:04:24 INFO - PROCESS | 3465 | 04:07:26 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-yui.html (next: http://localhost:35165/tests/dromaeo/cssquery-dojo.html) 04:07:27 INFO - PROCESS | 3465 | RSS: Main: 259076096 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | __start_tp_report 04:07:27 INFO - PROCESS | 3465 | _x_x_mozilla_page_load 04:07:27 INFO - PROCESS | 3465 | _x_x_mozilla_page_load_details 04:07:27 INFO - PROCESS | 3465 | |i|pagename|runs| 04:07:27 INFO - PROCESS | 3465 | |0;dojo.html;2619.318977065963;2702.1218104116156;2706.7834573234145;2723.673159220893;2732.52180868348;4577;4726.527347265272;4742.027884283722;4753.643476739241;4757.690750101246;4596.49438561758;4711.599514041302;4715.976420117903;4733.337332773414;4867.0265946810605;4328.329108988112;4332.155229730204;4339.218940590692;4341.02326976431;4350.673699472536;4369.213541562502;4394.033312671208;4419.712718673276;4425.446819147606;4436.622887054604;4109.506859176888;4148.336266197424;4221.303484924983;4235.745855248695;4276.294411422112;4302.892427689301;4316.266234740102;4340.696151269412;4353.695241333108;4393.824247030147;4263.616274535276;4269;4276;4280.400743895857;4306.20335237982;4377.299632058855;4505;4510.706804057726;4617.676762626617;4691.249400095969;5071.137906555858;5071.518205770446;5076.949230507722;5101.336826212606;5119.129747942859;5081.263216833576;5084.9745751271375;5088.313077734496;5094.3886733591835;5136.409312929024;4492.663050271178;4609.60818330439;4707.270373092176;4710.3405523226775;4710.481846996862;5112.4120726116225;5122.410922743858;5250.448702886142;5251.553617942442;5257.395399529027;4993.151164302078;5013.924791128136;5014.924776128361;5017.80672964692;5019.723915184627;4777.761111944389;4882.292067650171;5080.568151707146;5096.413912400048;5123.923141152885;4902.1176188285735;4910.926336104962;4975.4527002029745;5017.774200161001;5032;5010.323606313101;5019.0463811875625;5021.046001259749;5025.723585202776;5073.822416215415;4178.039051018282;4216.325387937915;4216.7259128156575;4224.964883603476;4258.574142585717;3575.76757510761;3615.186583018852;3672.8347224374966;3673.1918977824835;3710.406334986443;4381.824727010884;4387.978060109679;4393.384926110347;4411.18393097278;4442.8667139985855;5070.974645126751;5094.1849304111165;5096.05722941257;5105.463926287686;5124.8206312778875;4207.495100587949;4285.742855428684;4294.9785251073545;4306.375575541529;4398.340248962617;4465.866024019285;4468.530804265571;4471.977640111779;4479.081788233404;4506.887327816831;4806.351142595845;4812.133815913169;4814.277858321279;4833.685810422311;4871.902561948741;4809.398825146856;4923.975380123076;4932.679375840559;5000.524950129732;5121.950000249865;4807.879803004953;4830.058138662927;4866.865456942959;4876.317315575893;4919.335889654851;4967.329410529533;4979.477154898684;4994.775235114356;5002.349694539686;5034.270030845433;4864.075825593126;4989.226669866177;4996.800127994839;5045.520675535819;5188.558972487381;4933.9013219736125;4969.45336013031;4980.32765576657;4986.052649996489;5024.522670346311;4944.505549445027;4972.3038774572315;4973.154563724248;4974;5018.071656743514;4623.768811559476;4661.067786442793;4713.7643117844655;4731.243001119804;4757.09615173116;4958.975205123951;4959.975200123977;4970.279309500174;4972.477889821661;4987.526185012418;4831.710097394168;4839.612830973584;4839.903201935871;4844.660873738804;4881.585065269492 04:07:27 INFO - PROCESS | 3465 | |1;ext.html;509.4676063513628;514.6937572144573;521.9008388406203;549.2776998247305;565.581469712413;26556.734432655667;27062.45875082497;27095.593566096526;27110;27135.592966105498;27813.582796258073;36199.81900090496;36897;36921.630783692155;37088.44367334485;7981.521108733466;8121.715739949103;8123.390745694067;8124.837503249932;8125.06561745398;7173.318534739192;7928.8810667840025;8050.396220283473;8055.355571554262;8056.879146812803;7087.8228044298785;10257;10512.894871051307;10531.31546449482;10532.578696852117;10171.18630509561;10265.846012309821;10280.537375818107;10284.794304113952;10287.125594324454;7231.89152162718;7433.665485053186;10048.648297309632;10175.898241017569;10205;36777.81611091954;37326;37345.06637334089;37359.626403735885;37420.81289593535;2686.6238726578295;2761.7222131419558;3124.5938028056435;3172.0588015670996;3540.415831387818;28865;28949;29158;29242.70757292421;29846.552301715274;3299.5215693724276;3359.1434184283094;3368.208471009311;3388.423967925459;3431.9485207721905;211476;212313;212728;213006;213494;53986.19020714692;54219.18671219935;54324.72837635787;54609;54739;58873.41126588765;58886.41113588895;58956;59094.11358829621;59102.70448647729;13666.385012674453;14093.929530352487;14109.153450792985;14111.506097286545;14124.364403601863;10568.260221784401;10604.94697526523;10615.734606634896;10654.04113629777;10666.14670826332;18468.11819595669;19385.903070484557;19406.320778772675;19419;19424.902875485815;7512.624368781649;7708.730194443167;7731.381489480828;7862.213778622092;7868.72459463916;755.6561764397186;780.8984831971808;833.3458235285393;929.2658799548282;950.2160717408166;30721.231969200948;31673.8416307917;31968.68031319657;32410.189745256557;32909.17727056843;855.1363123245443;903.8870141232346;929.5584597316356;944.1644144931647;965.7778710896533;15595.844041559667;15901.52295431139;16185.4335098271;16243;16488.726609759105;313013;314192;315577;316650;317551;45158;47102.29346559804;47948.760256199195;49772.253416198786;51134.74432627813;1210.9636710898687;1230.9015278777676;1247.9126461147632;1253.7116463213329;1253.924764514132;25877.482450351265;26571;26605.600915985888;27162.185134445997;27178.456430870876;36187;37196.62803371932;45767.54232457633;47386;47400.525994740994;197909;199356;199925;201085;202002;28703.12046952065;28938.514530247845;29173.270668233465;29289.414211716074;29502;36920.26159476849;38049.80975095107;38085.80957095197;38373.61626383701;38550.80724596359;32117;35482.46776298306;40044.79977600093;40193.59806401899;40896.79551602223;33148.1712957178;33370;33623;33633.663663363055;33669;33551.83224083864;33704;33882.32235355328;34019;34132.488012680325;28733.28166795847;29540.556891646214;30298.24254393658;30568;32529;23502.764972350058;23769.16807911715;23786.40533986664;24048.15831445891;24066.87966560156 04:07:27 INFO - PROCESS | 3465 | |2;jquery.html;301.16877418325413;302.1373977294823;306.08175473579263;308.0604157320174;312.04980833362407;12073.939630301837;12445.315507647076;14789;15025.398984040652;15589.376424943002;12926.612201633967;13343.332833358318;14789.408423663068;16148.434804781835;16158.596035099128;4025.496812898388;4977.402711674604;5043.268726034723;5081.974590127063;5125.897482050356;5020.422651395082;5052.747362631872;5053.5957123430035;5053.6715113517685;5058.949410505885;4949.674833448255;4961.8511444656715;5003.524665156804;5004.84985450437;5031.11955407804;4983.651144419892;5016.949830501685;5019.472955339674;5021.17150670139;5024.296598476198;4432.49026361966;4473.686841921067;4475.910481790378;4478.350639157304;4704.858854234379;11534.365609891453;11751.236169648946;11751.647450576496;11755.412229388496;16311.83688163115;1812.5559237986777;1816.4369045595909;1817.6364727054643;1859.4979355574055;1869.7943226245102;8817.905410465517;8850.778730531723;9035.728928132101;9122.270218382513;9164.450132991975;1771.6279581287945;1780.1811166863258;1791.113398867569;1795.353672677835;1822.1891258390021;54463.72768136134;55549;57978;58522.41477585255;58545.7072714638;9151.084891510796;9392.107749763762;9477.91004034531;9488.667896623585;9578.808423831484;10166.694999150037;10518.105960993402;11417.372044537464;12146;12173.452194651261;6703.530752847254;6837.487188460886;6886.10480637514;6927.272636373209;6951.965240173767;6605.57063790852;6632.2704502504685;6652.667366631649;6663.4669226461765;6703.994400839913;4008.819603117867;4069.4302797608357;4080.0615858352744;4088.9182216355507;4093.8362465501045;1557.7585474251282;1669.1320513332998;1686.53620254431;1690.3407671008317;1699.8950682056761;756.0398294166378;763.6296396247926;836.0761358698672;885.1900511032334;886.866969954499;15621;16179.352825886832;16755.83244167567;17110.315587376615;17506.56233594145;737.5722081192895;829.8008477965245;846.8602680557763;891.6522556203086;906.3021473465526;7631.236876312435;8769;9042;9167.44995300284;9348.766280842898;443910;449805;451661;463780;465312;52437.47562524402;66537;71760.77414205844;72211;72786.63606681932;1051.8422236664562;1053.1837825685154;1053.984190237147;1075.5805235957982;1079.7786453776957;14725.410983560538;14820.48128315547;14851;15003;15272.389104435699;18532.907335463235;31189.53215701721;32658;32708.182295442803;34047.82976085104;42867.57132428761;43749.78125109354;45733.31400029069;47314.763426182646;47558.762206188745;8515.48907065578;8913.420627659441;8936.151065648754;8947.418417802823;8948.105189481;15345.901901262147;15655.608609784846;15779.28993195286;15805.769746047612;15895.761563576325;13003.284819335027;13018.2839943804;13232.669183270495;13729.519466818614;13857.4457021718;12894.484220631444;13002.479900803863;13412.366805941332;13602.115862468909;13771;13428.39572219272;13844.169349839041;13940.233287168898;13999.230042347768;14214.644633883821;8507.617157227816;8652.480851148952;8728.738137855875;8757.343199259954;8792.824143516966;8248.216419440383;8564.657413703382;8575.699850505453;9323.114304141096;9449.669261575811 04:07:27 INFO - PROCESS | 3465 | |3;mootools.html;1187.05035971223;1592.7770112184296;1654.1067823375379;1670.2734310574892;1714.4599451172871;5685.6020078594465;7045.013698082266;7195.388391986674;7196.496245262833;7211.7475888343915;7049.8590028199405;7059.329363710439;7120.145582530104;7157.427405807536;7182.281771822828;2095.7066010758545;2135.9786402135937;2137.091736012196;2138.1554286057;2139.3474990128007;2114.9577008459823;2141.6038032963875;2149.6345621244427;2161.8270538356974;2162.653975363934;2033.3391647714477;2035.542003049317;2059.289545106943;2060.0832629479887;2108.0408414171593;2065.442330570745;2077.5948690005457;2091.7803630618796;2091.9999999999923;2096.423483542023;2093.706881036656;2105.842061845368;2120.7455105387453;2121.4802373418456;2122.543653114588;7235.131784185879;7247.746328878464;7264.8547029059655;7273;7339.5963222022765;4177.22721296558;4237.110206856564;4263.765492897889;4269.87190384289;4286.721363111388;2653.973460265392;2706.336947447868;2841.105051908663;2876.942461150786;2901.158663987462;826.801567623772;830.754927296449;839.0686338164633;841.7979684875647;856.9614367353422;9917.057879501435;9935.205183585296;9937;9942.652007179713;9991.150752186073;4001.4397984282223;4022.7988600569856;4054.3715724062818;4066.7153299269357;4074.30736774749;8555;8608.139186081467;8612;8648.43785153963;8651.567421628893;4293.527711951683;4298.677599180074;4310.22415965123;4311.784410779448;4314.61168494837;3195.5526226328334;3250.6424293327714;3742.120601658608;3936.3308237599676;3951.2295102454746;3409.9659003409647;3410.6589341065696;3431.3823511768123;3440.2947395783804;3474.8783792567137;1041.3699711674478;1047.1308813684623;1050.0916707048348;1055.3509591601264;1056.8678915135608;1077.385890042668;1083.230906056693;1095.835624656308;1100.6918062942389;1118.8657361116718;6246.656433896179;6255.530835187288;6266.717997690115;6279.340669229757;6290.779822706183;412.69460599156406;428.4366058632888;430.46407223007554;435.37741030326305;435.8496318770019;5026.0199261143725;5083.923741143886;5090.821821236239;5092.770825312796;5098.566621837112;8575.6707710305;8577.614007369682;8669.523176225368;8736.912630873738;8816.691415800417;8689.957205135424;8800.119988001277;8800.823983520293;8803.251723603566;8803.383763136519;6685.431738302202;6816.420604248694;6862.588244705234;6877.105976223059;6904.896426553606;6317.241930968129;6327.715252813727;6349.174607301022;6351.872962540631;6364.07720880479;7246.565206087652;7734.845303093794;7790.727324543614;7807.804804879924;7889.171636978034;7863.9213607863185;8013.2387423194705;8027.5584842834205;8053.395995300259;8172.060213075335;5364.490373414519;5523.530499907552;5530.391656917816;6215.254169499689;6314.273858506147;6284.528660350401;6292.056191571301;6318.778842740482;6325.177726895658;6336.398042185985;5807.245058142415;5967.791127310524;6021.879562408815;6028.547858910511;6089.5737298388685;5786.161006654096;5882.823515294548;5968.850778730566;6109.694515274307;6152.292486364126;5955.851103722442;6163.8150855474405;6166.845828854314;6172.567920245539;6216.502679785516;5384.9730751346;5404.0272750905215;5418.187271909087;5418.83743487696;5429.267048948499;5766.826995190151;5781.219535362672;5804.448577385142;5804.941950580609;5812.157237200498 04:07:27 INFO - PROCESS | 3465 | |4;prototype.html;279.9062314124768;283.20702034303946;283.8921209940223;289.83189749945046;291.22679286494366;5371.140617501201;5434.673919564824;5445.346558412991;5451.236826844245;5460.808871689492;5106.285120083191;5186.273921650972;5260.868478288045;5349.54528865046;5379;4055.472788537501;4061.8375264989363;4065.796710164495;4073.307537718595;4073.5926407359175;3873.5932727063673;4057.6550993165615;4064.471618689566;4071.8982025449304;4072.7759973201464;3906.453096566483;3938.4879965604573;3984.581618930014;3995.1809878974886;4029.2747305485;3997.8400863965408;4003.019260281221;4009.5789942056103;4014.1770936958;4024.7182697211206;3461.8269086545824;3463.740219483549;3471.704905083071;3474.2356681530023;3486.9651303486894;5128.820491282787;5154.175331946871;5155.200943853672;5158.2520534522655;5164.483551644843;4567.817287308504;4651.44182698075;4745.976270118627;4747.335373047741;4757.714537127784;5647.548196144298;5652.660840349592;5653.773849046033;5659.40576239493;5660.207570940031;3918.3534716771983;3920.9607903920883;3923.784191869446;3924.7841368724994;3927.9410808837893;5949.702514874282;5959.404059594006;5960.9105863412515;5964.7315870785915;5971.641701497924;3816.2939856126704;3965.1276719121747;3974.0263635408933;3984.2230765000545;4032.798360082043;3990.10222699896;3997.980010099989;3998.3802510610903;3999.6200360965663;3999.9800000999808;4663.580277775017;4672;4672.906541869143;4675.906481870412;4677.695949763254;5676.829695109153;5679.034564124109;5686.43135686428;5688.345840228344;5688.459596338341;1293.8706129387174;1298.928558929249;1368.8904887609167;1386.5909556680804;1405.1358414575168;906.977325566866;909.0273407454093;915.4232833314969;929.3726734454216;937.7655586103474;4905.337779399735;4908.214685650279;4934.605231581465;4973.850784476472;4981.626378021663;5855.912161317584;5858.677772722541;5860.824175274749;5866.970665146647;5871.588988770745;4855;4966.776495057731;4967.155583550805;4979.975100124476;4980.651354405157;3117.34535747491;3152.1489197916435;3160.604924384452;3161.225499752575;3162.920926976798;5545.195946587723;5545.556355491551;5552.639078459887;5556.444355564411;5558.305211848519;5944.583879128506;5951.791687291011;5994.880102397928;5997.610155339889;6002.039673652282;5366.6779993200535;5536.169574563848;5545.694986775766;5551.250581171571;5552.972235138798;5836.153757705194;5841.912371314349;5843.29880414353;5855.648661080349;5856.970715146397;5683.431656834449;5705.087186050212;5710.37185909558;5712.257406537124;5714;5411.83764487066;5531.917021244765;5539.529140023144;5540.030494663337;5542.722863856871;3938.2517321708783;3943.5662077170914;3946.861859834892;3946.881593552198;3948.2498325318097;5836.095405212199;5838.0950952600715;5840.737166827418;5844.386339434468;5844.561657875762;5526.060569703241;5574.498295153456;5578.9163162553405;5603;5606.327240731139;5459.945400545944;5604.719764011702;5606.887862242814;5611.298587676541;5616.7191640416995;5487.122060470306;5493.890122197454;5500.9174862377895;5501.477359650827;5507.449255074461;5483.506484416422;5563.471470210324;5649.68926709035;5754.510866576388;5767.942320576908;5590.413006634408;5616.578756593353;5619.8876022480135;5620.690862002629;5627.296587926509 04:07:27 INFO - PROCESS | 3465 | |5;yui.html;758.2228216078521;763.1033535595674;763.5571368606209;776.4332037612546;797.1868693932186;12766.106372553913;13093.476260949563;13142.342882855866;13162.736745265089;13187.406566704498;13213.207207567553;13280.402381892814;13294.069415140944;13296.335183240824;13297.867021329785;653.1802587752388;660.2275337854721;815.6370415165254;828.2421584250434;829.1087081387502;795.6141271483355;806.0166596751983;815.7838172884191;817.3134566963749;817.8282560662268;796.3748457460895;824.1099612418574;835.3776436554745;835.9874601880946;836.506461187899;669.5714742564762;676.5500941873672;676.6549059979446;678.5724993254267;853.871919212117;497.9701217926936;616.0912653835602;626.3173141275986;629.4932579273683;629.937006299371;11153.330800152016;11176.27354221973;11180.385078820662;11228.270162439416;11278.379689117095;10341.844872326847;10729.302595331357;10778.730531736692;10819.459027048617;11102.61140860066;8721.694740684046;8785.516796576187;8869.334799890034;8967.820643587156;9005.594748236344;3175.8300014367874;3274.2305558193807;3288.490284005983;3292.456744637132;3292.571965644475;37952.24095518102;38640.420393693836;38690.806545967374;38786.61213387858;39123.80438097791;8465.111163327885;8567.443116197428;8572.657093716181;8622.024577633847;8653.307735381155;15149.318280677397;15151.318190681446;15195.468158614616;15201.6199595011;15216.163111028778;5984.551158663031;6026.969865150646;6094.39056094387;6192.102145188923;6323.936760632427;3660.7254455915913;3661.3226553087766;3669.1377526281303;3710.239400922804;3720.2745464634677;2611.3341098019882;2654.986725066401;2657.8006649501363;2660.2152365052357;2667.6532050833266;480.24601375840297;482.21399119435097;482.29344011024017;486.5864015586723;487.6099120703423;402.7724335750292;411.31105398457464;414.61026634963036;417.5365344467638;417.6992565352941;6769.647669477739;7187.820304492429;7458.440616953751;7521.0974683038385;7548.924510754822;402.94358789769456;484.76488902882073;494.8837023299522;551.3411473289381;563.9154126881001;3391.2196097048754;3399.8810041648426;3422.264213194175;3499.9675095846787;3581.516495273157;45910.31134532985;46127;46394.768026159654;46420.51846111555;46734;41792.53726119632;42243.57756422458;42487.787561061996;42617;43469.34795978063;37159.81420092882;37647.247055058746;37836.81081594629;37859.43210851839;38231;6595.505337099641;7363.889541656987;7606;7656.885146722915;7739.92260077392;29107.417851642425;29531;29689.25776855596;29784.106476804864;29880.551791723577;37343.62656373402;37707.62292377041;37924;38000;38065.61934380621;8911.643534258557;9411.200047995997;9505.097015783489;9517.952410237904;9676.516174191122;10498;10536.525856336637;10627.36235825853;10679.89320106789;10686.519106640064;9561.952190239004;9834.508274586098;9973.202143828621;10018.248631352824;10160.98390160978;9373.1564159226;9418.764530886783;9466.763330916507;9579.808403831745;9859.852102218329;8928.73213803587;9120.49837258957;9297;9379.735176730586;9380.756271059528;7827.647755850887;8516.74449766508;8900.376973612045;8934;9084.18242358191;7723.189065148304;8259.297959673255;8360.119003124404;8361.540115293717;8517.95741021291 04:07:27 INFO - PROCESS | 3465 | __end_tp_report 04:07:27 INFO - PROCESS | 3465 | __start_cc_report 04:07:27 INFO - PROCESS | 3465 | _x_x_mozilla_cycle_collect,881 04:07:27 INFO - PROCESS | 3465 | __end_cc_report 04:07:27 INFO - PROCESS | 3465 | __startTimestamp1450786047244__endTimestamp 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | ------- Summary: start ------- 04:07:27 INFO - PROCESS | 3465 | Number of tests: 6 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#0] dojo.html Cycles:165 Average:4652.92 Median:4809.40 stddev:496.94 (10.3%) stddev-sans-first:472.16 04:07:27 INFO - PROCESS | 3465 | Values: 2619.3 2702.1 2706.8 2723.7 2732.5 4577.0 4726.5 4742.0 4753.6 4757.7 4596.5 4711.6 4716.0 4733.3 4867.0 4328.3 4332.2 4339.2 4341.0 4350.7 4369.2 4394.0 4419.7 4425.4 4436.6 4109.5 4148.3 4221.3 4235.7 4276.3 4302.9 4316.3 4340.7 4353.7 4393.8 4263.6 4269.0 4276.0 4280.4 4306.2 4377.3 4505.0 4510.7 4617.7 4691.2 5071.1 5071.5 5076.9 5101.3 5119.1 5081.3 5085.0 5088.3 5094.4 5136.4 4492.7 4609.6 4707.3 4710.3 4710.5 5112.4 5122.4 5250.4 5251.6 5257.4 4993.2 5013.9 5014.9 5017.8 5019.7 4777.8 4882.3 5080.6 5096.4 5123.9 4902.1 4910.9 4975.5 5017.8 5032.0 5010.3 5019.0 5021.0 5025.7 5073.8 4178.0 4216.3 4216.7 4225.0 4258.6 3575.8 3615.2 3672.8 3673.2 3710.4 4381.8 4388.0 4393.4 4411.2 4442.9 5071.0 5094.2 5096.1 5105.5 5124.8 4207.5 4285.7 4295.0 4306.4 4398.3 4465.9 4468.5 4472.0 4479.1 4506.9 4806.4 4812.1 4814.3 4833.7 4871.9 4809.4 4924.0 4932.7 5000.5 5122.0 4807.9 4830.1 4866.9 4876.3 4919.3 4967.3 4979.5 4994.8 5002.3 5034.3 4864.1 4989.2 4996.8 5045.5 5188.6 4933.9 4969.5 4980.3 4986.1 5024.5 4944.5 4972.3 4973.2 4974.0 5018.1 4623.8 4661.1 4713.8 4731.2 4757.1 4959.0 4960.0 4970.3 4972.5 4987.5 4831.7 4839.6 4839.9 4844.7 4881.6 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#1] ext.html Cycles:180 Average:40792.06 Median:32469.59 stddev:64790.31 (199.5%) stddev-sans-first:64901.46 04:07:27 INFO - PROCESS | 3465 | Values: 509.5 514.7 521.9 549.3 565.6 26556.7 27062.5 27095.6 27110.0 27135.6 27813.6 36199.8 36897.0 36921.6 37088.4 7981.5 8121.7 8123.4 8124.8 8125.1 7173.3 7928.9 8050.4 8055.4 8056.9 7087.8 10257.0 10512.9 10531.3 10532.6 10171.2 10265.8 10280.5 10284.8 10287.1 7231.9 7433.7 10048.6 10175.9 10205.0 36777.8 37326.0 37345.1 37359.6 37420.8 2686.6 2761.7 3124.6 3172.1 3540.4 28865.0 28949.0 29158.0 29242.7 29846.6 3299.5 3359.1 3368.2 3388.4 3431.9 211476.0 212313.0 212728.0 213006.0 213494.0 53986.2 54219.2 54324.7 54609.0 54739.0 58873.4 58886.4 58956.0 59094.1 59102.7 13666.4 14093.9 14109.2 14111.5 14124.4 10568.3 10604.9 10615.7 10654.0 10666.1 18468.1 19385.9 19406.3 19419.0 19424.9 7512.6 7708.7 7731.4 7862.2 7868.7 755.7 780.9 833.3 929.3 950.2 30721.2 31673.8 31968.7 32410.2 32909.2 855.1 903.9 929.6 944.2 965.8 15595.8 15901.5 16185.4 16243.0 16488.7 313013.0 314192.0 315577.0 316650.0 317551.0 45158.0 47102.3 47948.8 49772.3 51134.7 1211.0 1230.9 1247.9 1253.7 1253.9 25877.5 26571.0 26605.6 27162.2 27178.5 36187.0 37196.6 45767.5 47386.0 47400.5 197909.0 199356.0 199925.0 201085.0 202002.0 28703.1 28938.5 29173.3 29289.4 29502.0 36920.3 38049.8 38085.8 38373.6 38550.8 32117.0 35482.5 40044.8 40193.6 40896.8 33148.2 33370.0 33623.0 33633.7 33669.0 33551.8 33704.0 33882.3 34019.0 34132.5 28733.3 29540.6 30298.2 30568.0 32529.0 23502.8 23769.2 23786.4 24048.2 24066.9 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#2] jquery.html Cycles:180 Average:24962.32 Median:4474.80 stddev:74387.19 (1662.4%) stddev-sans-first:74572.82 04:07:27 INFO - PROCESS | 3465 | Values: 301.2 302.1 306.1 308.1 312.0 12073.9 12445.3 14789.0 15025.4 15589.4 12926.6 13343.3 14789.4 16148.4 16158.6 4025.5 4977.4 5043.3 5082.0 5125.9 5020.4 5052.7 5053.6 5053.7 5058.9 4949.7 4961.9 5003.5 5004.8 5031.1 4983.7 5016.9 5019.5 5021.2 5024.3 4432.5 4473.7 4475.9 4478.4 4704.9 11534.4 11751.2 11751.6 11755.4 16311.8 1812.6 1816.4 1817.6 1859.5 1869.8 8817.9 8850.8 9035.7 9122.3 9164.5 1771.6 1780.2 1791.1 1795.4 1822.2 54463.7 55549.0 57978.0 58522.4 58545.7 9151.1 9392.1 9477.9 9488.7 9578.8 10166.7 10518.1 11417.4 12146.0 12173.5 6703.5 6837.5 6886.1 6927.3 6952.0 6605.6 6632.3 6652.7 6663.5 6704.0 4008.8 4069.4 4080.1 4088.9 4093.8 1557.8 1669.1 1686.5 1690.3 1699.9 756.0 763.6 836.1 885.2 886.9 15621.0 16179.4 16755.8 17110.3 17506.6 737.6 829.8 846.9 891.7 906.3 7631.2 8769.0 9042.0 9167.4 9348.8 443910.0 449805.0 451661.0 463780.0 465312.0 52437.5 66537.0 71760.8 72211.0 72786.6 1051.8 1053.2 1054.0 1075.6 1079.8 14725.4 14820.5 14851.0 15003.0 15272.4 18532.9 31189.5 32658.0 32708.2 34047.8 42867.6 43749.8 45733.3 47314.8 47558.8 8515.5 8913.4 8936.2 8947.4 8948.1 15345.9 15655.6 15779.3 15805.8 15895.8 13003.3 13018.3 13232.7 13729.5 13857.4 12894.5 13002.5 13412.4 13602.1 13771.0 13428.4 13844.2 13940.2 13999.2 14214.6 8507.6 8652.5 8728.7 8757.3 8792.8 8248.2 8564.7 8575.7 9323.1 9449.7 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#3] mootools.html Cycles:180 Average:4912.74 Median:5783.69 stddev:2602.12 (45.0%) stddev-sans-first:2594.35 04:07:27 INFO - PROCESS | 3465 | Values: 1187.1 1592.8 1654.1 1670.3 1714.5 5685.6 7045.0 7195.4 7196.5 7211.7 7049.9 7059.3 7120.1 7157.4 7182.3 2095.7 2136.0 2137.1 2138.2 2139.3 2115.0 2141.6 2149.6 2161.8 2162.7 2033.3 2035.5 2059.3 2060.1 2108.0 2065.4 2077.6 2091.8 2092.0 2096.4 2093.7 2105.8 2120.7 2121.5 2122.5 7235.1 7247.7 7264.9 7273.0 7339.6 4177.2 4237.1 4263.8 4269.9 4286.7 2654.0 2706.3 2841.1 2876.9 2901.2 826.8 830.8 839.1 841.8 857.0 9917.1 9935.2 9937.0 9942.7 9991.2 4001.4 4022.8 4054.4 4066.7 4074.3 8555.0 8608.1 8612.0 8648.4 8651.6 4293.5 4298.7 4310.2 4311.8 4314.6 3195.6 3250.6 3742.1 3936.3 3951.2 3410.0 3410.7 3431.4 3440.3 3474.9 1041.4 1047.1 1050.1 1055.4 1056.9 1077.4 1083.2 1095.8 1100.7 1118.9 6246.7 6255.5 6266.7 6279.3 6290.8 412.7 428.4 430.5 435.4 435.8 5026.0 5083.9 5090.8 5092.8 5098.6 8575.7 8577.6 8669.5 8736.9 8816.7 8690.0 8800.1 8800.8 8803.3 8803.4 6685.4 6816.4 6862.6 6877.1 6904.9 6317.2 6327.7 6349.2 6351.9 6364.1 7246.6 7734.8 7790.7 7807.8 7889.2 7863.9 8013.2 8027.6 8053.4 8172.1 5364.5 5523.5 5530.4 6215.3 6314.3 6284.5 6292.1 6318.8 6325.2 6336.4 5807.2 5967.8 6021.9 6028.5 6089.6 5786.2 5882.8 5968.9 6109.7 6152.3 5955.9 6163.8 6166.8 6172.6 6216.5 5385.0 5404.0 5418.2 5418.8 5429.3 5766.8 5781.2 5804.4 5804.9 5812.2 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#4] prototype.html Cycles:180 Average:4644.30 Median:5375.07 stddev:1399.79 (26.0%) stddev-sans-first:1364.85 04:07:27 INFO - PROCESS | 3465 | Values: 279.9 283.2 283.9 289.8 291.2 5371.1 5434.7 5445.3 5451.2 5460.8 5106.3 5186.3 5260.9 5349.5 5379.0 4055.5 4061.8 4065.8 4073.3 4073.6 3873.6 4057.7 4064.5 4071.9 4072.8 3906.5 3938.5 3984.6 3995.2 4029.3 3997.8 4003.0 4009.6 4014.2 4024.7 3461.8 3463.7 3471.7 3474.2 3487.0 5128.8 5154.2 5155.2 5158.3 5164.5 4567.8 4651.4 4746.0 4747.3 4757.7 5647.5 5652.7 5653.8 5659.4 5660.2 3918.4 3921.0 3923.8 3924.8 3927.9 5949.7 5959.4 5960.9 5964.7 5971.6 3816.3 3965.1 3974.0 3984.2 4032.8 3990.1 3998.0 3998.4 3999.6 4000.0 4663.6 4672.0 4672.9 4675.9 4677.7 5676.8 5679.0 5686.4 5688.3 5688.5 1293.9 1298.9 1368.9 1386.6 1405.1 907.0 909.0 915.4 929.4 937.8 4905.3 4908.2 4934.6 4973.9 4981.6 5855.9 5858.7 5860.8 5867.0 5871.6 4855.0 4966.8 4967.2 4980.0 4980.7 3117.3 3152.1 3160.6 3161.2 3162.9 5545.2 5545.6 5552.6 5556.4 5558.3 5944.6 5951.8 5994.9 5997.6 6002.0 5366.7 5536.2 5545.7 5551.3 5553.0 5836.2 5841.9 5843.3 5855.6 5857.0 5683.4 5705.1 5710.4 5712.3 5714.0 5411.8 5531.9 5539.5 5540.0 5542.7 3938.3 3943.6 3946.9 3946.9 3948.2 5836.1 5838.1 5840.7 5844.4 5844.6 5526.1 5574.5 5578.9 5603.0 5606.3 5459.9 5604.7 5606.9 5611.3 5616.7 5487.1 5493.9 5500.9 5501.5 5507.4 5483.5 5563.5 5649.7 5754.5 5767.9 5590.4 5616.6 5619.9 5620.7 5627.3 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - PROCESS | 3465 | [#5] yui.html Cycles:180 Average:11635.77 Median:483.53 stddev:13038.37 (2696.5%) stddev-sans-first:13049.36 04:07:27 INFO - PROCESS | 3465 | Values: 758.2 763.1 763.6 776.4 797.2 12766.1 13093.5 13142.3 13162.7 13187.4 13213.2 13280.4 13294.1 13296.3 13297.9 653.2 660.2 815.6 828.2 829.1 795.6 806.0 815.8 817.3 817.8 796.4 824.1 835.4 836.0 836.5 669.6 676.6 676.7 678.6 853.9 498.0 616.1 626.3 629.5 629.9 11153.3 11176.3 11180.4 11228.3 11278.4 10341.8 10729.3 10778.7 10819.5 11102.6 8721.7 8785.5 8869.3 8967.8 9005.6 3175.8 3274.2 3288.5 3292.5 3292.6 37952.2 38640.4 38690.8 38786.6 39123.8 8465.1 8567.4 8572.7 8622.0 8653.3 15149.3 15151.3 15195.5 15201.6 15216.2 5984.6 6027.0 6094.4 6192.1 6323.9 3660.7 3661.3 3669.1 3710.2 3720.3 2611.3 2655.0 2657.8 2660.2 2667.7 480.2 482.2 482.3 486.6 487.6 402.8 411.3 414.6 417.5 417.7 6769.6 7187.8 7458.4 7521.1 7548.9 402.9 484.8 494.9 551.3 563.9 3391.2 3399.9 3422.3 3500.0 3581.5 45910.3 46127.0 46394.8 46420.5 46734.0 41792.5 42243.6 42487.8 42617.0 43469.3 37159.8 37647.2 37836.8 37859.4 38231.0 6595.5 7363.9 7606.0 7656.9 7739.9 29107.4 29531.0 29689.3 29784.1 29880.6 37343.6 37707.6 37924.0 38000.0 38065.6 8911.6 9411.2 9505.1 9518.0 9676.5 10498.0 10536.5 10627.4 10679.9 10686.5 9562.0 9834.5 9973.2 10018.2 10161.0 9373.2 9418.8 9466.8 9579.8 9859.9 8928.7 9120.5 9297.0 9379.7 9380.8 7827.6 8516.7 8900.4 8934.0 9084.2 7723.2 8259.3 8360.1 8361.5 8518.0 04:07:27 INFO - PROCESS | 3465 | -------- Summary: end -------- 04:07:27 INFO - PROCESS | 3465 | 04:07:27 INFO - TEST-INFO | 3465: exit 0 04:07:27 INFO - TEST-OK | dromaeo_css | took 1121619ms 04:07:27 INFO - TEST-START | kraken 04:07:27 INFO - operating with platform_type : linux_ 04:07:27 INFO - Initialising browser for kraken test... 04:07:27 INFO - TEST-INFO | started process 3652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3WMwK/profile http://localhost:35165/getInfo.html) 04:07:32 INFO - PROCESS | 3652 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:07:32 INFO - PROCESS | 3652 | __metrics Screen width/height:1600/1200 04:07:32 INFO - PROCESS | 3652 | colorDepth:24 04:07:32 INFO - PROCESS | 3652 | Browser inner width/height: 1024/697 04:07:32 INFO - PROCESS | 3652 | __metrics 04:07:32 INFO - PROCESS | 3652 | 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:07:32 INFO - PROCESS | 3652 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:33 INFO - TEST-INFO | 3652: exit 0 04:07:33 INFO - Browser initialized. 04:07:33 INFO - Running cycle 1/1 for kraken test... 04:07:33 INFO - TEST-INFO | started process 3733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3WMwK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:45 INFO - PROCESS | 3733 | RSS: Main: 150949888 04:07:45 INFO - PROCESS | 3733 | 04:07:48 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:48 INFO - PROCESS | 3733 | RSS: Main: 186871808 04:07:48 INFO - PROCESS | 3733 | 04:07:51 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-dft) 04:07:51 INFO - PROCESS | 3733 | RSS: Main: 176443392 04:07:51 INFO - PROCESS | 3733 | 04:07:54 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-fft) 04:07:55 INFO - PROCESS | 3733 | RSS: Main: 162578432 04:07:55 INFO - PROCESS | 3733 | 04:07:57 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-oscillator) 04:07:58 INFO - PROCESS | 3733 | RSS: Main: 163344384 04:07:58 INFO - PROCESS | 3733 | 04:08:00 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:00 INFO - PROCESS | 3733 | RSS: Main: 164528128 04:08:00 INFO - PROCESS | 3733 | 04:08:03 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:04 INFO - PROCESS | 3733 | RSS: Main: 164360192 04:08:04 INFO - PROCESS | 3733 | 04:08:07 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:08 INFO - PROCESS | 3733 | RSS: Main: 165130240 04:08:08 INFO - PROCESS | 3733 | 04:08:11 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35165/tests/kraken/driver.html?testName=json-parse-financial) 04:08:11 INFO - PROCESS | 3733 | RSS: Main: 166428672 04:08:11 INFO - PROCESS | 3733 | 04:08:13 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:14 INFO - PROCESS | 3733 | RSS: Main: 176816128 04:08:14 INFO - PROCESS | 3733 | 04:08:16 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:16 INFO - PROCESS | 3733 | RSS: Main: 175591424 04:08:16 INFO - PROCESS | 3733 | 04:08:19 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:19 INFO - PROCESS | 3733 | RSS: Main: 187252736 04:08:19 INFO - PROCESS | 3733 | 04:08:22 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:22 INFO - PROCESS | 3733 | RSS: Main: 190627840 04:08:22 INFO - PROCESS | 3733 | 04:08:25 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:26 INFO - PROCESS | 3733 | RSS: Main: 187633664 04:08:26 INFO - PROCESS | 3733 | 04:08:27 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35165/tests/kraken/driver.html?testName=ai-astar) 04:08:28 INFO - PROCESS | 3733 | RSS: Main: 246542336 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | __start_tp_report 04:08:28 INFO - PROCESS | 3733 | _x_x_mozilla_page_load 04:08:28 INFO - PROCESS | 3733 | _x_x_mozilla_page_load_details 04:08:28 INFO - PROCESS | 3733 | |i|pagename|runs| 04:08:28 INFO - PROCESS | 3733 | |0;ai-astar;112;114;105;112;112;113;102;112;111;119 04:08:28 INFO - PROCESS | 3733 | |1;audio-beat-detection;151;131;151;164;140;151;166;133;170;131 04:08:28 INFO - PROCESS | 3733 | |2;audio-dft;161;160;161;163;160;161;162;163;163;164 04:08:28 INFO - PROCESS | 3733 | |3;audio-fft;72;72;83;91;72;73;71;121;88;71 04:08:28 INFO - PROCESS | 3733 | |4;audio-oscillator;95;96;135;95;95;96;135;95;96;132 04:08:28 INFO - PROCESS | 3733 | |5;imaging-gaussian-blur;110;109;109;109;109;111;109;109;109;109 04:08:28 INFO - PROCESS | 3733 | |6;imaging-darkroom;147;147;146;146;147;147;146;147;146;146 04:08:28 INFO - PROCESS | 3733 | |7;imaging-desaturate;96;95;95;96;96;95;95;95;95;96 04:08:28 INFO - PROCESS | 3733 | |8;json-parse-financial;71;71;69;71;72;72;71;79;69;69 04:08:28 INFO - PROCESS | 3733 | |9;json-stringify-tinderbox;68;68;67;67;68;69;68;69;68;68 04:08:28 INFO - PROCESS | 3733 | |10;stanford-crypto-aes;344;83;82;82;82;92;82;82;83;97 04:08:28 INFO - PROCESS | 3733 | |11;stanford-crypto-ccm;131;127;127;125;132;124;121;124;133;120 04:08:28 INFO - PROCESS | 3733 | |12;stanford-crypto-pbkdf2;140;147;144;145;172;135;148;147;147;141 04:08:28 INFO - PROCESS | 3733 | |13;stanford-crypto-sha256-iterative;71;72;70;70;70;69;69;70;71;70 04:08:28 INFO - PROCESS | 3733 | __end_tp_report 04:08:28 INFO - PROCESS | 3733 | __start_cc_report 04:08:28 INFO - PROCESS | 3733 | _x_x_mozilla_cycle_collect,989 04:08:28 INFO - PROCESS | 3733 | __end_cc_report 04:08:28 INFO - PROCESS | 3733 | __startTimestamp1450786108090__endTimestamp 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | ------- Summary: start ------- 04:08:28 INFO - PROCESS | 3733 | Number of tests: 14 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:4.69 (4.2%) stddev-sans-first:4.96 04:08:28 INFO - PROCESS | 3733 | Values: 112.0 114.0 105.0 112.0 112.0 113.0 102.0 112.0 111.0 119.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:151.00 stddev:14.73 (9.8%) stddev-sans-first:15.60 04:08:28 INFO - PROCESS | 3733 | Values: 151.0 131.0 151.0 164.0 140.0 151.0 166.0 133.0 170.0 131.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 04:08:28 INFO - PROCESS | 3733 | Values: 161.0 160.0 161.0 163.0 160.0 161.0 162.0 163.0 163.0 164.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#3] audio-fft Cycles:10 Average:81.40 Median:72.50 stddev:15.84 (21.8%) stddev-sans-first:16.43 04:08:28 INFO - PROCESS | 3733 | Values: 72.0 72.0 83.0 91.0 72.0 73.0 71.0 121.0 88.0 71.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:95.00 stddev:18.65 (19.6%) stddev-sans-first:19.27 04:08:28 INFO - PROCESS | 3733 | Values: 95.0 96.0 135.0 95.0 95.0 96.0 135.0 95.0 96.0 132.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 04:08:28 INFO - PROCESS | 3733 | Values: 110.0 109.0 109.0 109.0 109.0 111.0 109.0 109.0 109.0 109.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:08:28 INFO - PROCESS | 3733 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:08:28 INFO - PROCESS | 3733 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.91 (4.1%) stddev-sans-first:3.09 04:08:28 INFO - PROCESS | 3733 | Values: 71.0 71.0 69.0 71.0 72.0 72.0 71.0 79.0 69.0 69.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:08:28 INFO - PROCESS | 3733 | Values: 68.0 68.0 67.0 67.0 68.0 69.0 68.0 69.0 68.0 68.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#10] stanford-crypto-aes Cycles:10 Average:110.90 Median:82.50 stddev:82.07 (99.5%) stddev-sans-first:5.55 04:08:28 INFO - PROCESS | 3733 | Values: 344.0 83.0 82.0 82.0 82.0 92.0 82.0 82.0 83.0 97.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:127.00 stddev:4.48 (3.5%) stddev-sans-first:4.43 04:08:28 INFO - PROCESS | 3733 | Values: 131.0 127.0 127.0 125.0 132.0 124.0 121.0 124.0 133.0 120.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:147.00 stddev:9.81 (6.7%) stddev-sans-first:10.11 04:08:28 INFO - PROCESS | 3733 | Values: 140.0 147.0 144.0 145.0 172.0 135.0 148.0 147.0 147.0 141.0 04:08:28 INFO - PROCESS | 3733 | 04:08:28 INFO - PROCESS | 3733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 04:08:28 INFO - PROCESS | 3733 | Values: 71.0 72.0 70.0 70.0 70.0 69.0 69.0 70.0 71.0 70.0 04:08:28 INFO - PROCESS | 3733 | -------- Summary: end -------- 04:08:28 INFO - PROCESS | 3733 | 04:08:29 INFO - TEST-INFO | 3733: exit 0 04:08:29 INFO - TEST-OK | kraken | took 61094ms 04:08:29 INFO - TEST-START | v8_7 04:08:29 INFO - operating with platform_type : linux_ 04:08:29 INFO - Initialising browser for v8_7 test... 04:08:29 INFO - TEST-INFO | started process 3982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDwtzl/profile http://localhost:35165/getInfo.html) 04:08:33 INFO - PROCESS | 3982 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:08:33 INFO - PROCESS | 3982 | __metrics Screen width/height:1600/1200 04:08:33 INFO - PROCESS | 3982 | colorDepth:24 04:08:33 INFO - PROCESS | 3982 | Browser inner width/height: 1024/697 04:08:33 INFO - PROCESS | 3982 | __metrics 04:08:33 INFO - PROCESS | 3982 | 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:08:33 INFO - PROCESS | 3982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:34 INFO - TEST-INFO | 3982: exit 0 04:08:34 INFO - Browser initialized. 04:08:34 INFO - Running cycle 1/1 for v8_7 test... 04:08:34 INFO - TEST-INFO | started process 4063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDwtzl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:46 INFO - PROCESS | 4063 | RSS: Main: 150048768 04:08:46 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | Cycle 1(1): loaded http://localhost:35165/tests/v8_7/run.html (next: http://localhost:35165/tests/v8_7/run.html) 04:09:08 INFO - PROCESS | 4063 | RSS: Main: 450129920 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | __start_tp_report 04:09:08 INFO - PROCESS | 4063 | _x_x_mozilla_page_load 04:09:08 INFO - PROCESS | 4063 | _x_x_mozilla_page_load_details 04:09:08 INFO - PROCESS | 4063 | |i|pagename|runs| 04:09:08 INFO - PROCESS | 4063 | |0;Richards;168.12373907195695 04:09:08 INFO - PROCESS | 4063 | |1;DeltaBlue;185.73551263001485 04:09:08 INFO - PROCESS | 4063 | |2;Encrypt;278.2415136338342 04:09:08 INFO - PROCESS | 4063 | |3;Decrypt;5181.347150259067 04:09:08 INFO - PROCESS | 4063 | |4;RayTrace;1978.2608695652175 04:09:08 INFO - PROCESS | 4063 | |5;Earley;793.0214115781126 04:09:08 INFO - PROCESS | 4063 | |6;Boyer;12144.578313253012 04:09:08 INFO - PROCESS | 4063 | |7;RegExp;26526.315789473683 04:09:08 INFO - PROCESS | 4063 | |8;Splay;622.66500622665 04:09:08 INFO - PROCESS | 4063 | |9;NavierStokes;4840.579710144928 04:09:08 INFO - PROCESS | 4063 | __end_tp_report 04:09:08 INFO - PROCESS | 4063 | __startTimestamp1450786148317__endTimestamp 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | ------- Summary: start ------- 04:09:08 INFO - PROCESS | 4063 | Number of tests: 10 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#0] Richards Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 168.1 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#1] DeltaBlue Cycles:1 Average:185.74 Median:185.74 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 185.7 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 278.2 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 5181.3 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 1978.3 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 793.0 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 12144.6 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 26526.3 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 622.7 04:09:08 INFO - PROCESS | 4063 | 04:09:08 INFO - PROCESS | 4063 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:09:08 INFO - PROCESS | 4063 | Values: 4840.6 04:09:08 INFO - PROCESS | 4063 | -------- Summary: end -------- 04:09:08 INFO - PROCESS | 4063 | 04:09:09 INFO - TEST-INFO | 4063: exit 0 04:09:09 INFO - TEST-OK | v8_7 | took 40216ms 04:09:09 INFO - SUITE-END | took 1222s 04:09:09 INFO - Completed test suite (00:20:23) 04:09:09 INFO - Working with test: dromaeo_css 04:09:09 INFO - Generating results file: dromaeo_css 04:09:09 INFO - Working with test: kraken 04:09:09 INFO - Generating results file: kraken 04:09:09 INFO - javascript benchmark 04:09:09 INFO - Working with test: v8_7 04:09:09 INFO - Generating results file: v8_7 04:09:09 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:09:09 INFO - process_Request line: dromaeo_css 6196.64 graph.html#tests=[[72,132,35]] 04:09:09 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:09 INFO - process_Request line: kraken 1554.90 graph.html#tests=[[232,132,35]] 04:09:09 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:09 INFO - process_Request line: v8_7 19760.72 graph.html#tests=[[230,132,35]] 04:09:09 INFO - RETURN: dromaeo_css: 6196.64 04:09:09 INFO - RETURN: kraken: 1554.90 04:09:09 INFO - RETURN: v8_7: 19760.72 04:09:09 INFO - javascript benchmark 04:09:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.318977065963, 2702.1218104116156, 2706.7834573234145, 2723.673159220893, 2732.52180868348, 4577.0, 4726.527347265272, 4742.027884283722, 4753.643476739241, 4757.690750101246, 4596.49438561758, 4711.599514041302, 4715.976420117903, 4733.337332773414, 4867.0265946810605, 4328.329108988112, 4332.155229730204, 4339.218940590692, 4341.02326976431, 4350.673699472536, 4369.213541562502, 4394.033312671208, 4419.712718673276, 4425.446819147606, 4436.622887054604, 4109.506859176888, 4148.336266197424, 4221.303484924983, 4235.745855248695, 4276.294411422112, 4302.892427689301, 4316.266234740102, 4340.696151269412, 4353.695241333108, 4393.824247030147, 4263.616274535276, 4269.0, 4276.0, 4280.400743895857, 4306.20335237982, 4377.299632058855, 4505.0, 4510.706804057726, 4617.676762626617, 4691.249400095969, 5071.137906555858, 5071.518205770446, 5076.949230507722, 5101.336826212606, 5119.129747942859, 5081.263216833576, 5084.9745751271375, 5088.313077734496, 5094.3886733591835, 5136.409312929024, 4492.663050271178, 4609.60818330439, 4707.270373092176, 4710.3405523226775, 4710.481846996862, 5112.4120726116225, 5122.410922743858, 5250.448702886142, 5251.553617942442, 5257.395399529027, 4993.151164302078, 5013.924791128136, 5014.924776128361, 5017.80672964692, 5019.723915184627, 4777.761111944389, 4882.292067650171, 5080.568151707146, 5096.413912400048, 5123.923141152885, 4902.1176188285735, 4910.926336104962, 4975.4527002029745, 5017.774200161001, 5032.0, 5010.323606313101, 5019.0463811875625, 5021.046001259749, 5025.723585202776, 5073.822416215415, 4178.039051018282, 4216.325387937915, 4216.7259128156575, 4224.964883603476, 4258.574142585717, 3575.76757510761, 3615.186583018852, 3672.8347224374966, 3673.1918977824835, 3710.406334986443, 4381.824727010884, 4387.978060109679, 4393.384926110347, 4411.18393097278, 4442.8667139985855, 5070.974645126751, 5094.1849304111165, 5096.05722941257, 5105.463926287686, 5124.8206312778875, 4207.495100587949, 4285.742855428684, 4294.9785251073545, 4306.375575541529, 4398.340248962617, 4465.866024019285, 4468.530804265571, 4471.977640111779, 4479.081788233404, 4506.887327816831, 4806.351142595845, 4812.133815913169, 4814.277858321279, 4833.685810422311, 4871.902561948741, 4809.398825146856, 4923.975380123076, 4932.679375840559, 5000.524950129732, 5121.950000249865, 4807.879803004953, 4830.058138662927, 4866.865456942959, 4876.317315575893, 4919.335889654851, 4967.329410529533, 4979.477154898684, 4994.775235114356, 5002.349694539686, 5034.270030845433, 4864.075825593126, 4989.226669866177, 4996.800127994839, 5045.520675535819, 5188.558972487381, 4933.9013219736125, 4969.45336013031, 4980.32765576657, 4986.052649996489, 5024.522670346311, 4944.505549445027, 4972.3038774572315, 4973.154563724248, 4974.0, 5018.071656743514, 4623.768811559476, 4661.067786442793, 4713.7643117844655, 4731.243001119804, 4757.09615173116, 4958.975205123951, 4959.975200123977, 4970.279309500174, 4972.477889821661, 4987.526185012418, 4831.710097394168, 4839.612830973584, 4839.903201935871, 4844.660873738804, 4881.585065269492], "unit": "score", "name": "dojo.html", "value": 4621.441561010053}, {"lowerIsBetter": false, "replicates": [509.4676063513628, 514.6937572144573, 521.9008388406203, 549.2776998247305, 565.581469712413, 26556.734432655667, 27062.45875082497, 27095.593566096526, 27110.0, 27135.592966105498, 27813.582796258073, 36199.81900090496, 36897.0, 36921.630783692155, 37088.44367334485, 7981.521108733466, 8121.715739949103, 8123.390745694067, 8124.837503249932, 8125.06561745398, 7173.318534739192, 7928.8810667840025, 8050.396220283473, 8055.355571554262, 8056.879146812803, 7087.8228044298785, 10257.0, 10512.894871051307, 10531.31546449482, 10532.578696852117, 10171.18630509561, 10265.846012309821, 10280.537375818107, 10284.794304113952, 10287.125594324454, 7231.89152162718, 7433.665485053186, 10048.648297309632, 10175.898241017569, 10205.0, 36777.81611091954, 37326.0, 37345.06637334089, 37359.626403735885, 37420.81289593535, 2686.6238726578295, 2761.7222131419558, 3124.5938028056435, 3172.0588015670996, 3540.415831387818, 28865.0, 28949.0, 29158.0, 29242.70757292421, 29846.552301715274, 3299.5215693724276, 3359.1434184283094, 3368.208471009311, 3388.423967925459, 3431.9485207721905, 211476.0, 212313.0, 212728.0, 213006.0, 213494.0, 53986.19020714692, 54219.18671219935, 54324.72837635787, 54609.0, 54739.0, 58873.41126588765, 58886.41113588895, 58956.0, 59094.11358829621, 59102.70448647729, 13666.385012674453, 14093.929530352487, 14109.153450792985, 14111.506097286545, 14124.364403601863, 10568.260221784401, 10604.94697526523, 10615.734606634896, 10654.04113629777, 10666.14670826332, 18468.11819595669, 19385.903070484557, 19406.320778772675, 19419.0, 19424.902875485815, 7512.624368781649, 7708.730194443167, 7731.381489480828, 7862.213778622092, 7868.72459463916, 755.6561764397186, 780.8984831971808, 833.3458235285393, 929.2658799548282, 950.2160717408166, 30721.231969200948, 31673.8416307917, 31968.68031319657, 32410.189745256557, 32909.17727056843, 855.1363123245443, 903.8870141232346, 929.5584597316356, 944.1644144931647, 965.7778710896533, 15595.844041559667, 15901.52295431139, 16185.4335098271, 16243.0, 16488.726609759105, 313013.0, 314192.0, 315577.0, 316650.0, 317551.0, 45158.0, 47102.29346559804, 47948.760256199195, 49772.253416198786, 51134.74432627813, 1210.9636710898687, 1230.9015278777676, 1247.9126461147632, 1253.7116463213329, 1253.924764514132, 25877.482450351265, 26571.0, 26605.600915985888, 27162.185134445997, 27178.456430870876, 36187.0, 37196.62803371932, 45767.54232457633, 47386.0, 47400.525994740994, 197909.0, 199356.0, 199925.0, 201085.0, 202002.0, 28703.12046952065, 28938.514530247845, 29173.270668233465, 29289.414211716074, 29502.0, 36920.26159476849, 38049.80975095107, 38085.80957095197, 38373.61626383701, 38550.80724596359, 32117.0, 35482.46776298306, 40044.79977600093, 40193.59806401899, 40896.79551602223, 33148.1712957178, 33370.0, 33623.0, 33633.663663363055, 33669.0, 33551.83224083864, 33704.0, 33882.32235355328, 34019.0, 34132.488012680325, 28733.28166795847, 29540.556891646214, 30298.24254393658, 30568.0, 32529.0, 23502.764972350058, 23769.16807911715, 23786.40533986664, 24048.15831445891, 24066.87966560156], "unit": "score", "name": "ext.html", "value": 17183.510244251564}, {"lowerIsBetter": false, "replicates": [301.16877418325413, 302.1373977294823, 306.08175473579263, 308.0604157320174, 312.04980833362407, 12073.939630301837, 12445.315507647076, 14789.0, 15025.398984040652, 15589.376424943002, 12926.612201633967, 13343.332833358318, 14789.408423663068, 16148.434804781835, 16158.596035099128, 4025.496812898388, 4977.402711674604, 5043.268726034723, 5081.974590127063, 5125.897482050356, 5020.422651395082, 5052.747362631872, 5053.5957123430035, 5053.6715113517685, 5058.949410505885, 4949.674833448255, 4961.8511444656715, 5003.524665156804, 5004.84985450437, 5031.11955407804, 4983.651144419892, 5016.949830501685, 5019.472955339674, 5021.17150670139, 5024.296598476198, 4432.49026361966, 4473.686841921067, 4475.910481790378, 4478.350639157304, 4704.858854234379, 11534.365609891453, 11751.236169648946, 11751.647450576496, 11755.412229388496, 16311.83688163115, 1812.5559237986777, 1816.4369045595909, 1817.6364727054643, 1859.4979355574055, 1869.7943226245102, 8817.905410465517, 8850.778730531723, 9035.728928132101, 9122.270218382513, 9164.450132991975, 1771.6279581287945, 1780.1811166863258, 1791.113398867569, 1795.353672677835, 1822.1891258390021, 54463.72768136134, 55549.0, 57978.0, 58522.41477585255, 58545.7072714638, 9151.084891510796, 9392.107749763762, 9477.91004034531, 9488.667896623585, 9578.808423831484, 10166.694999150037, 10518.105960993402, 11417.372044537464, 12146.0, 12173.452194651261, 6703.530752847254, 6837.487188460886, 6886.10480637514, 6927.272636373209, 6951.965240173767, 6605.57063790852, 6632.2704502504685, 6652.667366631649, 6663.4669226461765, 6703.994400839913, 4008.819603117867, 4069.4302797608357, 4080.0615858352744, 4088.9182216355507, 4093.8362465501045, 1557.7585474251282, 1669.1320513332998, 1686.53620254431, 1690.3407671008317, 1699.8950682056761, 756.0398294166378, 763.6296396247926, 836.0761358698672, 885.1900511032334, 886.866969954499, 15621.0, 16179.352825886832, 16755.83244167567, 17110.315587376615, 17506.56233594145, 737.5722081192895, 829.8008477965245, 846.8602680557763, 891.6522556203086, 906.3021473465526, 7631.236876312435, 8769.0, 9042.0, 9167.44995300284, 9348.766280842898, 443910.0, 449805.0, 451661.0, 463780.0, 465312.0, 52437.47562524402, 66537.0, 71760.77414205844, 72211.0, 72786.63606681932, 1051.8422236664562, 1053.1837825685154, 1053.984190237147, 1075.5805235957982, 1079.7786453776957, 14725.410983560538, 14820.48128315547, 14851.0, 15003.0, 15272.389104435699, 18532.907335463235, 31189.53215701721, 32658.0, 32708.182295442803, 34047.82976085104, 42867.57132428761, 43749.78125109354, 45733.31400029069, 47314.763426182646, 47558.762206188745, 8515.48907065578, 8913.420627659441, 8936.151065648754, 8947.418417802823, 8948.105189481, 15345.901901262147, 15655.608609784846, 15779.28993195286, 15805.769746047612, 15895.761563576325, 13003.284819335027, 13018.2839943804, 13232.669183270495, 13729.519466818614, 13857.4457021718, 12894.484220631444, 13002.479900803863, 13412.366805941332, 13602.115862468909, 13771.0, 13428.39572219272, 13844.169349839041, 13940.233287168898, 13999.230042347768, 14214.644633883821, 8507.617157227816, 8652.480851148952, 8728.738137855875, 8757.343199259954, 8792.824143516966, 8248.216419440383, 8564.657413703382, 8575.699850505453, 9323.114304141096, 9449.669261575811], "unit": "score", "name": "jquery.html", "value": 7909.121016921625}, {"lowerIsBetter": false, "replicates": [1187.05035971223, 1592.7770112184296, 1654.1067823375379, 1670.2734310574892, 1714.4599451172871, 5685.6020078594465, 7045.013698082266, 7195.388391986674, 7196.496245262833, 7211.7475888343915, 7049.8590028199405, 7059.329363710439, 7120.145582530104, 7157.427405807536, 7182.281771822828, 2095.7066010758545, 2135.9786402135937, 2137.091736012196, 2138.1554286057, 2139.3474990128007, 2114.9577008459823, 2141.6038032963875, 2149.6345621244427, 2161.8270538356974, 2162.653975363934, 2033.3391647714477, 2035.542003049317, 2059.289545106943, 2060.0832629479887, 2108.0408414171593, 2065.442330570745, 2077.5948690005457, 2091.7803630618796, 2091.9999999999923, 2096.423483542023, 2093.706881036656, 2105.842061845368, 2120.7455105387453, 2121.4802373418456, 2122.543653114588, 7235.131784185879, 7247.746328878464, 7264.8547029059655, 7273.0, 7339.5963222022765, 4177.22721296558, 4237.110206856564, 4263.765492897889, 4269.87190384289, 4286.721363111388, 2653.973460265392, 2706.336947447868, 2841.105051908663, 2876.942461150786, 2901.158663987462, 826.801567623772, 830.754927296449, 839.0686338164633, 841.7979684875647, 856.9614367353422, 9917.057879501435, 9935.205183585296, 9937.0, 9942.652007179713, 9991.150752186073, 4001.4397984282223, 4022.7988600569856, 4054.3715724062818, 4066.7153299269357, 4074.30736774749, 8555.0, 8608.139186081467, 8612.0, 8648.43785153963, 8651.567421628893, 4293.527711951683, 4298.677599180074, 4310.22415965123, 4311.784410779448, 4314.61168494837, 3195.5526226328334, 3250.6424293327714, 3742.120601658608, 3936.3308237599676, 3951.2295102454746, 3409.9659003409647, 3410.6589341065696, 3431.3823511768123, 3440.2947395783804, 3474.8783792567137, 1041.3699711674478, 1047.1308813684623, 1050.0916707048348, 1055.3509591601264, 1056.8678915135608, 1077.385890042668, 1083.230906056693, 1095.835624656308, 1100.6918062942389, 1118.8657361116718, 6246.656433896179, 6255.530835187288, 6266.717997690115, 6279.340669229757, 6290.779822706183, 412.69460599156406, 428.4366058632888, 430.46407223007554, 435.37741030326305, 435.8496318770019, 5026.0199261143725, 5083.923741143886, 5090.821821236239, 5092.770825312796, 5098.566621837112, 8575.6707710305, 8577.614007369682, 8669.523176225368, 8736.912630873738, 8816.691415800417, 8689.957205135424, 8800.119988001277, 8800.823983520293, 8803.251723603566, 8803.383763136519, 6685.431738302202, 6816.420604248694, 6862.588244705234, 6877.105976223059, 6904.896426553606, 6317.241930968129, 6327.715252813727, 6349.174607301022, 6351.872962540631, 6364.07720880479, 7246.565206087652, 7734.845303093794, 7790.727324543614, 7807.804804879924, 7889.171636978034, 7863.9213607863185, 8013.2387423194705, 8027.5584842834205, 8053.395995300259, 8172.060213075335, 5364.490373414519, 5523.530499907552, 5530.391656917816, 6215.254169499689, 6314.273858506147, 6284.528660350401, 6292.056191571301, 6318.778842740482, 6325.177726895658, 6336.398042185985, 5807.245058142415, 5967.791127310524, 6021.879562408815, 6028.547858910511, 6089.5737298388685, 5786.161006654096, 5882.823515294548, 5968.850778730566, 6109.694515274307, 6152.292486364126, 5955.851103722442, 6163.8150855474405, 6166.845828854314, 6172.567920245539, 6216.502679785516, 5384.9730751346, 5404.0272750905215, 5418.187271909087, 5418.83743487696, 5429.267048948499, 5766.826995190151, 5781.219535362672, 5804.448577385142, 5804.941950580609, 5812.157237200498], "unit": "score", "name": "mootools.html", "value": 3964.5354064255994}, {"lowerIsBetter": false, "replicates": [279.9062314124768, 283.20702034303946, 283.8921209940223, 289.83189749945046, 291.22679286494366, 5371.140617501201, 5434.673919564824, 5445.346558412991, 5451.236826844245, 5460.808871689492, 5106.285120083191, 5186.273921650972, 5260.868478288045, 5349.54528865046, 5379.0, 4055.472788537501, 4061.8375264989363, 4065.796710164495, 4073.307537718595, 4073.5926407359175, 3873.5932727063673, 4057.6550993165615, 4064.471618689566, 4071.8982025449304, 4072.7759973201464, 3906.453096566483, 3938.4879965604573, 3984.581618930014, 3995.1809878974886, 4029.2747305485, 3997.8400863965408, 4003.019260281221, 4009.5789942056103, 4014.1770936958, 4024.7182697211206, 3461.8269086545824, 3463.740219483549, 3471.704905083071, 3474.2356681530023, 3486.9651303486894, 5128.820491282787, 5154.175331946871, 5155.200943853672, 5158.2520534522655, 5164.483551644843, 4567.817287308504, 4651.44182698075, 4745.976270118627, 4747.335373047741, 4757.714537127784, 5647.548196144298, 5652.660840349592, 5653.773849046033, 5659.40576239493, 5660.207570940031, 3918.3534716771983, 3920.9607903920883, 3923.784191869446, 3924.7841368724994, 3927.9410808837893, 5949.702514874282, 5959.404059594006, 5960.9105863412515, 5964.7315870785915, 5971.641701497924, 3816.2939856126704, 3965.1276719121747, 3974.0263635408933, 3984.2230765000545, 4032.798360082043, 3990.10222699896, 3997.980010099989, 3998.3802510610903, 3999.6200360965663, 3999.9800000999808, 4663.580277775017, 4672.0, 4672.906541869143, 4675.906481870412, 4677.695949763254, 5676.829695109153, 5679.034564124109, 5686.43135686428, 5688.345840228344, 5688.459596338341, 1293.8706129387174, 1298.928558929249, 1368.8904887609167, 1386.5909556680804, 1405.1358414575168, 906.977325566866, 909.0273407454093, 915.4232833314969, 929.3726734454216, 937.7655586103474, 4905.337779399735, 4908.214685650279, 4934.605231581465, 4973.850784476472, 4981.626378021663, 5855.912161317584, 5858.677772722541, 5860.824175274749, 5866.970665146647, 5871.588988770745, 4855.0, 4966.776495057731, 4967.155583550805, 4979.975100124476, 4980.651354405157, 3117.34535747491, 3152.1489197916435, 3160.604924384452, 3161.225499752575, 3162.920926976798, 5545.195946587723, 5545.556355491551, 5552.639078459887, 5556.444355564411, 5558.305211848519, 5944.583879128506, 5951.791687291011, 5994.880102397928, 5997.610155339889, 6002.039673652282, 5366.6779993200535, 5536.169574563848, 5545.694986775766, 5551.250581171571, 5552.972235138798, 5836.153757705194, 5841.912371314349, 5843.29880414353, 5855.648661080349, 5856.970715146397, 5683.431656834449, 5705.087186050212, 5710.37185909558, 5712.257406537124, 5714.0, 5411.83764487066, 5531.917021244765, 5539.529140023144, 5540.030494663337, 5542.722863856871, 3938.2517321708783, 3943.5662077170914, 3946.861859834892, 3946.881593552198, 3948.2498325318097, 5836.095405212199, 5838.0950952600715, 5840.737166827418, 5844.386339434468, 5844.561657875762, 5526.060569703241, 5574.498295153456, 5578.9163162553405, 5603.0, 5606.327240731139, 5459.945400545944, 5604.719764011702, 5606.887862242814, 5611.298587676541, 5616.7191640416995, 5487.122060470306, 5493.890122197454, 5500.9174862377895, 5501.477359650827, 5507.449255074461, 5483.506484416422, 5563.471470210324, 5649.68926709035, 5754.510866576388, 5767.942320576908, 5590.413006634408, 5616.578756593353, 5619.8876022480135, 5620.690862002629, 5627.296587926509], "unit": "score", "name": "prototype.html", "value": 4182.152622875084}, {"lowerIsBetter": false, "replicates": [758.2228216078521, 763.1033535595674, 763.5571368606209, 776.4332037612546, 797.1868693932186, 12766.106372553913, 13093.476260949563, 13142.342882855866, 13162.736745265089, 13187.406566704498, 13213.207207567553, 13280.402381892814, 13294.069415140944, 13296.335183240824, 13297.867021329785, 653.1802587752388, 660.2275337854721, 815.6370415165254, 828.2421584250434, 829.1087081387502, 795.6141271483355, 806.0166596751983, 815.7838172884191, 817.3134566963749, 817.8282560662268, 796.3748457460895, 824.1099612418574, 835.3776436554745, 835.9874601880946, 836.506461187899, 669.5714742564762, 676.5500941873672, 676.6549059979446, 678.5724993254267, 853.871919212117, 497.9701217926936, 616.0912653835602, 626.3173141275986, 629.4932579273683, 629.937006299371, 11153.330800152016, 11176.27354221973, 11180.385078820662, 11228.270162439416, 11278.379689117095, 10341.844872326847, 10729.302595331357, 10778.730531736692, 10819.459027048617, 11102.61140860066, 8721.694740684046, 8785.516796576187, 8869.334799890034, 8967.820643587156, 9005.594748236344, 3175.8300014367874, 3274.2305558193807, 3288.490284005983, 3292.456744637132, 3292.571965644475, 37952.24095518102, 38640.420393693836, 38690.806545967374, 38786.61213387858, 39123.80438097791, 8465.111163327885, 8567.443116197428, 8572.657093716181, 8622.024577633847, 8653.307735381155, 15149.318280677397, 15151.318190681446, 15195.468158614616, 15201.6199595011, 15216.163111028778, 5984.551158663031, 6026.969865150646, 6094.39056094387, 6192.102145188923, 6323.936760632427, 3660.7254455915913, 3661.3226553087766, 3669.1377526281303, 3710.239400922804, 3720.2745464634677, 2611.3341098019882, 2654.986725066401, 2657.8006649501363, 2660.2152365052357, 2667.6532050833266, 480.24601375840297, 482.21399119435097, 482.29344011024017, 486.5864015586723, 487.6099120703423, 402.7724335750292, 411.31105398457464, 414.61026634963036, 417.5365344467638, 417.6992565352941, 6769.647669477739, 7187.820304492429, 7458.440616953751, 7521.0974683038385, 7548.924510754822, 402.94358789769456, 484.76488902882073, 494.8837023299522, 551.3411473289381, 563.9154126881001, 3391.2196097048754, 3399.8810041648426, 3422.264213194175, 3499.9675095846787, 3581.516495273157, 45910.31134532985, 46127.0, 46394.768026159654, 46420.51846111555, 46734.0, 41792.53726119632, 42243.57756422458, 42487.787561061996, 42617.0, 43469.34795978063, 37159.81420092882, 37647.247055058746, 37836.81081594629, 37859.43210851839, 38231.0, 6595.505337099641, 7363.889541656987, 7606.0, 7656.885146722915, 7739.92260077392, 29107.417851642425, 29531.0, 29689.25776855596, 29784.106476804864, 29880.551791723577, 37343.62656373402, 37707.62292377041, 37924.0, 38000.0, 38065.61934380621, 8911.643534258557, 9411.200047995997, 9505.097015783489, 9517.952410237904, 9676.516174191122, 10498.0, 10536.525856336637, 10627.36235825853, 10679.89320106789, 10686.519106640064, 9561.952190239004, 9834.508274586098, 9973.202143828621, 10018.248631352824, 10160.98390160978, 9373.1564159226, 9418.764530886783, 9466.763330916507, 9579.808403831745, 9859.852102218329, 8928.73213803587, 9120.49837258957, 9297.0, 9379.735176730586, 9380.756271059528, 7827.647755850887, 8516.74449766508, 8900.376973612045, 8934.0, 9084.18242358191, 7723.189065148304, 8259.297959673255, 8360.119003124404, 8361.540115293717, 8517.95741021291], "unit": "score", "name": "yui.html", "value": 5436.034689184908}], "name": "dromaeo_css", "value": 6196.643060438563}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 105.0, 112.0, 112.0, 113.0, 102.0, 112.0, 111.0, 119.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 151.0, 164.0, 140.0, 151.0, 166.0, 133.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 163.0, 160.0, 161.0, 162.0, 163.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 91.0, 72.0, 73.0, 71.0, 121.0, 88.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 135.0, 95.0, 95.0, 96.0, 135.0, 95.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 69.0, 71.0, 72.0, 72.0, 71.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [344.0, 83.0, 82.0, 82.0, 82.0, 92.0, 82.0, 82.0, 83.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 110.9}, {"lowerIsBetter": true, "replicates": [131.0, 127.0, 127.0, 125.0, 132.0, 124.0, 121.0, 124.0, 133.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [140.0, 147.0, 144.0, 145.0, 172.0, 135.0, 148.0, 147.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1554.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "Richards", "value": 209.97629600000008}, {"lowerIsBetter": false, "replicates": [185.73551263001485], "unit": "score", "name": "DeltaBlue", "value": 355.9793120000001}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Splay", "value": 130.874546}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19760.715418620563}]} 04:09:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19760.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1554.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6196.64"}}} 04:09:09 INFO - Return code: 0 04:09:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:09:09 ERROR - # TBPL SUCCESS # 04:09:09 INFO - Running post-action listener: _resource_record_post_action 04:09:09 INFO - Running post-run listener: _resource_record_post_run 04:09:10 INFO - Total resource usage - Wall time: 1240s; CPU: 13.0%; Read bytes: 10358784; Write bytes: 451215360; Read time: 2852; Write time: 413760 04:09:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7516160; Read time: 0; Write time: 5928 04:09:10 INFO - run-tests - Wall time: 1225s; CPU: 13.0%; Read bytes: 8597504; Write bytes: 443699200; Read time: 2808; Write time: 407832 04:09:10 INFO - Running post-run listener: _upload_blobber_files 04:09:10 INFO - Blob upload gear active. 04:09:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:09:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:09:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:12 INFO - (blobuploader) - INFO - Done attempting. 04:09:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:09:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:09:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:12 INFO - (blobuploader) - INFO - Done attempting. 04:09:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:13 INFO - Return code: 0 04:09:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08eb509bd21f5193a86c0435ea0d489e3d4ebe72cd9deda36c9edc27aa1d438dc7b4c90152b36e37045aca1a258a982e026294b5f20a3603030cfafe7e099dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4588275ab0b417de7acdae35b78afa4e1f24498f60556b43b03058d61fe2723fd685801bcdc03185f3250327450192693d37c3ca9326aef1e610e0db5e89c976"} 04:09:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:13 INFO - Contents: 04:09:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08eb509bd21f5193a86c0435ea0d489e3d4ebe72cd9deda36c9edc27aa1d438dc7b4c90152b36e37045aca1a258a982e026294b5f20a3603030cfafe7e099dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4588275ab0b417de7acdae35b78afa4e1f24498f60556b43b03058d61fe2723fd685801bcdc03185f3250327450192693d37c3ca9326aef1e610e0db5e89c976"} 04:09:13 INFO - Copying logs to upload dir... 04:09:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.376547 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-22 04:09:13.006602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:09:13.009979) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08eb509bd21f5193a86c0435ea0d489e3d4ebe72cd9deda36c9edc27aa1d438dc7b4c90152b36e37045aca1a258a982e026294b5f20a3603030cfafe7e099dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4588275ab0b417de7acdae35b78afa4e1f24498f60556b43b03058d61fe2723fd685801bcdc03185f3250327450192693d37c3ca9326aef1e610e0db5e89c976"} build_url:https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/NMAgVfeJT56WqWNn5TROfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08eb509bd21f5193a86c0435ea0d489e3d4ebe72cd9deda36c9edc27aa1d438dc7b4c90152b36e37045aca1a258a982e026294b5f20a3603030cfafe7e099dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4588275ab0b417de7acdae35b78afa4e1f24498f60556b43b03058d61fe2723fd685801bcdc03185f3250327450192693d37c3ca9326aef1e610e0db5e89c976"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:09:13.034514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:09:13.034876) ========= 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=6587686cb2da90a5f91b3170000001be-1450782530.363786-858572196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:09:13.120719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:09:13.121033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:09:13.121348) ========= ========= Total master_lag: 0.20 =========