builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1452786243.91 results: success (0) buildid: 20160114060131 builduid: 4848de1251cf4e33a88ba88340cd9d13 revision: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.906028) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.906544) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.906887) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004431 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.928537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.928879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.948730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.949146) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.998092) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.998433) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:03.998819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:04.003157) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 07:44:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.4M=0s 2016-01-14 07:44:04 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:04.178134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:04.178452) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015650 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:04.233776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 07:44:04.234157) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 07:44:04,668 truncating revision to first 12 chars 2016-01-14 07:44:04,668 Setting DEBUG logging. 2016-01-14 07:44:04,668 attempt 1/10 2016-01-14 07:44:04,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27eb5e90eeee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 07:44:05,527 unpacking tar archive at: mozilla-central-27eb5e90eeee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.148354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 07:44:05.399256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:05.399572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:05.408976) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:05.409376) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:44:05.411140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-01-14 07:44:05.411468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:05 INFO - MultiFileLogger online at 20160114 07:44:05 in /builds/slave/test 07:44:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:44:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:05 INFO - {'append_to_log': False, 07:44:05 INFO - 'base_work_dir': '/builds/slave/test', 07:44:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:44:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:05 INFO - 'branch': 'Firefox-Non-PGO', 07:44:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:05 INFO - 'config_files': ('talos/linux_config.py',), 07:44:05 INFO - 'default_actions': ('clobber', 07:44:05 INFO - 'read-buildbot-config', 07:44:05 INFO - 'download-and-extract', 07:44:05 INFO - 'populate-webroot', 07:44:05 INFO - 'create-virtualenv', 07:44:05 INFO - 'install', 07:44:05 INFO - 'run-tests'), 07:44:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:05 INFO - 'download_minidump_stackwalk': True, 07:44:05 INFO - 'download_symbols': 'ondemand', 07:44:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:05 INFO - 'installer_path': 'installer.exe', 07:44:05 INFO - 'log_level': 'info', 07:44:05 INFO - 'log_name': 'talos', 07:44:05 INFO - 'log_to_console': True, 07:44:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:05 INFO - 'opt_config_files': (), 07:44:05 INFO - 'pip_index': False, 07:44:05 INFO - 'sps_profile': False, 07:44:05 INFO - 'sps_profile_interval': 0, 07:44:05 INFO - 'suite': 'dromaeojs-e10s', 07:44:05 INFO - 'system_bits': '32', 07:44:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:05 INFO - 'title': 'talos-linux64-ix-035', 07:44:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:05 INFO - 'use_talos_json': True, 07:44:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:05 INFO - 'work_dir': 'build'} 07:44:05 INFO - ##### 07:44:05 INFO - ##### Running clobber step. 07:44:05 INFO - ##### 07:44:05 INFO - Running pre-action listener: _resource_record_pre_action 07:44:05 INFO - Running main action method: clobber 07:44:05 INFO - rmtree: /builds/slave/test/build 07:44:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:06 INFO - Running post-action listener: _resource_record_post_action 07:44:06 INFO - ##### 07:44:06 INFO - ##### Running read-buildbot-config step. 07:44:06 INFO - ##### 07:44:06 INFO - Running pre-action listener: _resource_record_pre_action 07:44:06 INFO - Running main action method: read_buildbot_config 07:44:06 INFO - Using buildbot properties: 07:44:06 INFO - { 07:44:06 INFO - "project": "", 07:44:06 INFO - "product": "firefox", 07:44:06 INFO - "script_repo_revision": "production", 07:44:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:44:06 INFO - "repository": "", 07:44:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:44:06 INFO - "buildid": "20160114060131", 07:44:06 INFO - "pgo_build": "False", 07:44:06 INFO - "basedir": "/builds/slave/test", 07:44:06 INFO - "buildnumber": 208, 07:44:06 INFO - "slavename": "talos-linux64-ix-035", 07:44:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:44:06 INFO - "platform": "ubuntu64_hw", 07:44:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:44:06 INFO - "branch": "mozilla-central", 07:44:06 INFO - "repo_path": "mozilla-central", 07:44:06 INFO - "revision": "27eb5e90eeee2e6a1ffe61c368c294d3de51b797", 07:44:06 INFO - "stage_platform": "linux64", 07:44:06 INFO - "builduid": "4848de1251cf4e33a88ba88340cd9d13", 07:44:06 INFO - "slavebuilddir": "test" 07:44:06 INFO - } 07:44:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:44:06 INFO - Running post-action listener: _resource_record_post_action 07:44:06 INFO - ##### 07:44:06 INFO - ##### Running download-and-extract step. 07:44:06 INFO - ##### 07:44:06 INFO - Running pre-action listener: _resource_record_pre_action 07:44:06 INFO - Running main action method: download_and_extract 07:44:06 INFO - mkdir: /builds/slave/test/build/tests 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:06 INFO - https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:44:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/test_packages.json 07:44:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/test_packages.json 07:44:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:44:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:44:07 INFO - Downloaded 1448 bytes. 07:44:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:44:07 INFO - Using the following test package requirements: 07:44:07 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:07 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:44:07 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'jsshell-linux-x86_64.zip'], 07:44:07 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:07 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:07 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:07 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:07 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:07 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44: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')]} 07:44:07 INFO - https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:10 INFO - Downloaded 22762240 bytes. 07:44:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:44:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:44:11 INFO - Return code: 0 07:44:11 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 07:44: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')]} 07:44:11 INFO - https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:14 INFO - Downloaded 22762240 bytes. 07:44:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:44:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:44:15 INFO - Return code: 0 07:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:15 INFO - https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:17 INFO - Downloaded 11132144 bytes. 07:44:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:44:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:44:17 INFO - Return code: 0 07:44:17 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')]} 07:44:17 INFO - https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bjs7blJNRJCIpW04qgeyeQ/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 07:44:22 INFO - Downloaded 53973400 bytes. 07:44:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:22 INFO - mkdir: /builds/slave/test/properties 07:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:22 INFO - Contents: 07:44:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:22 INFO - Running post-action listener: _resource_record_post_action 07:44:22 INFO - Running post-action listener: set_extra_try_arguments 07:44:22 INFO - ##### 07:44:22 INFO - ##### Running populate-webroot step. 07:44:22 INFO - ##### 07:44:22 INFO - Running pre-action listener: _resource_record_pre_action 07:44:22 INFO - Running main action method: populate_webroot 07:44:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:22 INFO - '--tppagecycles', 07:44:22 INFO - '7'], 07:44:22 INFO - 'tests': ['tsvgm']}}, 07:44:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:44:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:44:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:44:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'tests': ['damp', 'tps']}, 07:44:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['damp', 'tps']}, 07:44:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:44:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:22 INFO - 'other': {'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'other_l64': {'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'other_nol64': {'tests': ['a11yr', 07:44:22 INFO - 'ts_paint', 07:44:22 INFO - 'tpaint', 07:44:22 INFO - 'sessionrestore', 07:44:22 INFO - 'sessionrestore_no_auto_restore']}, 07:44:22 INFO - 'svgr': {'tests': ['tsvgx', 07:44:22 INFO - 'tsvgr_opacity', 07:44:22 INFO - 'tart', 07:44:22 INFO - 'tscrollx', 07:44:22 INFO - 'cart']}, 07:44:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['tsvgx', 07:44:22 INFO - 'tsvgr_opacity', 07:44:22 INFO - 'tart', 07:44:22 INFO - 'tscrollx', 07:44:22 INFO - 'cart']}, 07:44:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'tests': ['tp5o']}, 07:44:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'talos_options': ['--e10s'], 07:44:22 INFO - 'tests': ['tp5o']}, 07:44:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'talos_options': ['--xperf_path', 07:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:22 INFO - 'tests': ['tp5n']}, 07:44:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:22 INFO - 'talos_options': ['--e10s', 07:44:22 INFO - '--xperf_path', 07:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:22 INFO - 'tests': ['tp5n']}}, 07:44:22 INFO - 'talos.zip': {'path': '', 07:44:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:22 INFO - Running post-action listener: _resource_record_post_action 07:44:22 INFO - ##### 07:44:22 INFO - ##### Running create-virtualenv step. 07:44:22 INFO - ##### 07:44:22 INFO - Running pre-action listener: _resource_record_pre_action 07:44:22 INFO - Running main action method: create_virtualenv 07:44:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:22 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 07:44:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:22 INFO - Using real prefix '/usr' 07:44:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:24 INFO - Installing pip.................done. 07:44:24 INFO - Return code: 0 07:44:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44: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', 'pip>=1.5'] in /builds/slave/test/build 07:44: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 pip>=1.5 07:44:24 INFO - Using env: {'DISPLAY': ':0', 07:44:24 INFO - 'HOME': '/home/cltbld', 07:44:24 INFO - 'LANG': 'en_US.UTF-8', 07:44:24 INFO - 'LANGUAGE': 'en_US:en', 07:44:24 INFO - 'LOGNAME': 'cltbld', 07:44:24 INFO - 'MAIL': '/var/mail/cltbld', 07:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:24 INFO - 'MOZ_NO_REMOTE': '1', 07:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:24 INFO - 'NO_EM_RESTART': '1', 07:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:24 INFO - 'PWD': '/builds/slave/test', 07:44:24 INFO - 'SHELL': '/bin/bash', 07:44:24 INFO - 'SHLVL': '1', 07:44:24 INFO - 'TERM': 'linux', 07:44:24 INFO - 'TMOUT': '86400', 07:44:24 INFO - 'USER': 'cltbld', 07:44:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:24 INFO - '_': '/tools/buildbot/bin/python'} 07:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:25 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 07:44:25 INFO - Cleaning up... 07:44:25 INFO - Return code: 0 07:44:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:25 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:25 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 07:44:25 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 07:44:25 INFO - Using env: {'DISPLAY': ':0', 07:44:25 INFO - 'HOME': '/home/cltbld', 07:44:25 INFO - 'LANG': 'en_US.UTF-8', 07:44:25 INFO - 'LANGUAGE': 'en_US:en', 07:44:25 INFO - 'LOGNAME': 'cltbld', 07:44:25 INFO - 'MAIL': '/var/mail/cltbld', 07:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:25 INFO - 'MOZ_NO_REMOTE': '1', 07:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:25 INFO - 'NO_EM_RESTART': '1', 07:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:25 INFO - 'PWD': '/builds/slave/test', 07:44:25 INFO - 'SHELL': '/bin/bash', 07:44:25 INFO - 'SHLVL': '1', 07:44:25 INFO - 'TERM': 'linux', 07:44:25 INFO - 'TMOUT': '86400', 07:44:25 INFO - 'USER': 'cltbld', 07:44:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:25 INFO - '_': '/tools/buildbot/bin/python'} 07:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:25 INFO - Downloading/unpacking psutil>=0.7.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:44:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:27 INFO - Installing collected packages: psutil 07:44:27 INFO - Running setup.py install for psutil 07:44:27 INFO - building 'psutil._psutil_linux' extension 07:44:27 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 07:44:27 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 07:44:27 INFO - building 'psutil._psutil_posix' extension 07:44:27 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 07:44:27 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 07:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:27 INFO - Successfully installed psutil 07:44:27 INFO - Cleaning up... 07:44:27 INFO - Return code: 0 07:44:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:44:27 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')]} 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:27 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')]} 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:27 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:27 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 07:44:27 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 07:44:27 INFO - Using env: {'DISPLAY': ':0', 07:44:27 INFO - 'HOME': '/home/cltbld', 07:44:27 INFO - 'LANG': 'en_US.UTF-8', 07:44:27 INFO - 'LANGUAGE': 'en_US:en', 07:44:27 INFO - 'LOGNAME': 'cltbld', 07:44:27 INFO - 'MAIL': '/var/mail/cltbld', 07:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:27 INFO - 'MOZ_NO_REMOTE': '1', 07:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:27 INFO - 'NO_EM_RESTART': '1', 07:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:27 INFO - 'PWD': '/builds/slave/test', 07:44:27 INFO - 'SHELL': '/bin/bash', 07:44:27 INFO - 'SHLVL': '1', 07:44:27 INFO - 'TERM': 'linux', 07:44:27 INFO - 'TMOUT': '86400', 07:44:27 INFO - 'USER': 'cltbld', 07:44:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:27 INFO - '_': '/tools/buildbot/bin/python'} 07:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:44:27 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 07:44:27 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 07:44:27 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 07:44:27 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 07:44:27 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 07:44:27 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 07:44:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:44:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:44:29 INFO - Installing collected packages: mozsystemmonitor 07:44:29 INFO - Running setup.py install for mozsystemmonitor 07:44:29 INFO - Successfully installed mozsystemmonitor 07:44:29 INFO - Cleaning up... 07:44:29 INFO - Return code: 0 07:44:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:29 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')]} 07:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:29 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')]} 07:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:29 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:29 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 07:44:29 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 07:44:29 INFO - Using env: {'DISPLAY': ':0', 07:44:29 INFO - 'HOME': '/home/cltbld', 07:44:29 INFO - 'LANG': 'en_US.UTF-8', 07:44:29 INFO - 'LANGUAGE': 'en_US:en', 07:44:29 INFO - 'LOGNAME': 'cltbld', 07:44:29 INFO - 'MAIL': '/var/mail/cltbld', 07:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:29 INFO - 'MOZ_NO_REMOTE': '1', 07:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:29 INFO - 'NO_EM_RESTART': '1', 07:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:29 INFO - 'PWD': '/builds/slave/test', 07:44:29 INFO - 'SHELL': '/bin/bash', 07:44:29 INFO - 'SHLVL': '1', 07:44:29 INFO - 'TERM': 'linux', 07:44:29 INFO - 'TMOUT': '86400', 07:44:29 INFO - 'USER': 'cltbld', 07:44:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:29 INFO - '_': '/tools/buildbot/bin/python'} 07:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:32 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 07:44:32 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 07:44:32 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 07:44:32 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 07:44:32 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 07:44:32 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 07:44:32 INFO - Downloading docopt-0.6.1.tar.gz 07:44:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:32 INFO - Running setup.py install for blobuploader 07:44:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:32 INFO - Running setup.py install for requests 07:44:32 INFO - Running setup.py install for docopt 07:44:32 INFO - Successfully installed blobuploader requests docopt 07:44:32 INFO - Cleaning up... 07:44:33 INFO - Return code: 0 07:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:33 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')]} 07:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:33 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')]} 07:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:33 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:33 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 07:44:33 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 07:44:33 INFO - Using env: {'DISPLAY': ':0', 07:44:33 INFO - 'HOME': '/home/cltbld', 07:44:33 INFO - 'LANG': 'en_US.UTF-8', 07:44:33 INFO - 'LANGUAGE': 'en_US:en', 07:44:33 INFO - 'LOGNAME': 'cltbld', 07:44:33 INFO - 'MAIL': '/var/mail/cltbld', 07:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:33 INFO - 'MOZ_NO_REMOTE': '1', 07:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:33 INFO - 'NO_EM_RESTART': '1', 07:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:33 INFO - 'PWD': '/builds/slave/test', 07:44:33 INFO - 'SHELL': '/bin/bash', 07:44:33 INFO - 'SHLVL': '1', 07:44:33 INFO - 'TERM': 'linux', 07:44:33 INFO - 'TMOUT': '86400', 07:44:33 INFO - 'USER': 'cltbld', 07:44:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:33 INFO - '_': '/tools/buildbot/bin/python'} 07:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:33 INFO - Running setup.py (path:/tmp/pip-VII6fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:33 INFO - Running setup.py (path:/tmp/pip-NeCSJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:33 INFO - Running setup.py (path:/tmp/pip-OGY5Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:33 INFO - Running setup.py (path:/tmp/pip-Q4pVuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:33 INFO - Running setup.py (path:/tmp/pip-1gQ7jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:33 INFO - Running setup.py (path:/tmp/pip-0WUQYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:33 INFO - Running setup.py (path:/tmp/pip-qbMPEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:33 INFO - Running setup.py (path:/tmp/pip-4Ma77a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:33 INFO - Running setup.py (path:/tmp/pip-HRYffB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:33 INFO - Running setup.py (path:/tmp/pip-jlcNrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:33 INFO - Running setup.py (path:/tmp/pip-z2PDbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:34 INFO - Running setup.py (path:/tmp/pip-xtkp8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:34 INFO - Running setup.py (path:/tmp/pip-VwffJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:34 INFO - Running setup.py (path:/tmp/pip-xjQXjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:34 INFO - Running setup.py (path:/tmp/pip-u6khPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:34 INFO - Running setup.py (path:/tmp/pip-7vpDba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:34 INFO - Running setup.py (path:/tmp/pip-8LfoGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:34 INFO - Running setup.py install for manifestparser 07:44:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:34 INFO - Running setup.py install for mozcrash 07:44:34 INFO - Running setup.py install for mozdebug 07:44:34 INFO - Running setup.py install for mozdevice 07:44:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:34 INFO - Running setup.py install for mozfile 07:44:34 INFO - Running setup.py install for mozhttpd 07:44:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozinfo 07:44:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozInstall 07:44:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozleak 07:44:35 INFO - Running setup.py install for mozlog 07:44:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for moznetwork 07:44:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozprocess 07:44:35 INFO - Running setup.py install for mozprofile 07:44:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozrunner 07:44:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:35 INFO - Running setup.py install for mozscreenshot 07:44:36 INFO - Running setup.py install for moztest 07:44:36 INFO - Running setup.py install for mozversion 07:44:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:36 INFO - Cleaning up... 07:44:36 INFO - Return code: 0 07:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:36 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:36 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 07:44:36 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 07:44:36 INFO - Using env: {'DISPLAY': ':0', 07:44:36 INFO - 'HOME': '/home/cltbld', 07:44:36 INFO - 'LANG': 'en_US.UTF-8', 07:44:36 INFO - 'LANGUAGE': 'en_US:en', 07:44:36 INFO - 'LOGNAME': 'cltbld', 07:44:36 INFO - 'MAIL': '/var/mail/cltbld', 07:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:36 INFO - 'MOZ_NO_REMOTE': '1', 07:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:36 INFO - 'NO_EM_RESTART': '1', 07:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:36 INFO - 'PWD': '/builds/slave/test', 07:44:36 INFO - 'SHELL': '/bin/bash', 07:44:36 INFO - 'SHLVL': '1', 07:44:36 INFO - 'TERM': 'linux', 07:44:36 INFO - 'TMOUT': '86400', 07:44:36 INFO - 'USER': 'cltbld', 07:44:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:36 INFO - '_': '/tools/buildbot/bin/python'} 07:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:36 INFO - Running setup.py (path:/tmp/pip-zKcWSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:36 INFO - Running setup.py (path:/tmp/pip-VpwoqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:36 INFO - Running setup.py (path:/tmp/pip-P1ioGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:36 INFO - Running setup.py (path:/tmp/pip-qwDgJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:36 INFO - Running setup.py (path:/tmp/pip-8QN1JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:36 INFO - Running setup.py (path:/tmp/pip-QaC0D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:36 INFO - Running setup.py (path:/tmp/pip-yfZD6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:36 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)) 07:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:36 INFO - Running setup.py (path:/tmp/pip-YoxXIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:37 INFO - Running setup.py (path:/tmp/pip-YgxG0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:37 INFO - Running setup.py (path:/tmp/pip-r7Ww48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:37 INFO - Running setup.py (path:/tmp/pip-_mFTnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:37 INFO - Running setup.py (path:/tmp/pip-MiIO1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:37 INFO - Running setup.py (path:/tmp/pip-qcMtVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:37 INFO - Running setup.py (path:/tmp/pip-qISpJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:37 INFO - Running setup.py (path:/tmp/pip-eGFLCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:37 INFO - Running setup.py (path:/tmp/pip-VjdZRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:37 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)) 07:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:37 INFO - Running setup.py (path:/tmp/pip-tQEpqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:37 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)) 07:44:37 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)) 07:44:37 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)) 07:44:37 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)) 07:44:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:44:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:44:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:39 INFO - Downloading blessings-1.5.1.tar.gz 07:44:39 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 07:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:39 INFO - Installing collected packages: blessings 07:44:39 INFO - Running setup.py install for blessings 07:44:39 INFO - Successfully installed blessings 07:44:39 INFO - Cleaning up... 07:44:39 INFO - Return code: 0 07:44:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:39 INFO - Reading from file tmpfile_stdout 07:44:39 INFO - Current package versions: 07:44:39 INFO - argparse == 1.2.1 07:44:39 INFO - blessings == 1.5.1 07:44:39 INFO - blobuploader == 1.2.4 07:44:39 INFO - docopt == 0.6.1 07:44:39 INFO - manifestparser == 1.1 07:44:39 INFO - mozInstall == 1.12 07:44:39 INFO - mozcrash == 0.16 07:44:39 INFO - mozdebug == 0.1 07:44:39 INFO - mozdevice == 0.48 07:44:39 INFO - mozfile == 1.2 07:44:39 INFO - mozhttpd == 0.7 07:44:39 INFO - mozinfo == 0.9 07:44:39 INFO - mozleak == 0.1 07:44:39 INFO - mozlog == 3.1 07:44:39 INFO - moznetwork == 0.27 07:44:39 INFO - mozprocess == 0.22 07:44:39 INFO - mozprofile == 0.28 07:44:39 INFO - mozrunner == 6.11 07:44:39 INFO - mozscreenshot == 0.1 07:44:39 INFO - mozsystemmonitor == 0.0 07:44:39 INFO - moztest == 0.7 07:44:39 INFO - mozversion == 1.4 07:44:39 INFO - psutil == 3.1.1 07:44:39 INFO - requests == 1.2.3 07:44:39 INFO - wsgiref == 0.1.2 07:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:39 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:39 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 07:44:39 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 07:44:39 INFO - Using env: {'DISPLAY': ':0', 07:44:39 INFO - 'HOME': '/home/cltbld', 07:44:39 INFO - 'LANG': 'en_US.UTF-8', 07:44:39 INFO - 'LANGUAGE': 'en_US:en', 07:44:39 INFO - 'LOGNAME': 'cltbld', 07:44:39 INFO - 'MAIL': '/var/mail/cltbld', 07:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:39 INFO - 'MOZ_NO_REMOTE': '1', 07:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:39 INFO - 'NO_EM_RESTART': '1', 07:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:39 INFO - 'PWD': '/builds/slave/test', 07:44:39 INFO - 'SHELL': '/bin/bash', 07:44:39 INFO - 'SHLVL': '1', 07:44:39 INFO - 'TERM': 'linux', 07:44:39 INFO - 'TMOUT': '86400', 07:44:39 INFO - 'USER': 'cltbld', 07:44:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:39 INFO - '_': '/tools/buildbot/bin/python'} 07:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 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)) 07:44:40 INFO - Cleaning up... 07:44:40 INFO - Return code: 0 07:44:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:40 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 07:44:40 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 07:44:40 INFO - Using env: {'DISPLAY': ':0', 07:44:40 INFO - 'HOME': '/home/cltbld', 07:44:40 INFO - 'LANG': 'en_US.UTF-8', 07:44:40 INFO - 'LANGUAGE': 'en_US:en', 07:44:40 INFO - 'LOGNAME': 'cltbld', 07:44:40 INFO - 'MAIL': '/var/mail/cltbld', 07:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:40 INFO - 'MOZ_NO_REMOTE': '1', 07:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:40 INFO - 'NO_EM_RESTART': '1', 07:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:40 INFO - 'PWD': '/builds/slave/test', 07:44:40 INFO - 'SHELL': '/bin/bash', 07:44:40 INFO - 'SHLVL': '1', 07:44:40 INFO - 'TERM': 'linux', 07:44:40 INFO - 'TMOUT': '86400', 07:44:40 INFO - 'USER': 'cltbld', 07:44:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:40 INFO - '_': '/tools/buildbot/bin/python'} 07:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:40 INFO - Downloading/unpacking jsonschema 07:44:40 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 07:44:40 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 07:44:40 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 07:44:40 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 07:44:40 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 07:44:40 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 07:44:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:42 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 07:44:42 INFO - Downloading/unpacking functools32 (from jsonschema) 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:42 INFO - warning: no files found matching '*.txt' 07:44:42 INFO - no previously-included directories found matching 'build' 07:44:42 INFO - no previously-included directories found matching 'dist' 07:44:42 INFO - no previously-included directories found matching '.git*' 07:44:42 INFO - Installing collected packages: jsonschema, functools32 07:44:42 INFO - Running setup.py install for functools32 07:44:42 INFO - warning: no files found matching '*.txt' 07:44:42 INFO - no previously-included directories found matching 'build' 07:44:42 INFO - no previously-included directories found matching 'dist' 07:44:42 INFO - no previously-included directories found matching '.git*' 07:44:42 INFO - Successfully installed jsonschema functools32 07:44:42 INFO - Cleaning up... 07:44:42 INFO - Return code: 0 07:44:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:42 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 0x7f2a7d3bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2899dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, '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': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', '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 07:44:42 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 07:44:42 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 07:44:42 INFO - Using env: {'DISPLAY': ':0', 07:44:42 INFO - 'HOME': '/home/cltbld', 07:44:42 INFO - 'LANG': 'en_US.UTF-8', 07:44:42 INFO - 'LANGUAGE': 'en_US:en', 07:44:42 INFO - 'LOGNAME': 'cltbld', 07:44:42 INFO - 'MAIL': '/var/mail/cltbld', 07:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:42 INFO - 'MOZ_NO_REMOTE': '1', 07:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:42 INFO - 'NO_EM_RESTART': '1', 07:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:42 INFO - 'PWD': '/builds/slave/test', 07:44:42 INFO - 'SHELL': '/bin/bash', 07:44:42 INFO - 'SHLVL': '1', 07:44:42 INFO - 'TERM': 'linux', 07:44:42 INFO - 'TMOUT': '86400', 07:44:42 INFO - 'USER': 'cltbld', 07:44:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:42 INFO - '_': '/tools/buildbot/bin/python'} 07:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:42 INFO - Downloading/unpacking flake8 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:44 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 07:44:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:44 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 07:44:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 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 07:44:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:45 INFO - no previously-included directories found matching 'docs/_build' 07:44:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:45 INFO - Running setup.py install for pep8 07:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:45 INFO - no previously-included directories found matching 'docs/_build' 07:44:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:45 INFO - Cleaning up... 07:44:45 INFO - Return code: 0 07:44:45 INFO - Running post-action listener: _resource_record_post_action 07:44:45 INFO - Running post-action listener: _start_resource_monitoring 07:44:45 INFO - Starting resource monitoring. 07:44:45 INFO - ##### 07:44:45 INFO - ##### Running install step. 07:44:45 INFO - ##### 07:44:45 INFO - Running pre-action listener: _resource_record_pre_action 07:44:45 INFO - Running main action method: install 07:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:45 INFO - Reading from file tmpfile_stdout 07:44:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:45 INFO - Reading from file tmpfile_stdout 07:44:45 INFO - Output received: 07:44:45 INFO - Usage: mozinstall [options] installer 07:44:45 INFO - Options: 07:44:45 INFO - -h, --help show this help message and exit 07:44:45 INFO - -d DEST, --destination=DEST 07:44:45 INFO - Directory to install application into. [default: 07:44:45 INFO - "/builds/slave/test"] 07:44:45 INFO - --app=APP Application being installed. [default: firefox] 07:44:45 INFO - mkdir: /builds/slave/test/build/application 07:44:45 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'] 07:44:45 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 07:45:01 INFO - Reading from file tmpfile_stdout 07:45:01 INFO - Output received: 07:45:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:01 INFO - Running post-action listener: _resource_record_post_action 07:45:01 INFO - ##### 07:45:01 INFO - ##### Running run-tests step. 07:45:01 INFO - ##### 07:45:01 INFO - Running pre-action listener: _resource_record_pre_action 07:45:01 INFO - Running main action method: run_tests 07:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:01 INFO - Python 2.7.3 07:45:01 INFO - Return code: 0 07:45:01 INFO - grabbing minidump binary from tooltool 07:45:01 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')]} 07:45:01 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 0x292c3d0>, '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 0x2897ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:01 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 07:45:01 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 07:45:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:01 INFO - Return code: 0 07:45:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:45:02 INFO - Return code: 0 07:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:45:02 INFO - Using env: {'DISPLAY': ':0', 07:45:02 INFO - 'HOME': '/home/cltbld', 07:45:02 INFO - 'LANG': 'en_US.UTF-8', 07:45:02 INFO - 'LANGUAGE': 'en_US:en', 07:45:02 INFO - 'LOGNAME': 'cltbld', 07:45:02 INFO - 'MAIL': '/var/mail/cltbld', 07:45:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:02 INFO - 'MOZ_NO_REMOTE': '1', 07:45:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:02 INFO - 'NO_EM_RESTART': '1', 07:45:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:02 INFO - 'PWD': '/builds/slave/test', 07:45:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:02 INFO - 'SHELL': '/bin/bash', 07:45:02 INFO - 'SHLVL': '1', 07:45:02 INFO - 'TERM': 'linux', 07:45:02 INFO - 'TMOUT': '86400', 07:45:02 INFO - 'USER': 'cltbld', 07:45:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192', 07:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:02 INFO - '_': '/tools/buildbot/bin/python'} 07:45:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:45:02 INFO - mozversion application_buildid: 20160114060131 07:45:02 INFO - mozversion application_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 07:45:02 INFO - mozversion application_display_name: Nightly 07:45:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:02 INFO - mozversion application_name: Firefox 07:45:02 INFO - mozversion application_remotingname: firefox 07:45:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:02 INFO - mozversion application_vendor: Mozilla 07:45:02 INFO - mozversion application_version: 46.0a1 07:45:02 INFO - mozversion platform_buildid: 20160114060131 07:45:02 INFO - mozversion platform_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 07:45:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:02 INFO - mozversion platform_version: 46.0a1 07:45:02 INFO - using testdate: 1452786302 07:45:02 INFO - actual date: 1452786302 07:45:02 INFO - starting webserver on 'localhost:59560' 07:45:02 INFO - SUITE-START | Running 3 tests 07:45:02 INFO - TEST-START | dromaeo_css 07:45:02 INFO - operating with platform_type : linux_ 07:45:02 INFO - Initialising browser for dromaeo_css test... 07:45:02 INFO - TEST-INFO | started process 24738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIX2Lo/profile http://localhost:59560/getInfo.html) 07:45:06 INFO - PROCESS | 24738 | 07:45:06 INFO - PROCESS | 24738 | (process:24822): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:45:07 INFO - PROCESS | 24738 | __metrics Screen width/height:1600/1200 07:45:07 INFO - PROCESS | 24738 | colorDepth:24 07:45:07 INFO - PROCESS | 24738 | Browser inner width/height: 1024/697 07:45:07 INFO - PROCESS | 24738 | __metrics 07:45:07 INFO - PROCESS | 24738 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:45:08 INFO - TEST-INFO | 24738: exit 0 07:45:08 INFO - Browser initialized. 07:45:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:08 INFO - TEST-INFO | started process 24871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIX2Lo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:09 INFO - PROCESS | 24871 | 07:45:09 INFO - PROCESS | 24871 | (process:24928): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:45:20 INFO - PROCESS | 24871 | RSS: Main: 150302720 07:45:20 INFO - PROCESS | 24871 | 07:46:09 INFO - PROCESS | 24871 | 1452786369826 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] 07:48:21 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59560/tests/dromaeo/cssquery-ext.html) 07:48:22 INFO - PROCESS | 24871 | RSS: Main: 155435008 07:48:22 INFO - PROCESS | 24871 | 07:51:24 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-ext.html (next: http://localhost:59560/tests/dromaeo/cssquery-jquery.html) 07:51:25 INFO - PROCESS | 24871 | RSS: Main: 152412160 07:51:25 INFO - PROCESS | 24871 | 07:54:27 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59560/tests/dromaeo/cssquery-mootools.html) 07:54:27 INFO - PROCESS | 24871 | RSS: Main: 151904256 07:54:27 INFO - PROCESS | 24871 | 07:57:29 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59560/tests/dromaeo/cssquery-prototype.html) 07:57:30 INFO - PROCESS | 24871 | RSS: Main: 149975040 07:57:30 INFO - PROCESS | 24871 | 08:00:33 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59560/tests/dromaeo/cssquery-yui.html) 08:00:33 INFO - PROCESS | 24871 | RSS: Main: 149835776 08:00:33 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:59560/tests/dromaeo/cssquery-yui.html (next: http://localhost:59560/tests/dromaeo/cssquery-dojo.html) 08:03:36 INFO - PROCESS | 24871 | RSS: Main: 153923584 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | __start_tp_report 08:03:36 INFO - PROCESS | 24871 | _x_x_mozilla_page_load 08:03:36 INFO - PROCESS | 24871 | _x_x_mozilla_page_load_details 08:03:36 INFO - PROCESS | 24871 | |i|pagename|runs| 08:03:36 INFO - PROCESS | 24871 | |0;dojo.html;2643.048502539086;2655.216711070234;2687.5699888017907;2688.6504754381926;2703.8648067596628;4498.775061246933;4527.886802829927;4563.2470642344015;4578.15304168729;4611.423572053489;4563.954360456394;4573.8170473181035;4601.746903920283;4653.7440440775745;4675.181843177439;4261.105167914741;4314.84898028569;4363.0619416825375;4376.343548467739;4416.2713152329825;4312.137572485515;4333.653307735373;4339.913201735963;4366.454193225847;4438.533953934839;4137.069159439102;4222.535521092677;4225.133847561273;4246.893827654302;4249.681273904454;4251.59609837065;4290.785460726983;4291.527931927485;4302.419173411612;4317.309230523101;4227.365895115727;4266.2320782259185;4274.487061552602;4288.078063216423;4317.827286908519;4439.578240067189;4452.599266066037;4541.45502539694;4550.931736023962;4645.396098507173;4908.852734417973;4911.778969946361;4913.631477639191;4923.556879880792;4982.402111746614;4950.975245123787;4954.90352779996;4964.255361695738;4965.975170124162;5011.6241281904;4499.955000449986;4575.9771201143785;4664.277037059193;4710.552497512731;4744.59670927975;5056.418511871108;5079.238114282887;5083.694978301313;5088.720120393414;5092.745362731848;4710.835120770825;4826.710397376169;4861.222204447272;4866.829660961849;4925.768557860535;4829.372181616367;4916.778744956486;4971.801127954914;4989.351384320088;5029.622778291643;4867.561919427269;4923.359963204761;4929.580985616263;4938.9012219755405;4946.5053494650965;4724.622030237572;4836.443808961944;4905.730184839868;4911.680740751911;4948.6783359082265;4079.102597428561;4088.5911408858874;4096.1193343431305;4104.363823607286;4121.5466298707115;3592.1019745063736;3624.655657712513;3635.327464419091;3653.50677658518;3661.7802931824176;4150.481189851269;4226.070264541796;4230.1539692061715;4261.190373828963;4273.209456250604;4919.458859525449;4924.556789888928;4942.8764280893265;4953.083679519301;4984.3021976923255;4225.598568136023;4253.170631726845;4256.787160641956;4257.87226383209;4300.247456695066;4096.467459230281;4173.499180098408;4190.371444283382;4349.412829268072;4352.303631419021;4627.259638457831;4634.698744581591;4682.321063445849;4705.035467729039;4741.644376671695;4896.143174944442;4907.950920490749;4914.992426552477;4920.6555541111775;4967.230079337708;4457.375967364506;4572.291294849304;4619.260918253063;4646.953530464652;4690.530946905282;4804.5195480451675;4815.590674792682;4852.393450818648;4873.95126048735;4912.312276281395;4883.340748998839;4916.188828843201;4921.163402221702;4926.778294976806;4967.60259179272;4625.976870115628;4735.337052812678;4751.216049351819;4765.189917713928;4828.2998965150555;4699.483056863811;4732.171869922819;4733.148033353892;4736.952630473789;4739.454962679336;4725.5510726480925;4737.9052418952115;4740.075685241345;4763.761811909321;4796.9760151199025;4696.272077827942;4769.713817170981;4776.02091571234;4898.118338699069;4913.385826771653;4710.882227944328;4748;4774.522547745198;4775.021120670323;4798.520147985174 08:03:36 INFO - PROCESS | 24871 | |1;ext.html;511.6827566908517;517.3972322244585;518.6810111781255;538.8625900395399;540.8026070484275;32797.508037379455;34017.319653606944;34060.318793624116;34076;34124;37798.0550486238;38474.8076259619;38476.230475390475;38498.230035399276;38574.61425385745;7527.849443011137;7727.884081738778;7752.651130699132;7766.766996990099;7771.417143714216;7492.7752167435065;7579.090509138883;7585;7598.240175982385;7633.961830190841;7758.340541054017;7824.256695613907;7850.057993040843;7865.4887432317;7888.2506161914525;7711.074671039483;7739.3034626883855;7747.225277472236;7757.340626046793;7768.300852923236;7595.5442673439775;7657.081150261948;7684.077910650702;7726.575038372887;7766.106897706723;37645.81177094125;37784.811075944446;38017.809910950265;38130;38186.618133818585;3054.9694503054907;3319.203391186098;3354.8490317935507;3371.96628033719;3405.8297085145646;28258.71741282602;28276.575851362246;28297.15108546747;28325.150245492667;29427.11718648444;3467.497212904115;3501.859925602973;3566.625504322035;3576.213233088716;3588.766730162531;221902;222811;222892;223674;223861;47745;48929;56399;57760;57809.421905781244;49432.25851612229;49760;50134.74932625386;50189;50294;12720;12864.48542058326;12883.484660613658;12901.677458063623;12937.870621293854;9707;9792.069753373418;9815;9961.701148965543;10015.799684006279;19114.00989309077;19533.121009554605;19533.51166220856;19674.21303147858;19706.802931970782;6743.56166849163;6952.617606031717;6997.93002069983;7030.54301470413;7077.787666370017;761.2919984414548;779.563444471098;791.7783020754198;941.6139382852997;971.2521358553875;25564.360890977503;25803.225903222934;26225.868870655526;26433.339166520607;26526.73473265281;864.7449002544139;914.2868562521111;935.3639525122982;938.5401153434905;955.4888134847823;11454.370009649549;11516;11544.134189935789;11609;11617.186796924134;263758;263855;264210;266521;267321;46204.5379546207;46383;46398.5360146401;46741.06517869623;46780.53219467762;1221.1024896700917;1234.3087870792206;1235.2279825109126;1235.2700531824769;1331.4141777617817;23796.446283051588;23906.711355837968;24023.382945612648;24205.51588968246;24298.906549204974;41032.79483602563;41133.58866411298;41192.38211426771;41408.171836563706;41468;243111;243492;243812;243824;245185;28103.71896281011;28270.293242669097;28582.14253572396;29030.564541531472;29133.56299655549;33743.4938475928;33770.49344259887;33862;34446.48330274998;34558;28664.57003144913;29274.707252927197;29654.258643534085;31227;31997.040088797374;31714.20714482064;32240;32503;32507.34985300328;32584;31838.204044899063;31985.72057117689;32377.190570235933;32501.34997300088;32539.674603253665;27608;28560.285992850346;28725.28186795347;28897.85551072231;29038.274043148245;22804.543909121392;22931.770682292965;23017.85970982293;23024.194153204557;23071.423214419774 08:03:36 INFO - PROCESS | 24871 | |2;jquery.html;347.6627671158975;348.84999450236387;349.16549446822097;350.4497938236969;351.8311210618902;13717.696818802211;13939.721205575896;14798.112113273211;15475.380984760624;15633.062016279031;10150.3402278852;10477.947610261957;12521.373931303422;15113.92443037786;15158;4464.888377790557;4561.589456948874;4616.192166370872;4628.560286772768;5008.073506401327;4889.902201955959;4963.677360971526;4997.550220480156;4998.150314446535;5012.248162775576;4693.671442998992;4970.527799859025;5321.122014867542;5584.385717571064;5588.273524441817;4889.33993910821;5113.846584602431;5471.890562188773;5492.47821456963;5517.503424691777;4741.336212930192;4878.073166098466;4899.069176856386;4917.139500587383;4927.50724927508;16790.58023549409;17589.64820703579;17601.559961001076;17846.91076544622;17977.280908763634;1795.703708888032;1879.9450892300013;1950.4733721895009;1989.254029738848;2048.528838367169;12375.381230938418;12589.937050314782;12826;12881.67795805103;12898.484060637564;1851.25949620153;1917.309768483345;1949;1997.2709960864324;2072.450800537859;54722.17916731252;56243.15635265474;56943.14585281224;56954.43045569574;57291;14470.204138772258;14701.191434470993;14710.55868323952;14733.116013039253;14739;21758;21983.670244946337;22008;22080.88959555192;22131.557368852533;8037.31682806968;8050.59747012647;8059.798505037304;8106.513609183467;8211.671533138608;6635.137432133792;6654.567453115532;6696.732130714814;6704.765333213314;6721;7261.164966028869;7332;7346.63266836656;7390.667419966115;7411.332980031823;1695.2456157010013;1804.3323970130873;2834.6598408190735;2896.232498387929;2912.6796052434215;720.42726032803;789.455275859655;836.0761358698672;846.272205902923;889.6485888074304;14007;14082.788758168635;14563.563093107225;15031.473898413504;15286;832.2592892325835;861.7070196133345;899.7525680437801;904.7059705595708;907.8547432410783;8323.6670533178;8459.280961118251;8463.619137138843;8654.697085601974;8690.739277821676;290195;291804;292901;439278;444940;49508.75245623749;51666;57245.42754572401;62065;62113.68943155255;1046.2937517175876;1068.893110688925;1075.774087441646;1082.4317233452343;1087.9891201088046;13361.198328100345;13496.662583435493;13656.317184140555;13668.794968075686;13746.93126534361;27461.725382745917;28371.148865534065;28897.711022890344;30331.545026824173;30642.540361894142;36248.81875590711;37549.62450375461;37967.24065518729;38273.808630956664;38552;6181.567290289637;6348.143000694847;6424.2933277338525;6459.321771213955;6564.606123632598;7608.353289970414;8612.397132200937;9860.753481163028;9977.600895964371;10022.3485473444;8347.499150051017;8409.117042710428;8507.489550626735;8838.64645414202;8854.114588541095;8352.87470687928;8497.405181637227;8808.25129863943;8951.597178126869;9028.27773778083;8732.126787321216;8748.69379571712;9043.276537876822;9243.630254789734;9317.301202409712;6874.6562671867205;6882.242953275236;6931.0643063187845;6987.231404545394;7010.824729381806;8300.2114799094;8751.431156974777;8890.33322500828;9221.123993220634;9390.859137113086 08:03:36 INFO - PROCESS | 24871 | |3;mootools.html;1370;1400.8739213470785;1508.4946542908126;1726.9897110190539;1737.37454516374;6240.84397890053;6376.744930202786;7151.141862976444;7331.3768329691975;7341.632918354087;6828.897566536506;6965.3731164195215;7047.788566343005;7049.083619129518;7055.4355651547885;2109.926152584656;2143.453419378064;2144.2066435418915;2145.8927053647335;2150.827933765295;2085.0200405809323;2087.060822629815;2093.6859471079383;2101.485136141647;2110.1137522240697;2072.678734796109;2080.43828166395;2081.583683263346;2087.8016588424075;2145.2598853395552;2158.5251244726214;2165.653495440722;2169.2949791317883;2169.381726208039;2174.141214220382;2075.418882712828;2111.567128738605;2117.7035215069905;2119.184114116076;2121.968170477444;7378.5941773202985;7406.629668516553;7411.925880741232;7427.628618569104;7433.85132297351;4173.979130104361;4298.032942587924;4307.870763877088;4311.9651283692;4315.676324275661;2693.245891150481;2716.5246081935584;2744.464829358276;2750.986245068762;2756.2558109310576;882.5410786391105;885.2873436883307;903.7333986474006;911.3939230411768;914.9451032938046;10097.444640544767;10121.898781012243;10125.746856328651;10142.695719128438;10143.884172740993;3903.4535165076913;3919.1769728356794;3942.7240093193773;3971.0667993021616;3980.0845805464905;8603.827923441497;8635.352348573757;8638.524881131598;8652.3510736695;8654.524001179869;4370.213361594943;4393.758343291086;4396.934045989313;4399.032212913154;4403.559644035571;3403.897883063512;3492.004778638127;3816;3970.940435893464;3978.7214894957074;3425.2635683328203;3444.0012396405264;3466.2201004773724;3500.4224302989724;3508.9298214035575;1069.4225118436113;1074.661481633283;1077.5474300793685;1077.7521170130915;1080.3679847289425;1143.0626885953604;1152.6599653102355;1157.3576664951033;1162.2329262686587;1190.000399664286;6533.509986750918;6570.211574611078;6621.834454138685;6657.3342665733035;6659.167604049494;403.8727800742757;404.3934098851722;409.53926832313647;410.8130800485772;412.9834806607702;5215.295935048795;5263.763130659129;5275.736213189325;5284.894302113936;5299.761510731949;8471.195236452528;8508.872366914502;8700.390972631854;8790.780230494289;8860.4240724354;8592.95703521491;8597.355198360148;8621.353398495012;8670.696525621574;8681.088485709037;6666.300038495985;6710.932890671031;6812.420944219698;6845.657717114124;6847.623380714009;6422.967885160731;6459.031145328238;6486.254080780771;6491.188601424822;6498;7657;7773.572453515111;7810.804729881571;7816.06207255133;7900.881486777588;7791.844163116819;8021.117677055403;8030.759077227693;8059.597020148852;8099.028116626043;5529.253550770755;5667.3482549507335;6008.128821320972;6413.679316034087;6507.219133703986;6696.296888826603;6792;6802.8639427212165;6817.931820681928;6833.282505337067;6082.178905847654;6250.374962503895;6342.746290148342;6367.204099487564;6374.872502550016;6176.073588961692;6230.532710046855;6285.057241413824;6325.051242313506;6373.87252254943;6438.484921206386;6642.535022548375;6696.397324240842;6704.161979752531;6712.093867328043;5867.794627188028;5956.583039187215;5980.461758441761;5986.042233242834;5992.280926288873;6050.606710563799;6056.878862422815;6064;6077.787277445268;6079.270487541523 08:03:36 INFO - PROCESS | 24871 | |4;prototype.html;322.1366737144453;322.9321842413093;323.9935201295976;331.91370243736634;332.5112085234705;5363.8122665706705;5453.481919217678;5505.201745746869;5505.807296744615;5524.64089834161;5326.760295786689;5449.155380915964;5471.398146203915;5472.288602481672;5473.644213126154;4320.719153255036;4323.718958267703;4334;4340.804663790137;4343.370211319357;4338.197433474801;4338.305871060631;4341.587549182838;4343.67422443318;4345.391645169679;4062.796860156995;4166.708330416872;4301.139772045603;4315.654747620199;4324.027093903878;4175.853845115422;4201.1807697499;4226.894327641833;4235.237657221699;4238.109996900655;3686.870959516431;3693.6121707220623;3695.0762309422644;3695.4087346024507;3698.7780733156096;5317.282166907496;5321.760520776575;5327.46725327468;5337.092694241988;5337.466253374631;4755.9286610700865;4877.585405240558;4877.731724755137;4892.363992680928;4896.804127834882;5755.510781583571;5788.305403351583;5802.796902108448;5804.158397032406;5806.361300256968;3974.6621537169085;4002.2595819773437;4005.2990726623016;4008.2584721826556;4008.83964641414;6029.577929544934;6101.572889897709;6104.114903339036;6140.815775526741;6203.16257305267;3973.0663294125857;4164.083901541656;4166.187593419254;4176.227397931331;4182.2890108681595;4187.330027195634;4242.830286788494;4247.745135291892;4248.256555102845;4250.3836943643;4844.176489996709;4867.026594681078;4870.0746858096845;4870.975645121823;4872.610191184696;5798.275215598051;5804.535637149018;5810.709464526757;5811.244538210006;5818.5345172386105;1391.8747312741903;1420.552525954321;1461.3789139615621;1505.7590785474272;1507.1183357735847;962.5668449197889;977.7604486900755;978.256525040974;978.3982850547005;983.7540614846289;4990.925136122961;5048.798048078036;5050.015247026868;5052.9242061369105;5067.189249720101;5928.584999050111;5932.169496270526;5941.168236446901;5942.227510423617;5952.375000624958;5018.197088465828;5032.7483625819295;5037.4458809530925;5042.268871013683;5046.419661738947;3156.700113489215;3185.39477499279;3236.3689080629524;3236.967630323714;3255.1211172983635;5662.5753068520025;5705.144228365695;5715.571332150105;5722.141678748138;5726.226959360516;6250.9062364064575;6283.528735344776;6291.276503202191;6291.402316779899;6298.370162983665;5591.524720398812;5711.057675483582;5716.342620598602;5718.370979192286;5719.914201286984;6062.575619706578;6062.78780242707;6064.696765161636;6075.544334174866;6078.7264573093435;5940.970295148497;5941.940580594139;5942.881142377215;5948.583599148191;5948.73230704628;5692.800751973661;5700.315962084576;5711.057675483665;5718.1136923776885;5718.599698021098;4016.678665706795;4045.5752146024242;4061.1065565575527;4088.7546747194074;4102.364133559303;5846.356900741001;6076.969615151896;6079;6080.331163571915;6096.78661246872;5763;5777.508911742549;5789.681567513827;5791.7683292667825;5813.360530341574;5773.769049237983;5832.096025116114;5837.562182836219;5842.883142337215;5844.211031510692;5666.320041595035;5707.800226992035;5717.914231286617;5717.971410142923;5742.885142297047;5682.772689092555;5914.378990206139;5914.615549989237;5919.7040147991565;5921.200637913998;5734.655920644775;5734.856628584319;5735.598508104393;5744.195812586157;5746.310442746897 08:03:36 INFO - PROCESS | 24871 | |5;yui.html;730.6565914020408;741.7515132430635;759.4835511851941;766.9118051424084;778.7975126467117;11540.422978851055;11627.593034243813;11653.475593598287;11695.473703683334;11714.238574492652;11582.42087895606;11588.768224635502;11615.186936914419;11633.592824251153;11675.883241167587;610.38351265222;620.0915658560208;773.0684525147199;776.7980325115483;791.6793698552095;772.0233904111303;783.682608543538;783.8628240057996;785.7132146766418;788.6214616983851;813.686730608717;815.9143289954559;818.5866137600533;820.4625969989667;820.5281962871372;794.5351969098084;796.3430170109654;802.8554860125175;805.0862271322092;805.3195050182557;603.2881200183781;603.7253049862346;604.0214851939842;604.7611193578556;606.130203158469;11538.307701537935;11554.133439992034;11610.477528511237;11612.129090318176;11627.069834413227;11553.364564948924;11562.075033997344;11710.707232319175;11855.644330670008;12179;9219.688354182894;9231.815363692756;9283.535823208813;9343.859842102305;9887.802243955153;3228.515722641599;3302.2239773653173;3309.9172520686934;3312.685294897005;3388.373150967079;36987;37194.81402592997;37269.25461490755;37415.4387684185;37456.063598409986;8806.77983050416;9067.274618030542;9076.319276054322;9096.090390960984;9105.590248438835;14705.632359191106;14823.332950017275;15022.624434389008;15115.395384184729;15179.544613661608;5936.287645482484;6057.878842423215;6072.635641861502;6090.847728806815;6168.321484636686;3498.422760244582;3523.894283171509;3530.293941211768;3539.5752509698486;3549.716022718176;2637.3802156493207;2645.9470810584066;2660.8270462419882;2663.6803583570095;2674.3982603913964;468.62275867926644;474.926386410107;475.59099174709723;479.08972951392633;480.5098799224771;590.6633219065178;594.5956749410356;613.8496068463255;620.4416025576927;621.9533534984894;7339.88990165148;7538;7580.128285247267;7631.771046868603;7683.500572462772;471.8112754898068;600.6366148480107;613.8557439001831;617.299365220478;634.0995785983914;3512.473129030666;3588.784672919633;3756.417755247941;3780.0738818989525;3791.677707394847;45777.31334029992;45881;46411.30383044257;47425;51528.22707659388;41054.17891642151;41176.794116029225;41792.791036044626;41793;42142.946426339586;36648;37448.25103497915;38198.618013820065;38267.61732382696;38529.22941541154;7892.768452861784;7991.2807847294025;8213;8256.504609723435;8400;27993.860030700533;28898;29574.112776616737;29882.85058574693;30161.69838301589;34031.659683402846;34104.31791364109;34657.48013779745;37251.6274837259;38401.4239786409;9870.555824987749;9964.153046991087;10300.278980471296;10316.329438586468;10411.895881041093;11107.38909359993;11301.830472543083;11316.15128865355;11623.76752464963;11639.185257031926;10493.370397776158;10567.735806604896;10754.89245107539;10850.891491084989;11447.25592836463;10033.347832390871;10052.296339256181;10134.797304054026;10386.636467723594;10437.478126093816;10193.847092293474;10241.07830295277;10467.738306542093;10611.41637209961;10910.563577457131;9031.81936361256;9045.547722613974;9239.260859131118;9373.437593744124;9501.524923753646;9302.720918372459;9401.717948461557;9447.574859131219;9465.526723663927;9639.325247232908 08:03:36 INFO - PROCESS | 24871 | __end_tp_report 08:03:36 INFO - PROCESS | 24871 | __start_cc_report 08:03:36 INFO - PROCESS | 24871 | _x_x_mozilla_cycle_collect,336 08:03:36 INFO - PROCESS | 24871 | __end_cc_report 08:03:36 INFO - PROCESS | 24871 | __startTimestamp1452787416399__endTimestamp 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | ------- Summary: start ------- 08:03:36 INFO - PROCESS | 24871 | Number of tests: 6 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#0] dojo.html Cycles:165 Average:4551.77 Median:4696.27 stddev:465.81 (9.9%) stddev-sans-first:442.52 08:03:36 INFO - PROCESS | 24871 | Values: 2643.0 2655.2 2687.6 2688.7 2703.9 4498.8 4527.9 4563.2 4578.2 4611.4 4564.0 4573.8 4601.7 4653.7 4675.2 4261.1 4314.8 4363.1 4376.3 4416.3 4312.1 4333.7 4339.9 4366.5 4438.5 4137.1 4222.5 4225.1 4246.9 4249.7 4251.6 4290.8 4291.5 4302.4 4317.3 4227.4 4266.2 4274.5 4288.1 4317.8 4439.6 4452.6 4541.5 4550.9 4645.4 4908.9 4911.8 4913.6 4923.6 4982.4 4951.0 4954.9 4964.3 4966.0 5011.6 4500.0 4576.0 4664.3 4710.6 4744.6 5056.4 5079.2 5083.7 5088.7 5092.7 4710.8 4826.7 4861.2 4866.8 4925.8 4829.4 4916.8 4971.8 4989.4 5029.6 4867.6 4923.4 4929.6 4938.9 4946.5 4724.6 4836.4 4905.7 4911.7 4948.7 4079.1 4088.6 4096.1 4104.4 4121.5 3592.1 3624.7 3635.3 3653.5 3661.8 4150.5 4226.1 4230.2 4261.2 4273.2 4919.5 4924.6 4942.9 4953.1 4984.3 4225.6 4253.2 4256.8 4257.9 4300.2 4096.5 4173.5 4190.4 4349.4 4352.3 4627.3 4634.7 4682.3 4705.0 4741.6 4896.1 4908.0 4915.0 4920.7 4967.2 4457.4 4572.3 4619.3 4647.0 4690.5 4804.5 4815.6 4852.4 4874.0 4912.3 4883.3 4916.2 4921.2 4926.8 4967.6 4626.0 4735.3 4751.2 4765.2 4828.3 4699.5 4732.2 4733.1 4737.0 4739.5 4725.6 4737.9 4740.1 4763.8 4797.0 4696.3 4769.7 4776.0 4898.1 4913.4 4710.9 4748.0 4774.5 4775.0 4798.5 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#1] ext.html Cycles:180 Average:39748.16 Median:18733.07 stddev:63753.39 (340.3%) stddev-sans-first:63864.16 08:03:36 INFO - PROCESS | 24871 | Values: 511.7 517.4 518.7 538.9 540.8 32797.5 34017.3 34060.3 34076.0 34124.0 37798.1 38474.8 38476.2 38498.2 38574.6 7527.8 7727.9 7752.7 7766.8 7771.4 7492.8 7579.1 7585.0 7598.2 7634.0 7758.3 7824.3 7850.1 7865.5 7888.3 7711.1 7739.3 7747.2 7757.3 7768.3 7595.5 7657.1 7684.1 7726.6 7766.1 37645.8 37784.8 38017.8 38130.0 38186.6 3055.0 3319.2 3354.8 3372.0 3405.8 28258.7 28276.6 28297.2 28325.2 29427.1 3467.5 3501.9 3566.6 3576.2 3588.8 221902.0 222811.0 222892.0 223674.0 223861.0 47745.0 48929.0 56399.0 57760.0 57809.4 49432.3 49760.0 50134.7 50189.0 50294.0 12720.0 12864.5 12883.5 12901.7 12937.9 9707.0 9792.1 9815.0 9961.7 10015.8 19114.0 19533.1 19533.5 19674.2 19706.8 6743.6 6952.6 6997.9 7030.5 7077.8 761.3 779.6 791.8 941.6 971.3 25564.4 25803.2 26225.9 26433.3 26526.7 864.7 914.3 935.4 938.5 955.5 11454.4 11516.0 11544.1 11609.0 11617.2 263758.0 263855.0 264210.0 266521.0 267321.0 46204.5 46383.0 46398.5 46741.1 46780.5 1221.1 1234.3 1235.2 1235.3 1331.4 23796.4 23906.7 24023.4 24205.5 24298.9 41032.8 41133.6 41192.4 41408.2 41468.0 243111.0 243492.0 243812.0 243824.0 245185.0 28103.7 28270.3 28582.1 29030.6 29133.6 33743.5 33770.5 33862.0 34446.5 34558.0 28664.6 29274.7 29654.3 31227.0 31997.0 31714.2 32240.0 32503.0 32507.3 32584.0 31838.2 31985.7 32377.2 32501.3 32539.7 27608.0 28560.3 28725.3 28897.9 29038.3 22804.5 22931.8 23017.9 23024.2 23071.4 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#2] jquery.html Cycles:180 Average:21584.87 Median:4908.10 stddev:58839.06 (1198.8%) stddev-sans-first:58982.51 08:03:36 INFO - PROCESS | 24871 | Values: 347.7 348.8 349.2 350.4 351.8 13717.7 13939.7 14798.1 15475.4 15633.1 10150.3 10477.9 12521.4 15113.9 15158.0 4464.9 4561.6 4616.2 4628.6 5008.1 4889.9 4963.7 4997.6 4998.2 5012.2 4693.7 4970.5 5321.1 5584.4 5588.3 4889.3 5113.8 5471.9 5492.5 5517.5 4741.3 4878.1 4899.1 4917.1 4927.5 16790.6 17589.6 17601.6 17846.9 17977.3 1795.7 1879.9 1950.5 1989.3 2048.5 12375.4 12589.9 12826.0 12881.7 12898.5 1851.3 1917.3 1949.0 1997.3 2072.5 54722.2 56243.2 56943.1 56954.4 57291.0 14470.2 14701.2 14710.6 14733.1 14739.0 21758.0 21983.7 22008.0 22080.9 22131.6 8037.3 8050.6 8059.8 8106.5 8211.7 6635.1 6654.6 6696.7 6704.8 6721.0 7261.2 7332.0 7346.6 7390.7 7411.3 1695.2 1804.3 2834.7 2896.2 2912.7 720.4 789.5 836.1 846.3 889.6 14007.0 14082.8 14563.6 15031.5 15286.0 832.3 861.7 899.8 904.7 907.9 8323.7 8459.3 8463.6 8654.7 8690.7 290195.0 291804.0 292901.0 439278.0 444940.0 49508.8 51666.0 57245.4 62065.0 62113.7 1046.3 1068.9 1075.8 1082.4 1088.0 13361.2 13496.7 13656.3 13668.8 13746.9 27461.7 28371.1 28897.7 30331.5 30642.5 36248.8 37549.6 37967.2 38273.8 38552.0 6181.6 6348.1 6424.3 6459.3 6564.6 7608.4 8612.4 9860.8 9977.6 10022.3 8347.5 8409.1 8507.5 8838.6 8854.1 8352.9 8497.4 8808.3 8951.6 9028.3 8732.1 8748.7 9043.3 9243.6 9317.3 6874.7 6882.2 6931.1 6987.2 7010.8 8300.2 8751.4 8890.3 9221.1 9390.9 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#3] mootools.html Cycles:180 Average:5015.38 Median:5989.16 stddev:2640.33 (44.1%) stddev-sans-first:2633.52 08:03:36 INFO - PROCESS | 24871 | Values: 1370.0 1400.9 1508.5 1727.0 1737.4 6240.8 6376.7 7151.1 7331.4 7341.6 6828.9 6965.4 7047.8 7049.1 7055.4 2109.9 2143.5 2144.2 2145.9 2150.8 2085.0 2087.1 2093.7 2101.5 2110.1 2072.7 2080.4 2081.6 2087.8 2145.3 2158.5 2165.7 2169.3 2169.4 2174.1 2075.4 2111.6 2117.7 2119.2 2122.0 7378.6 7406.6 7411.9 7427.6 7433.9 4174.0 4298.0 4307.9 4312.0 4315.7 2693.2 2716.5 2744.5 2751.0 2756.3 882.5 885.3 903.7 911.4 914.9 10097.4 10121.9 10125.7 10142.7 10143.9 3903.5 3919.2 3942.7 3971.1 3980.1 8603.8 8635.4 8638.5 8652.4 8654.5 4370.2 4393.8 4396.9 4399.0 4403.6 3403.9 3492.0 3816.0 3970.9 3978.7 3425.3 3444.0 3466.2 3500.4 3508.9 1069.4 1074.7 1077.5 1077.8 1080.4 1143.1 1152.7 1157.4 1162.2 1190.0 6533.5 6570.2 6621.8 6657.3 6659.2 403.9 404.4 409.5 410.8 413.0 5215.3 5263.8 5275.7 5284.9 5299.8 8471.2 8508.9 8700.4 8790.8 8860.4 8593.0 8597.4 8621.4 8670.7 8681.1 6666.3 6710.9 6812.4 6845.7 6847.6 6423.0 6459.0 6486.3 6491.2 6498.0 7657.0 7773.6 7810.8 7816.1 7900.9 7791.8 8021.1 8030.8 8059.6 8099.0 5529.3 5667.3 6008.1 6413.7 6507.2 6696.3 6792.0 6802.9 6817.9 6833.3 6082.2 6250.4 6342.7 6367.2 6374.9 6176.1 6230.5 6285.1 6325.1 6373.9 6438.5 6642.5 6696.4 6704.2 6712.1 5867.8 5956.6 5980.5 5986.0 5992.3 6050.6 6056.9 6064.0 6077.8 6079.3 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#4] prototype.html Cycles:180 Average:4813.59 Median:5472.97 stddev:1426.96 (26.1%) stddev-sans-first:1390.57 08:03:36 INFO - PROCESS | 24871 | Values: 322.1 322.9 324.0 331.9 332.5 5363.8 5453.5 5505.2 5505.8 5524.6 5326.8 5449.2 5471.4 5472.3 5473.6 4320.7 4323.7 4334.0 4340.8 4343.4 4338.2 4338.3 4341.6 4343.7 4345.4 4062.8 4166.7 4301.1 4315.7 4324.0 4175.9 4201.2 4226.9 4235.2 4238.1 3686.9 3693.6 3695.1 3695.4 3698.8 5317.3 5321.8 5327.5 5337.1 5337.5 4755.9 4877.6 4877.7 4892.4 4896.8 5755.5 5788.3 5802.8 5804.2 5806.4 3974.7 4002.3 4005.3 4008.3 4008.8 6029.6 6101.6 6104.1 6140.8 6203.2 3973.1 4164.1 4166.2 4176.2 4182.3 4187.3 4242.8 4247.7 4248.3 4250.4 4844.2 4867.0 4870.1 4871.0 4872.6 5798.3 5804.5 5810.7 5811.2 5818.5 1391.9 1420.6 1461.4 1505.8 1507.1 962.6 977.8 978.3 978.4 983.8 4990.9 5048.8 5050.0 5052.9 5067.2 5928.6 5932.2 5941.2 5942.2 5952.4 5018.2 5032.7 5037.4 5042.3 5046.4 3156.7 3185.4 3236.4 3237.0 3255.1 5662.6 5705.1 5715.6 5722.1 5726.2 6250.9 6283.5 6291.3 6291.4 6298.4 5591.5 5711.1 5716.3 5718.4 5719.9 6062.6 6062.8 6064.7 6075.5 6078.7 5941.0 5941.9 5942.9 5948.6 5948.7 5692.8 5700.3 5711.1 5718.1 5718.6 4016.7 4045.6 4061.1 4088.8 4102.4 5846.4 6077.0 6079.0 6080.3 6096.8 5763.0 5777.5 5789.7 5791.8 5813.4 5773.8 5832.1 5837.6 5842.9 5844.2 5666.3 5707.8 5717.9 5718.0 5742.9 5682.8 5914.4 5914.6 5919.7 5921.2 5734.7 5734.9 5735.6 5744.2 5746.3 08:03:36 INFO - PROCESS | 24871 | 08:03:36 INFO - PROCESS | 24871 | [#5] yui.html Cycles:180 Average:11721.21 Median:41792.90 stddev:12813.04 (30.7%) stddev-sans-first:12822.40 08:03:36 INFO - PROCESS | 24871 | Values: 730.7 741.8 759.5 766.9 778.8 11540.4 11627.6 11653.5 11695.5 11714.2 11582.4 11588.8 11615.2 11633.6 11675.9 610.4 620.1 773.1 776.8 791.7 772.0 783.7 783.9 785.7 788.6 813.7 815.9 818.6 820.5 820.5 794.5 796.3 802.9 805.1 805.3 603.3 603.7 604.0 604.8 606.1 11538.3 11554.1 11610.5 11612.1 11627.1 11553.4 11562.1 11710.7 11855.6 12179.0 9219.7 9231.8 9283.5 9343.9 9887.8 3228.5 3302.2 3309.9 3312.7 3388.4 36987.0 37194.8 37269.3 37415.4 37456.1 8806.8 9067.3 9076.3 9096.1 9105.6 14705.6 14823.3 15022.6 15115.4 15179.5 5936.3 6057.9 6072.6 6090.8 6168.3 3498.4 3523.9 3530.3 3539.6 3549.7 2637.4 2645.9 2660.8 2663.7 2674.4 468.6 474.9 475.6 479.1 480.5 590.7 594.6 613.8 620.4 622.0 7339.9 7538.0 7580.1 7631.8 7683.5 471.8 600.6 613.9 617.3 634.1 3512.5 3588.8 3756.4 3780.1 3791.7 45777.3 45881.0 46411.3 47425.0 51528.2 41054.2 41176.8 41792.8 41793.0 42142.9 36648.0 37448.3 38198.6 38267.6 38529.2 7892.8 7991.3 8213.0 8256.5 8400.0 27993.9 28898.0 29574.1 29882.9 30161.7 34031.7 34104.3 34657.5 37251.6 38401.4 9870.6 9964.2 10300.3 10316.3 10411.9 11107.4 11301.8 11316.2 11623.8 11639.2 10493.4 10567.7 10754.9 10850.9 11447.3 10033.3 10052.3 10134.8 10386.6 10437.5 10193.8 10241.1 10467.7 10611.4 10910.6 9031.8 9045.5 9239.3 9373.4 9501.5 9302.7 9401.7 9447.6 9465.5 9639.3 08:03:36 INFO - PROCESS | 24871 | -------- Summary: end -------- 08:03:36 INFO - PROCESS | 24871 | 08:03:37 INFO - TEST-INFO | 24871: exit 0 08:03:37 INFO - TEST-OK | dromaeo_css | took 1114516ms 08:03:37 INFO - TEST-START | kraken 08:03:37 INFO - operating with platform_type : linux_ 08:03:37 INFO - Initialising browser for kraken test... 08:03:37 INFO - TEST-INFO | started process 25107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfG62D4/profile http://localhost:59560/getInfo.html) 08:03:40 INFO - PROCESS | 25107 | 08:03:40 INFO - PROCESS | 25107 | (process:25178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:03:41 INFO - PROCESS | 25107 | __metrics Screen width/height:1600/1200 08:03:41 INFO - PROCESS | 25107 | colorDepth:24 08:03:41 INFO - PROCESS | 25107 | Browser inner width/height: 1024/697 08:03:41 INFO - PROCESS | 25107 | __metrics 08:03:41 INFO - PROCESS | 25107 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:03:42 INFO - TEST-INFO | 25107: exit 0 08:03:42 INFO - Browser initialized. 08:03:42 INFO - Running cycle 1/1 for kraken test... 08:03:42 INFO - TEST-INFO | started process 25227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfG62D4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:44 INFO - PROCESS | 25227 | 08:03:44 INFO - PROCESS | 25227 | (process:25287): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:03:54 INFO - PROCESS | 25227 | RSS: Main: 150433792 08:03:54 INFO - PROCESS | 25227 | 08:03:57 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59560/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:57 INFO - PROCESS | 25227 | RSS: Main: 151121920 08:03:57 INFO - PROCESS | 25227 | 08:04:00 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59560/tests/kraken/driver.html?testName=audio-dft) 08:04:01 INFO - PROCESS | 25227 | RSS: Main: 154374144 08:04:01 INFO - PROCESS | 25227 | 08:04:04 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59560/tests/kraken/driver.html?testName=audio-fft) 08:04:04 INFO - PROCESS | 25227 | RSS: Main: 146870272 08:04:04 INFO - PROCESS | 25227 | 08:04:06 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59560/tests/kraken/driver.html?testName=audio-oscillator) 08:04:07 INFO - PROCESS | 25227 | RSS: Main: 147992576 08:04:07 INFO - PROCESS | 25227 | 08:04:09 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:10 INFO - PROCESS | 25227 | RSS: Main: 148074496 08:04:10 INFO - PROCESS | 25227 | 08:04:13 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59560/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:14 INFO - PROCESS | 25227 | RSS: Main: 149258240 08:04:14 INFO - PROCESS | 25227 | 08:04:17 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59560/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:18 INFO - PROCESS | 25227 | RSS: Main: 149245952 08:04:18 INFO - PROCESS | 25227 | 08:04:21 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59560/tests/kraken/driver.html?testName=json-parse-financial) 08:04:21 INFO - PROCESS | 25227 | RSS: Main: 149569536 08:04:21 INFO - PROCESS | 25227 | 08:04:23 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:24 INFO - PROCESS | 25227 | RSS: Main: 148021248 08:04:24 INFO - PROCESS | 25227 | 08:04:25 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:26 INFO - PROCESS | 25227 | RSS: Main: 149020672 08:04:26 INFO - PROCESS | 25227 | 08:04:28 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:29 INFO - PROCESS | 25227 | RSS: Main: 149401600 08:04:29 INFO - PROCESS | 25227 | 08:04:31 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:32 INFO - PROCESS | 25227 | RSS: Main: 149716992 08:04:32 INFO - PROCESS | 25227 | 08:04:34 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:35 INFO - PROCESS | 25227 | RSS: Main: 150204416 08:04:35 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:59560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59560/tests/kraken/driver.html?testName=ai-astar) 08:04:37 INFO - PROCESS | 25227 | RSS: Main: 149303296 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | __start_tp_report 08:04:37 INFO - PROCESS | 25227 | _x_x_mozilla_page_load 08:04:37 INFO - PROCESS | 25227 | _x_x_mozilla_page_load_details 08:04:37 INFO - PROCESS | 25227 | |i|pagename|runs| 08:04:37 INFO - PROCESS | 25227 | |0;ai-astar;115;109;116;113;114;127;114;114;113;114 08:04:37 INFO - PROCESS | 25227 | |1;audio-beat-detection;158;137;156;169;139;153;159;149;164;140 08:04:37 INFO - PROCESS | 25227 | |2;audio-dft;162;164;165;163;165;171;164;164;166;164 08:04:37 INFO - PROCESS | 25227 | |3;audio-fft;74;73;76;75;147;74;73;75;72;87 08:04:37 INFO - PROCESS | 25227 | |4;audio-oscillator;98;97;138;97;98;97;146;97;98;131 08:04:37 INFO - PROCESS | 25227 | |5;imaging-gaussian-blur;109;111;110;111;110;110;110;112;110;111 08:04:37 INFO - PROCESS | 25227 | |6;imaging-darkroom;148;151;148;149;147;148;148;148;147;148 08:04:37 INFO - PROCESS | 25227 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;95;96 08:04:37 INFO - PROCESS | 25227 | |8;json-parse-financial;72;72;72;71;73;73;71;73;70;73 08:04:37 INFO - PROCESS | 25227 | |9;json-stringify-tinderbox;66;66;66;67;66;67;67;67;66;67 08:04:37 INFO - PROCESS | 25227 | |10;stanford-crypto-aes;84;83;84;84;85;85;85;85;83;84 08:04:37 INFO - PROCESS | 25227 | |11;stanford-crypto-ccm;127;130;119;123;122;124;126;126;121;123 08:04:37 INFO - PROCESS | 25227 | |12;stanford-crypto-pbkdf2;143;150;149;147;147;135;148;149;137;135 08:04:37 INFO - PROCESS | 25227 | |13;stanford-crypto-sha256-iterative;72;71;72;69;71;70;70;72;70;71 08:04:37 INFO - PROCESS | 25227 | __end_tp_report 08:04:37 INFO - PROCESS | 25227 | __start_cc_report 08:04:37 INFO - PROCESS | 25227 | _x_x_mozilla_cycle_collect,791 08:04:37 INFO - PROCESS | 25227 | __end_cc_report 08:04:37 INFO - PROCESS | 25227 | __startTimestamp1452787477587__endTimestamp 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | ------- Summary: start ------- 08:04:37 INFO - PROCESS | 25227 | Number of tests: 14 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:4.63 (4.1%) stddev-sans-first:4.91 08:04:37 INFO - PROCESS | 25227 | Values: 115.0 109.0 116.0 113.0 114.0 127.0 114.0 114.0 113.0 114.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.00 stddev:10.96 (7.0%) stddev-sans-first:11.43 08:04:37 INFO - PROCESS | 25227 | Values: 158.0 137.0 156.0 169.0 139.0 153.0 159.0 149.0 164.0 140.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.44 (1.5%) stddev-sans-first:2.37 08:04:37 INFO - PROCESS | 25227 | Values: 162.0 164.0 165.0 163.0 165.0 171.0 164.0 164.0 166.0 164.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.50 stddev:23.02 (30.9%) stddev-sans-first:24.21 08:04:37 INFO - PROCESS | 25227 | Values: 74.0 73.0 76.0 75.0 147.0 74.0 73.0 75.0 72.0 87.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:97.00 stddev:20.08 (20.7%) stddev-sans-first:20.84 08:04:37 INFO - PROCESS | 25227 | Values: 98.0 97.0 138.0 97.0 98.0 97.0 146.0 97.0 98.0 131.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 08:04:37 INFO - PROCESS | 25227 | Values: 109.0 111.0 110.0 111.0 110.0 110.0 110.0 112.0 110.0 111.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 08:04:37 INFO - PROCESS | 25227 | Values: 148.0 151.0 148.0 149.0 147.0 148.0 148.0 148.0 147.0 148.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:04:37 INFO - PROCESS | 25227 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.50 stddev:1.05 (1.5%) stddev-sans-first:1.12 08:04:37 INFO - PROCESS | 25227 | Values: 72.0 72.0 72.0 71.0 73.0 73.0 71.0 73.0 70.0 73.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:04:37 INFO - PROCESS | 25227 | Values: 66.0 66.0 66.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 08:04:37 INFO - PROCESS | 25227 | Values: 84.0 83.0 84.0 84.0 85.0 85.0 85.0 85.0 83.0 84.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:3.21 (2.6%) stddev-sans-first:3.23 08:04:37 INFO - PROCESS | 25227 | Values: 127.0 130.0 119.0 123.0 122.0 124.0 126.0 126.0 121.0 123.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:147.50 stddev:6.07 (4.1%) stddev-sans-first:6.43 08:04:37 INFO - PROCESS | 25227 | Values: 143.0 150.0 149.0 147.0 147.0 135.0 148.0 149.0 137.0 135.0 08:04:37 INFO - PROCESS | 25227 | 08:04:37 INFO - PROCESS | 25227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 08:04:37 INFO - PROCESS | 25227 | Values: 72.0 71.0 72.0 69.0 71.0 70.0 70.0 72.0 70.0 71.0 08:04:37 INFO - PROCESS | 25227 | -------- Summary: end -------- 08:04:37 INFO - PROCESS | 25227 | 08:04:38 INFO - TEST-INFO | 25227: exit 0 08:04:38 INFO - TEST-OK | kraken | took 61496ms 08:04:38 INFO - TEST-START | v8_7 08:04:38 INFO - operating with platform_type : linux_ 08:04:38 INFO - Initialising browser for v8_7 test... 08:04:38 INFO - TEST-INFO | started process 25516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiHgMw/profile http://localhost:59560/getInfo.html) 08:04:42 INFO - PROCESS | 25516 | 08:04:42 INFO - PROCESS | 25516 | (process:25586): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:04:43 INFO - PROCESS | 25516 | __metrics Screen width/height:1600/1200 08:04:43 INFO - PROCESS | 25516 | colorDepth:24 08:04:43 INFO - PROCESS | 25516 | Browser inner width/height: 1024/697 08:04:43 INFO - PROCESS | 25516 | __metrics 08:04:43 INFO - PROCESS | 25516 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:04:44 INFO - TEST-INFO | 25516: exit 0 08:04:44 INFO - Browser initialized. 08:04:44 INFO - Running cycle 1/1 for v8_7 test... 08:04:44 INFO - TEST-INFO | started process 25635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiHgMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:45 INFO - PROCESS | 25635 | 08:04:45 INFO - PROCESS | 25635 | (process:25690): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:04:56 INFO - PROCESS | 25635 | RSS: Main: 148963328 08:04:56 INFO - PROCESS | 25635 | 08:05:18 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:59560/tests/v8_7/run.html (next: http://localhost:59560/tests/v8_7/run.html) 08:05:19 INFO - PROCESS | 25635 | RSS: Main: 144285696 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | __start_tp_report 08:05:19 INFO - PROCESS | 25635 | _x_x_mozilla_page_load 08:05:19 INFO - PROCESS | 25635 | _x_x_mozilla_page_load_details 08:05:19 INFO - PROCESS | 25635 | |i|pagename|runs| 08:05:19 INFO - PROCESS | 25635 | |0;Richards;171.79178835251676 08:05:19 INFO - PROCESS | 25635 | |1;DeltaBlue;187.5468867216804 08:05:19 INFO - PROCESS | 25635 | |2;Encrypt;279.4076557697681 08:05:19 INFO - PROCESS | 25635 | |3;Decrypt;5170.103092783505 08:05:19 INFO - PROCESS | 25635 | |4;RayTrace;1071.8113612004288 08:05:19 INFO - PROCESS | 25635 | |5;Earley;723.0657989877079 08:05:19 INFO - PROCESS | 25635 | |6;Boyer;12407.407407407407 08:05:19 INFO - PROCESS | 25635 | |7;RegExp;43234.04255319149 08:05:19 INFO - PROCESS | 25635 | |8;Splay;594.211458948612 08:05:19 INFO - PROCESS | 25635 | |9;NavierStokes;4826.923076923077 08:05:19 INFO - PROCESS | 25635 | __end_tp_report 08:05:19 INFO - PROCESS | 25635 | __startTimestamp1452787519005__endTimestamp 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | ------- Summary: start ------- 08:05:19 INFO - PROCESS | 25635 | Number of tests: 10 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#0] Richards Cycles:1 Average:171.79 Median:171.79 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 171.8 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#1] DeltaBlue Cycles:1 Average:187.55 Median:187.55 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 187.5 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 279.4 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 5170.1 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 1071.8 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#5] Earley Cycles:1 Average:723.07 Median:723.07 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 723.1 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 12407.4 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#7] RegExp Cycles:1 Average:43234.04 Median:43234.04 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 43234.0 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#8] Splay Cycles:1 Average:594.21 Median:594.21 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 594.2 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - PROCESS | 25635 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:05:19 INFO - PROCESS | 25635 | Values: 4826.9 08:05:19 INFO - PROCESS | 25635 | -------- Summary: end -------- 08:05:19 INFO - PROCESS | 25635 | 08:05:19 INFO - TEST-INFO | 25635: exit 0 08:05:19 INFO - TEST-OK | v8_7 | took 41355ms 08:05:19 INFO - SUITE-END | took 1217s 08:05:19 INFO - Completed test suite (00:20:17) 08:05:19 INFO - Working with test: dromaeo_css 08:05:19 INFO - Generating results file: dromaeo_css 08:05:19 INFO - Working with test: kraken 08:05:19 INFO - Generating results file: kraken 08:05:19 INFO - javascript benchmark 08:05:19 INFO - Working with test: v8_7 08:05:19 INFO - Generating results file: v8_7 08:05:19 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 08:05:20 INFO - process_Request line: dromaeo_css 6215.99 graph.html#tests=[[72,94,43]] 08:05:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:20 INFO - process_Request line: kraken 1540.60 graph.html#tests=[[232,94,43]] 08:05:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:20 INFO - process_Request line: v8_7 20218.90 graph.html#tests=[[230,94,43]] 08:05:20 INFO - RETURN: dromaeo_css: 6215.99 08:05:20 INFO - RETURN: kraken: 1540.60 08:05:20 INFO - RETURN: v8_7: 20218.90 08:05:20 INFO - javascript benchmark 08:05:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2643.048502539086, 2655.216711070234, 2687.5699888017907, 2688.6504754381926, 2703.8648067596628, 4498.775061246933, 4527.886802829927, 4563.2470642344015, 4578.15304168729, 4611.423572053489, 4563.954360456394, 4573.8170473181035, 4601.746903920283, 4653.7440440775745, 4675.181843177439, 4261.105167914741, 4314.84898028569, 4363.0619416825375, 4376.343548467739, 4416.2713152329825, 4312.137572485515, 4333.653307735373, 4339.913201735963, 4366.454193225847, 4438.533953934839, 4137.069159439102, 4222.535521092677, 4225.133847561273, 4246.893827654302, 4249.681273904454, 4251.59609837065, 4290.785460726983, 4291.527931927485, 4302.419173411612, 4317.309230523101, 4227.365895115727, 4266.2320782259185, 4274.487061552602, 4288.078063216423, 4317.827286908519, 4439.578240067189, 4452.599266066037, 4541.45502539694, 4550.931736023962, 4645.396098507173, 4908.852734417973, 4911.778969946361, 4913.631477639191, 4923.556879880792, 4982.402111746614, 4950.975245123787, 4954.90352779996, 4964.255361695738, 4965.975170124162, 5011.6241281904, 4499.955000449986, 4575.9771201143785, 4664.277037059193, 4710.552497512731, 4744.59670927975, 5056.418511871108, 5079.238114282887, 5083.694978301313, 5088.720120393414, 5092.745362731848, 4710.835120770825, 4826.710397376169, 4861.222204447272, 4866.829660961849, 4925.768557860535, 4829.372181616367, 4916.778744956486, 4971.801127954914, 4989.351384320088, 5029.622778291643, 4867.561919427269, 4923.359963204761, 4929.580985616263, 4938.9012219755405, 4946.5053494650965, 4724.622030237572, 4836.443808961944, 4905.730184839868, 4911.680740751911, 4948.6783359082265, 4079.102597428561, 4088.5911408858874, 4096.1193343431305, 4104.363823607286, 4121.5466298707115, 3592.1019745063736, 3624.655657712513, 3635.327464419091, 3653.50677658518, 3661.7802931824176, 4150.481189851269, 4226.070264541796, 4230.1539692061715, 4261.190373828963, 4273.209456250604, 4919.458859525449, 4924.556789888928, 4942.8764280893265, 4953.083679519301, 4984.3021976923255, 4225.598568136023, 4253.170631726845, 4256.787160641956, 4257.87226383209, 4300.247456695066, 4096.467459230281, 4173.499180098408, 4190.371444283382, 4349.412829268072, 4352.303631419021, 4627.259638457831, 4634.698744581591, 4682.321063445849, 4705.035467729039, 4741.644376671695, 4896.143174944442, 4907.950920490749, 4914.992426552477, 4920.6555541111775, 4967.230079337708, 4457.375967364506, 4572.291294849304, 4619.260918253063, 4646.953530464652, 4690.530946905282, 4804.5195480451675, 4815.590674792682, 4852.393450818648, 4873.95126048735, 4912.312276281395, 4883.340748998839, 4916.188828843201, 4921.163402221702, 4926.778294976806, 4967.60259179272, 4625.976870115628, 4735.337052812678, 4751.216049351819, 4765.189917713928, 4828.2998965150555, 4699.483056863811, 4732.171869922819, 4733.148033353892, 4736.952630473789, 4739.454962679336, 4725.5510726480925, 4737.9052418952115, 4740.075685241345, 4763.761811909321, 4796.9760151199025, 4696.272077827942, 4769.713817170981, 4776.02091571234, 4898.118338699069, 4913.385826771653, 4710.882227944328, 4748.0, 4774.522547745198, 4775.021120670323, 4798.520147985174], "unit": "score", "name": "dojo.html", "value": 4523.4483585787875}, {"lowerIsBetter": false, "replicates": [511.6827566908517, 517.3972322244585, 518.6810111781255, 538.8625900395399, 540.8026070484275, 32797.508037379455, 34017.319653606944, 34060.318793624116, 34076.0, 34124.0, 37798.0550486238, 38474.8076259619, 38476.230475390475, 38498.230035399276, 38574.61425385745, 7527.849443011137, 7727.884081738778, 7752.651130699132, 7766.766996990099, 7771.417143714216, 7492.7752167435065, 7579.090509138883, 7585.0, 7598.240175982385, 7633.961830190841, 7758.340541054017, 7824.256695613907, 7850.057993040843, 7865.4887432317, 7888.2506161914525, 7711.074671039483, 7739.3034626883855, 7747.225277472236, 7757.340626046793, 7768.300852923236, 7595.5442673439775, 7657.081150261948, 7684.077910650702, 7726.575038372887, 7766.106897706723, 37645.81177094125, 37784.811075944446, 38017.809910950265, 38130.0, 38186.618133818585, 3054.9694503054907, 3319.203391186098, 3354.8490317935507, 3371.96628033719, 3405.8297085145646, 28258.71741282602, 28276.575851362246, 28297.15108546747, 28325.150245492667, 29427.11718648444, 3467.497212904115, 3501.859925602973, 3566.625504322035, 3576.213233088716, 3588.766730162531, 221902.0, 222811.0, 222892.0, 223674.0, 223861.0, 47745.0, 48929.0, 56399.0, 57760.0, 57809.421905781244, 49432.25851612229, 49760.0, 50134.74932625386, 50189.0, 50294.0, 12720.0, 12864.48542058326, 12883.484660613658, 12901.677458063623, 12937.870621293854, 9707.0, 9792.069753373418, 9815.0, 9961.701148965543, 10015.799684006279, 19114.00989309077, 19533.121009554605, 19533.51166220856, 19674.21303147858, 19706.802931970782, 6743.56166849163, 6952.617606031717, 6997.93002069983, 7030.54301470413, 7077.787666370017, 761.2919984414548, 779.563444471098, 791.7783020754198, 941.6139382852997, 971.2521358553875, 25564.360890977503, 25803.225903222934, 26225.868870655526, 26433.339166520607, 26526.73473265281, 864.7449002544139, 914.2868562521111, 935.3639525122982, 938.5401153434905, 955.4888134847823, 11454.370009649549, 11516.0, 11544.134189935789, 11609.0, 11617.186796924134, 263758.0, 263855.0, 264210.0, 266521.0, 267321.0, 46204.5379546207, 46383.0, 46398.5360146401, 46741.06517869623, 46780.53219467762, 1221.1024896700917, 1234.3087870792206, 1235.2279825109126, 1235.2700531824769, 1331.4141777617817, 23796.446283051588, 23906.711355837968, 24023.382945612648, 24205.51588968246, 24298.906549204974, 41032.79483602563, 41133.58866411298, 41192.38211426771, 41408.171836563706, 41468.0, 243111.0, 243492.0, 243812.0, 243824.0, 245185.0, 28103.71896281011, 28270.293242669097, 28582.14253572396, 29030.564541531472, 29133.56299655549, 33743.4938475928, 33770.49344259887, 33862.0, 34446.48330274998, 34558.0, 28664.57003144913, 29274.707252927197, 29654.258643534085, 31227.0, 31997.040088797374, 31714.20714482064, 32240.0, 32503.0, 32507.34985300328, 32584.0, 31838.204044899063, 31985.72057117689, 32377.190570235933, 32501.34997300088, 32539.674603253665, 27608.0, 28560.285992850346, 28725.28186795347, 28897.85551072231, 29038.274043148245, 22804.543909121392, 22931.770682292965, 23017.85970982293, 23024.194153204557, 23071.423214419774], "unit": "score", "name": "ext.html", "value": 16295.936177967575}, {"lowerIsBetter": false, "replicates": [347.6627671158975, 348.84999450236387, 349.16549446822097, 350.4497938236969, 351.8311210618902, 13717.696818802211, 13939.721205575896, 14798.112113273211, 15475.380984760624, 15633.062016279031, 10150.3402278852, 10477.947610261957, 12521.373931303422, 15113.92443037786, 15158.0, 4464.888377790557, 4561.589456948874, 4616.192166370872, 4628.560286772768, 5008.073506401327, 4889.902201955959, 4963.677360971526, 4997.550220480156, 4998.150314446535, 5012.248162775576, 4693.671442998992, 4970.527799859025, 5321.122014867542, 5584.385717571064, 5588.273524441817, 4889.33993910821, 5113.846584602431, 5471.890562188773, 5492.47821456963, 5517.503424691777, 4741.336212930192, 4878.073166098466, 4899.069176856386, 4917.139500587383, 4927.50724927508, 16790.58023549409, 17589.64820703579, 17601.559961001076, 17846.91076544622, 17977.280908763634, 1795.703708888032, 1879.9450892300013, 1950.4733721895009, 1989.254029738848, 2048.528838367169, 12375.381230938418, 12589.937050314782, 12826.0, 12881.67795805103, 12898.484060637564, 1851.25949620153, 1917.309768483345, 1949.0, 1997.2709960864324, 2072.450800537859, 54722.17916731252, 56243.15635265474, 56943.14585281224, 56954.43045569574, 57291.0, 14470.204138772258, 14701.191434470993, 14710.55868323952, 14733.116013039253, 14739.0, 21758.0, 21983.670244946337, 22008.0, 22080.88959555192, 22131.557368852533, 8037.31682806968, 8050.59747012647, 8059.798505037304, 8106.513609183467, 8211.671533138608, 6635.137432133792, 6654.567453115532, 6696.732130714814, 6704.765333213314, 6721.0, 7261.164966028869, 7332.0, 7346.63266836656, 7390.667419966115, 7411.332980031823, 1695.2456157010013, 1804.3323970130873, 2834.6598408190735, 2896.232498387929, 2912.6796052434215, 720.42726032803, 789.455275859655, 836.0761358698672, 846.272205902923, 889.6485888074304, 14007.0, 14082.788758168635, 14563.563093107225, 15031.473898413504, 15286.0, 832.2592892325835, 861.7070196133345, 899.7525680437801, 904.7059705595708, 907.8547432410783, 8323.6670533178, 8459.280961118251, 8463.619137138843, 8654.697085601974, 8690.739277821676, 290195.0, 291804.0, 292901.0, 439278.0, 444940.0, 49508.75245623749, 51666.0, 57245.42754572401, 62065.0, 62113.68943155255, 1046.2937517175876, 1068.893110688925, 1075.774087441646, 1082.4317233452343, 1087.9891201088046, 13361.198328100345, 13496.662583435493, 13656.317184140555, 13668.794968075686, 13746.93126534361, 27461.725382745917, 28371.148865534065, 28897.711022890344, 30331.545026824173, 30642.540361894142, 36248.81875590711, 37549.62450375461, 37967.24065518729, 38273.808630956664, 38552.0, 6181.567290289637, 6348.143000694847, 6424.2933277338525, 6459.321771213955, 6564.606123632598, 7608.353289970414, 8612.397132200937, 9860.753481163028, 9977.600895964371, 10022.3485473444, 8347.499150051017, 8409.117042710428, 8507.489550626735, 8838.64645414202, 8854.114588541095, 8352.87470687928, 8497.405181637227, 8808.25129863943, 8951.597178126869, 9028.27773778083, 8732.126787321216, 8748.69379571712, 9043.276537876822, 9243.630254789734, 9317.301202409712, 6874.6562671867205, 6882.242953275236, 6931.0643063187845, 6987.231404545394, 7010.824729381806, 8300.2114799094, 8751.431156974777, 8890.33322500828, 9221.123993220634, 9390.859137113086], "unit": "score", "name": "jquery.html", "value": 7907.687792309561}, {"lowerIsBetter": false, "replicates": [1370.0, 1400.8739213470785, 1508.4946542908126, 1726.9897110190539, 1737.37454516374, 6240.84397890053, 6376.744930202786, 7151.141862976444, 7331.3768329691975, 7341.632918354087, 6828.897566536506, 6965.3731164195215, 7047.788566343005, 7049.083619129518, 7055.4355651547885, 2109.926152584656, 2143.453419378064, 2144.2066435418915, 2145.8927053647335, 2150.827933765295, 2085.0200405809323, 2087.060822629815, 2093.6859471079383, 2101.485136141647, 2110.1137522240697, 2072.678734796109, 2080.43828166395, 2081.583683263346, 2087.8016588424075, 2145.2598853395552, 2158.5251244726214, 2165.653495440722, 2169.2949791317883, 2169.381726208039, 2174.141214220382, 2075.418882712828, 2111.567128738605, 2117.7035215069905, 2119.184114116076, 2121.968170477444, 7378.5941773202985, 7406.629668516553, 7411.925880741232, 7427.628618569104, 7433.85132297351, 4173.979130104361, 4298.032942587924, 4307.870763877088, 4311.9651283692, 4315.676324275661, 2693.245891150481, 2716.5246081935584, 2744.464829358276, 2750.986245068762, 2756.2558109310576, 882.5410786391105, 885.2873436883307, 903.7333986474006, 911.3939230411768, 914.9451032938046, 10097.444640544767, 10121.898781012243, 10125.746856328651, 10142.695719128438, 10143.884172740993, 3903.4535165076913, 3919.1769728356794, 3942.7240093193773, 3971.0667993021616, 3980.0845805464905, 8603.827923441497, 8635.352348573757, 8638.524881131598, 8652.3510736695, 8654.524001179869, 4370.213361594943, 4393.758343291086, 4396.934045989313, 4399.032212913154, 4403.559644035571, 3403.897883063512, 3492.004778638127, 3816.0, 3970.940435893464, 3978.7214894957074, 3425.2635683328203, 3444.0012396405264, 3466.2201004773724, 3500.4224302989724, 3508.9298214035575, 1069.4225118436113, 1074.661481633283, 1077.5474300793685, 1077.7521170130915, 1080.3679847289425, 1143.0626885953604, 1152.6599653102355, 1157.3576664951033, 1162.2329262686587, 1190.000399664286, 6533.509986750918, 6570.211574611078, 6621.834454138685, 6657.3342665733035, 6659.167604049494, 403.8727800742757, 404.3934098851722, 409.53926832313647, 410.8130800485772, 412.9834806607702, 5215.295935048795, 5263.763130659129, 5275.736213189325, 5284.894302113936, 5299.761510731949, 8471.195236452528, 8508.872366914502, 8700.390972631854, 8790.780230494289, 8860.4240724354, 8592.95703521491, 8597.355198360148, 8621.353398495012, 8670.696525621574, 8681.088485709037, 6666.300038495985, 6710.932890671031, 6812.420944219698, 6845.657717114124, 6847.623380714009, 6422.967885160731, 6459.031145328238, 6486.254080780771, 6491.188601424822, 6498.0, 7657.0, 7773.572453515111, 7810.804729881571, 7816.06207255133, 7900.881486777588, 7791.844163116819, 8021.117677055403, 8030.759077227693, 8059.597020148852, 8099.028116626043, 5529.253550770755, 5667.3482549507335, 6008.128821320972, 6413.679316034087, 6507.219133703986, 6696.296888826603, 6792.0, 6802.8639427212165, 6817.931820681928, 6833.282505337067, 6082.178905847654, 6250.374962503895, 6342.746290148342, 6367.204099487564, 6374.872502550016, 6176.073588961692, 6230.532710046855, 6285.057241413824, 6325.051242313506, 6373.87252254943, 6438.484921206386, 6642.535022548375, 6696.397324240842, 6704.161979752531, 6712.093867328043, 5867.794627188028, 5956.583039187215, 5980.461758441761, 5986.042233242834, 5992.280926288873, 6050.606710563799, 6056.878862422815, 6064.0, 6077.787277445268, 6079.270487541523], "unit": "score", "name": "mootools.html", "value": 4042.4413720506127}, {"lowerIsBetter": false, "replicates": [322.1366737144453, 322.9321842413093, 323.9935201295976, 331.91370243736634, 332.5112085234705, 5363.8122665706705, 5453.481919217678, 5505.201745746869, 5505.807296744615, 5524.64089834161, 5326.760295786689, 5449.155380915964, 5471.398146203915, 5472.288602481672, 5473.644213126154, 4320.719153255036, 4323.718958267703, 4334.0, 4340.804663790137, 4343.370211319357, 4338.197433474801, 4338.305871060631, 4341.587549182838, 4343.67422443318, 4345.391645169679, 4062.796860156995, 4166.708330416872, 4301.139772045603, 4315.654747620199, 4324.027093903878, 4175.853845115422, 4201.1807697499, 4226.894327641833, 4235.237657221699, 4238.109996900655, 3686.870959516431, 3693.6121707220623, 3695.0762309422644, 3695.4087346024507, 3698.7780733156096, 5317.282166907496, 5321.760520776575, 5327.46725327468, 5337.092694241988, 5337.466253374631, 4755.9286610700865, 4877.585405240558, 4877.731724755137, 4892.363992680928, 4896.804127834882, 5755.510781583571, 5788.305403351583, 5802.796902108448, 5804.158397032406, 5806.361300256968, 3974.6621537169085, 4002.2595819773437, 4005.2990726623016, 4008.2584721826556, 4008.83964641414, 6029.577929544934, 6101.572889897709, 6104.114903339036, 6140.815775526741, 6203.16257305267, 3973.0663294125857, 4164.083901541656, 4166.187593419254, 4176.227397931331, 4182.2890108681595, 4187.330027195634, 4242.830286788494, 4247.745135291892, 4248.256555102845, 4250.3836943643, 4844.176489996709, 4867.026594681078, 4870.0746858096845, 4870.975645121823, 4872.610191184696, 5798.275215598051, 5804.535637149018, 5810.709464526757, 5811.244538210006, 5818.5345172386105, 1391.8747312741903, 1420.552525954321, 1461.3789139615621, 1505.7590785474272, 1507.1183357735847, 962.5668449197889, 977.7604486900755, 978.256525040974, 978.3982850547005, 983.7540614846289, 4990.925136122961, 5048.798048078036, 5050.015247026868, 5052.9242061369105, 5067.189249720101, 5928.584999050111, 5932.169496270526, 5941.168236446901, 5942.227510423617, 5952.375000624958, 5018.197088465828, 5032.7483625819295, 5037.4458809530925, 5042.268871013683, 5046.419661738947, 3156.700113489215, 3185.39477499279, 3236.3689080629524, 3236.967630323714, 3255.1211172983635, 5662.5753068520025, 5705.144228365695, 5715.571332150105, 5722.141678748138, 5726.226959360516, 6250.9062364064575, 6283.528735344776, 6291.276503202191, 6291.402316779899, 6298.370162983665, 5591.524720398812, 5711.057675483582, 5716.342620598602, 5718.370979192286, 5719.914201286984, 6062.575619706578, 6062.78780242707, 6064.696765161636, 6075.544334174866, 6078.7264573093435, 5940.970295148497, 5941.940580594139, 5942.881142377215, 5948.583599148191, 5948.73230704628, 5692.800751973661, 5700.315962084576, 5711.057675483665, 5718.1136923776885, 5718.599698021098, 4016.678665706795, 4045.5752146024242, 4061.1065565575527, 4088.7546747194074, 4102.364133559303, 5846.356900741001, 6076.969615151896, 6079.0, 6080.331163571915, 6096.78661246872, 5763.0, 5777.508911742549, 5789.681567513827, 5791.7683292667825, 5813.360530341574, 5773.769049237983, 5832.096025116114, 5837.562182836219, 5842.883142337215, 5844.211031510692, 5666.320041595035, 5707.800226992035, 5717.914231286617, 5717.971410142923, 5742.885142297047, 5682.772689092555, 5914.378990206139, 5914.615549989237, 5919.7040147991565, 5921.200637913998, 5734.655920644775, 5734.856628584319, 5735.598508104393, 5744.195812586157, 5746.310442746897], "unit": "score", "name": "prototype.html", "value": 4355.351244990644}, {"lowerIsBetter": false, "replicates": [730.6565914020408, 741.7515132430635, 759.4835511851941, 766.9118051424084, 778.7975126467117, 11540.422978851055, 11627.593034243813, 11653.475593598287, 11695.473703683334, 11714.238574492652, 11582.42087895606, 11588.768224635502, 11615.186936914419, 11633.592824251153, 11675.883241167587, 610.38351265222, 620.0915658560208, 773.0684525147199, 776.7980325115483, 791.6793698552095, 772.0233904111303, 783.682608543538, 783.8628240057996, 785.7132146766418, 788.6214616983851, 813.686730608717, 815.9143289954559, 818.5866137600533, 820.4625969989667, 820.5281962871372, 794.5351969098084, 796.3430170109654, 802.8554860125175, 805.0862271322092, 805.3195050182557, 603.2881200183781, 603.7253049862346, 604.0214851939842, 604.7611193578556, 606.130203158469, 11538.307701537935, 11554.133439992034, 11610.477528511237, 11612.129090318176, 11627.069834413227, 11553.364564948924, 11562.075033997344, 11710.707232319175, 11855.644330670008, 12179.0, 9219.688354182894, 9231.815363692756, 9283.535823208813, 9343.859842102305, 9887.802243955153, 3228.515722641599, 3302.2239773653173, 3309.9172520686934, 3312.685294897005, 3388.373150967079, 36987.0, 37194.81402592997, 37269.25461490755, 37415.4387684185, 37456.063598409986, 8806.77983050416, 9067.274618030542, 9076.319276054322, 9096.090390960984, 9105.590248438835, 14705.632359191106, 14823.332950017275, 15022.624434389008, 15115.395384184729, 15179.544613661608, 5936.287645482484, 6057.878842423215, 6072.635641861502, 6090.847728806815, 6168.321484636686, 3498.422760244582, 3523.894283171509, 3530.293941211768, 3539.5752509698486, 3549.716022718176, 2637.3802156493207, 2645.9470810584066, 2660.8270462419882, 2663.6803583570095, 2674.3982603913964, 468.62275867926644, 474.926386410107, 475.59099174709723, 479.08972951392633, 480.5098799224771, 590.6633219065178, 594.5956749410356, 613.8496068463255, 620.4416025576927, 621.9533534984894, 7339.88990165148, 7538.0, 7580.128285247267, 7631.771046868603, 7683.500572462772, 471.8112754898068, 600.6366148480107, 613.8557439001831, 617.299365220478, 634.0995785983914, 3512.473129030666, 3588.784672919633, 3756.417755247941, 3780.0738818989525, 3791.677707394847, 45777.31334029992, 45881.0, 46411.30383044257, 47425.0, 51528.22707659388, 41054.17891642151, 41176.794116029225, 41792.791036044626, 41793.0, 42142.946426339586, 36648.0, 37448.25103497915, 38198.618013820065, 38267.61732382696, 38529.22941541154, 7892.768452861784, 7991.2807847294025, 8213.0, 8256.504609723435, 8400.0, 27993.860030700533, 28898.0, 29574.112776616737, 29882.85058574693, 30161.69838301589, 34031.659683402846, 34104.31791364109, 34657.48013779745, 37251.6274837259, 38401.4239786409, 9870.555824987749, 9964.153046991087, 10300.278980471296, 10316.329438586468, 10411.895881041093, 11107.38909359993, 11301.830472543083, 11316.15128865355, 11623.76752464963, 11639.185257031926, 10493.370397776158, 10567.735806604896, 10754.89245107539, 10850.891491084989, 11447.25592836463, 10033.347832390871, 10052.296339256181, 10134.797304054026, 10386.636467723594, 10437.478126093816, 10193.847092293474, 10241.07830295277, 10467.738306542093, 10611.41637209961, 10910.563577457131, 9031.81936361256, 9045.547722613974, 9239.260859131118, 9373.437593744124, 9501.524923753646, 9302.720918372459, 9401.717948461557, 9447.574859131219, 9465.526723663927, 9639.325247232908], "unit": "score", "name": "yui.html", "value": 5620.2099220162345}], "name": "dromaeo_css", "value": 6215.987285966005}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 116.0, 113.0, 114.0, 127.0, 114.0, 114.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.9}, {"lowerIsBetter": true, "replicates": [158.0, 137.0, 156.0, 169.0, 139.0, 153.0, 159.0, 149.0, 164.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 165.0, 163.0, 165.0, 171.0, 164.0, 164.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 76.0, 75.0, 147.0, 74.0, 73.0, 75.0, 72.0, 87.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 138.0, 97.0, 98.0, 97.0, 146.0, 97.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 112.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 71.0, 73.0, 73.0, 71.0, 73.0, 70.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 119.0, 123.0, 122.0, 124.0, 126.0, 126.0, 121.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 149.0, 147.0, 147.0, 135.0, 148.0, 149.0, 137.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 69.0, 71.0, 70.0, 70.0, 72.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1540.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.79178835251676], "unit": "score", "name": "Richards", "value": 205.49294200000006}, {"lowerIsBetter": false, "replicates": [187.5468867216804], "unit": "score", "name": "DeltaBlue", "value": 352.54117599999995}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [723.0657989877079], "unit": "score", "name": "Earley", "value": 921.718329}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [43234.04255319149], "unit": "score", "name": "RegExp", "value": 21.071011318897654}, {"lowerIsBetter": false, "replicates": [594.211458948612], "unit": "score", "name": "Splay", "value": 137.1414145129225}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20218.90234534142}]} 08:05:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20218.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1540.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6215.99"}}} 08:05:20 INFO - Return code: 0 08:05:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:05:20 INFO - # TBPL SUCCESS # 08:05:20 INFO - Running post-action listener: _resource_record_post_action 08:05:20 INFO - Running post-run listener: _resource_record_post_run 08:05:21 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 542093312; Read time: 0; Write time: 433960 08:05:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 231837696; Read time: 0; Write time: 204784 08:05:21 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 310255616; Read time: 0; Write time: 229176 08:05:21 INFO - Running post-run listener: _upload_blobber_files 08:05:21 INFO - Blob upload gear active. 08:05:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:21 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 08:05:21 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:05:21 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:05:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:22 INFO - (blobuploader) - INFO - Done attempting. 08:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:23 INFO - (blobuploader) - INFO - Done attempting. 08:05:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:23 INFO - Return code: 0 08:05:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad19b039181aa2ad4ce5e7832682199213ca48ad4a3bbc7c7d63101b6bb9e3a8cd94047d489c61c5c98d34c06ebd079780c8db06719a16d3d5d3566432cf5775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd2a76d66c698bdc1f3963364c3aae41062e6d6f7f877232f0bbd0de9213286b6c101885b8ad7c4a284d145fa902b161b126714c10188eddca084b7368b9f6e"} 08:05:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:23 INFO - Contents: 08:05:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad19b039181aa2ad4ce5e7832682199213ca48ad4a3bbc7c7d63101b6bb9e3a8cd94047d489c61c5c98d34c06ebd079780c8db06719a16d3d5d3566432cf5775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd2a76d66c698bdc1f3963364c3aae41062e6d6f7f877232f0bbd0de9213286b6c101885b8ad7c4a284d145fa902b161b126714c10188eddca084b7368b9f6e"} 08:05:23 INFO - Copying logs to upload dir... 08:05:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.984335 ========= master_lag: 29.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-01-14 08:05:52.549256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 08:05:52.555543) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad19b039181aa2ad4ce5e7832682199213ca48ad4a3bbc7c7d63101b6bb9e3a8cd94047d489c61c5c98d34c06ebd079780c8db06719a16d3d5d3566432cf5775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd2a76d66c698bdc1f3963364c3aae41062e6d6f7f877232f0bbd0de9213286b6c101885b8ad7c4a284d145fa902b161b126714c10188eddca084b7368b9f6e"} build_url:https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010547 build_url: 'https://queue.taskcluster.net/v1/task/Bjs7blJNRJCIpW04qgeyeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad19b039181aa2ad4ce5e7832682199213ca48ad4a3bbc7c7d63101b6bb9e3a8cd94047d489c61c5c98d34c06ebd079780c8db06719a16d3d5d3566432cf5775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd2a76d66c698bdc1f3963364c3aae41062e6d6f7f877232f0bbd0de9213286b6c101885b8ad7c4a284d145fa902b161b126714c10188eddca084b7368b9f6e"}' ========= master_lag: 0.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 08:05:53.043731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:05:53.044056) ========= 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=ed14279e38b05397cf4aa391000001a4-1452786239.332125-1005278192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:05:53.064441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 08:05:53.064774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 08:05:53.065949) ========= ========= Total master_lag: 29.78 =========