builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1450701936.08 results: success (0) buildid: 20151221030135 builduid: d046ce8279b14050bd1acd043e0e5a21 revision: 3f3f0361567c418a2f7c23a1930ba8ac953d3358 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.081983) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.082494) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.082790) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006414 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.107172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.107487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.120879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.121275) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.170572) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.170877) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.171257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.171530) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 04:45:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-21 04:45:37 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.298385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.482073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.482365) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.531831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:36.532188) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3f3f0361567c418a2f7c23a1930ba8ac953d3358 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3f3f0361567c418a2f7c23a1930ba8ac953d3358 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 04:45:37,442 truncating revision to first 12 chars 2015-12-21 04:45:37,442 Setting DEBUG logging. 2015-12-21 04:45:37,443 attempt 1/10 2015-12-21 04:45:37,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3f3f0361567c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 04:45:37,689 unpacking tar archive at: fx-team-3f3f0361567c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519122 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:37.064089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:37.064399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:37.072907) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:37.073287) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:45:37.073771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 04:45:37.074087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:38 INFO - MultiFileLogger online at 20151221 04:45:38 in /builds/slave/test 04:45:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:45:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:38 INFO - {'append_to_log': False, 04:45:38 INFO - 'base_work_dir': '/builds/slave/test', 04:45:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:45:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:38 INFO - 'branch': 'Fx-Team-Non-PGO', 04:45:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:38 INFO - 'config_files': ('talos/linux_config.py',), 04:45:38 INFO - 'default_actions': ('clobber', 04:45:38 INFO - 'read-buildbot-config', 04:45:38 INFO - 'download-and-extract', 04:45:38 INFO - 'populate-webroot', 04:45:38 INFO - 'create-virtualenv', 04:45:38 INFO - 'install', 04:45:38 INFO - 'run-tests'), 04:45:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:38 INFO - 'download_minidump_stackwalk': True, 04:45:38 INFO - 'download_symbols': 'ondemand', 04:45:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:38 INFO - 'installer_path': 'installer.exe', 04:45:38 INFO - 'log_level': 'info', 04:45:38 INFO - 'log_name': 'talos', 04:45:38 INFO - 'log_to_console': True, 04:45:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:38 INFO - 'opt_config_files': (), 04:45:38 INFO - 'pip_index': False, 04:45:38 INFO - 'sps_profile': False, 04:45:38 INFO - 'sps_profile_interval': 0, 04:45:38 INFO - 'suite': 'dromaeojs', 04:45:38 INFO - 'system_bits': '64', 04:45:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:38 INFO - 'title': 'talos-linux64-ix-057', 04:45:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:38 INFO - 'use_talos_json': True, 04:45:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:38 INFO - 'work_dir': 'build'} 04:45:38 INFO - ##### 04:45:38 INFO - ##### Running clobber step. 04:45:38 INFO - ##### 04:45:38 INFO - Running pre-action listener: _resource_record_pre_action 04:45:38 INFO - Running main action method: clobber 04:45:38 INFO - rmtree: /builds/slave/test/build 04:45:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:38 INFO - Running post-action listener: _resource_record_post_action 04:45:38 INFO - ##### 04:45:38 INFO - ##### Running read-buildbot-config step. 04:45:38 INFO - ##### 04:45:38 INFO - Running pre-action listener: _resource_record_pre_action 04:45:38 INFO - Running main action method: read_buildbot_config 04:45:38 INFO - Using buildbot properties: 04:45:38 INFO - { 04:45:38 INFO - "project": "", 04:45:38 INFO - "product": "firefox", 04:45:38 INFO - "script_repo_revision": "production", 04:45:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:45:38 INFO - "repository": "", 04:45:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:45:38 INFO - "buildid": "20151221030135", 04:45:38 INFO - "pgo_build": "False", 04:45:38 INFO - "basedir": "/builds/slave/test", 04:45:38 INFO - "buildnumber": 2236, 04:45:38 INFO - "slavename": "talos-linux64-ix-057", 04:45:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:38 INFO - "platform": "ubuntu64_hw", 04:45:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:45:38 INFO - "branch": "fx-team", 04:45:38 INFO - "repo_path": "integration/fx-team", 04:45:38 INFO - "revision": "3f3f0361567c418a2f7c23a1930ba8ac953d3358", 04:45:38 INFO - "stage_platform": "linux64", 04:45:38 INFO - "builduid": "d046ce8279b14050bd1acd043e0e5a21", 04:45:38 INFO - "slavebuilddir": "test" 04:45:38 INFO - } 04:45:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:45:38 INFO - Running post-action listener: _resource_record_post_action 04:45:38 INFO - ##### 04:45:38 INFO - ##### Running download-and-extract step. 04:45:38 INFO - ##### 04:45:38 INFO - Running pre-action listener: _resource_record_pre_action 04:45:38 INFO - Running main action method: download_and_extract 04:45:38 INFO - mkdir: /builds/slave/test/build/tests 04:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:38 INFO - https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/test_packages.json 04:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/test_packages.json 04:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:45:40 INFO - Downloaded 1302 bytes. 04:45:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:45:40 INFO - Using the following test package requirements: 04:45:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'jsshell-linux-x86_64.zip'], 04:45:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:45:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:45:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:40 INFO - https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:41 INFO - Downloaded 21926753 bytes. 04:45:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:45:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:45:42 INFO - Return code: 0 04:45:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:45: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')]} 04:45:42 INFO - https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:46 INFO - Downloaded 21926753 bytes. 04:45:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:45:47 INFO - Return code: 0 04:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:47 INFO - https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:45:48 INFO - Downloaded 11132277 bytes. 04:45:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:45:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:45:48 INFO - Return code: 0 04:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:48 INFO - https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:45:49 INFO - Downloaded 53387732 bytes. 04:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:49 INFO - mkdir: /builds/slave/test/properties 04:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:49 INFO - Contents: 04:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:49 INFO - Running post-action listener: _resource_record_post_action 04:45:49 INFO - Running post-action listener: set_extra_try_arguments 04:45:49 INFO - ##### 04:45:49 INFO - ##### Running populate-webroot step. 04:45:49 INFO - ##### 04:45:49 INFO - Running pre-action listener: _resource_record_pre_action 04:45:49 INFO - Running main action method: populate_webroot 04:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:49 INFO - '--tppagecycles', 04:45:49 INFO - '7'], 04:45:49 INFO - 'tests': ['tsvgm']}}, 04:45:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:45:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:45:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:45:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'tests': ['damp', 'tps']}, 04:45:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['damp', 'tps']}, 04:45:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:49 INFO - 'other': {'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'other_l64': {'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'other_nol64': {'tests': ['a11yr', 04:45:49 INFO - 'ts_paint', 04:45:49 INFO - 'tpaint', 04:45:49 INFO - 'sessionrestore', 04:45:49 INFO - 'sessionrestore_no_auto_restore']}, 04:45:49 INFO - 'svgr': {'tests': ['tsvgx', 04:45:49 INFO - 'tsvgr_opacity', 04:45:49 INFO - 'tart', 04:45:49 INFO - 'tscrollx', 04:45:49 INFO - 'cart']}, 04:45:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['tsvgx', 04:45:49 INFO - 'tsvgr_opacity', 04:45:49 INFO - 'tart', 04:45:49 INFO - 'tscrollx', 04:45:49 INFO - 'cart']}, 04:45:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'tests': ['tp5o']}, 04:45:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'talos_options': ['--e10s'], 04:45:49 INFO - 'tests': ['tp5o']}, 04:45:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'talos_options': ['--xperf_path', 04:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:49 INFO - 'tests': ['tp5n']}, 04:45:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:49 INFO - 'talos_options': ['--e10s', 04:45:49 INFO - '--xperf_path', 04:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:49 INFO - 'tests': ['tp5n']}}, 04:45:49 INFO - 'talos.zip': {'path': '', 04:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:49 INFO - Running post-action listener: _resource_record_post_action 04:45:49 INFO - ##### 04:45:49 INFO - ##### Running create-virtualenv step. 04:45:49 INFO - ##### 04:45:49 INFO - Running pre-action listener: _resource_record_pre_action 04:45:49 INFO - Running main action method: create_virtualenv 04:45:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:49 INFO - Using real prefix '/usr' 04:45:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:52 INFO - Installing pip.................done. 04:45:52 INFO - Return code: 0 04:45:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:52 INFO - Using env: {'DISPLAY': ':0', 04:45:52 INFO - 'HOME': '/home/cltbld', 04:45:52 INFO - 'LANG': 'en_US.UTF-8', 04:45:52 INFO - 'LANGUAGE': 'en_US:en', 04:45:52 INFO - 'LOGNAME': 'cltbld', 04:45:52 INFO - 'MAIL': '/var/mail/cltbld', 04:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:52 INFO - 'MOZ_NO_REMOTE': '1', 04:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:52 INFO - 'NO_EM_RESTART': '1', 04:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:52 INFO - 'PWD': '/builds/slave/test', 04:45:52 INFO - 'SHELL': '/bin/bash', 04:45:52 INFO - 'SHLVL': '1', 04:45:52 INFO - 'TERM': 'linux', 04:45:52 INFO - 'TMOUT': '86400', 04:45:52 INFO - 'USER': 'cltbld', 04:45:52 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:52 INFO - '_': '/tools/buildbot/bin/python'} 04:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:45:52 INFO - Cleaning up... 04:45:52 INFO - Return code: 0 04:45:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:45:52 INFO - Using env: {'DISPLAY': ':0', 04:45:52 INFO - 'HOME': '/home/cltbld', 04:45:52 INFO - 'LANG': 'en_US.UTF-8', 04:45:52 INFO - 'LANGUAGE': 'en_US:en', 04:45:52 INFO - 'LOGNAME': 'cltbld', 04:45:52 INFO - 'MAIL': '/var/mail/cltbld', 04:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:52 INFO - 'MOZ_NO_REMOTE': '1', 04:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:52 INFO - 'NO_EM_RESTART': '1', 04:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:52 INFO - 'PWD': '/builds/slave/test', 04:45:52 INFO - 'SHELL': '/bin/bash', 04:45:52 INFO - 'SHLVL': '1', 04:45:52 INFO - 'TERM': 'linux', 04:45:52 INFO - 'TMOUT': '86400', 04:45:52 INFO - 'USER': 'cltbld', 04:45:52 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:52 INFO - '_': '/tools/buildbot/bin/python'} 04:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:52 INFO - Downloading/unpacking psutil>=0.7.1 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:54 INFO - Installing collected packages: psutil 04:45:54 INFO - Running setup.py install for psutil 04:45:54 INFO - building 'psutil._psutil_linux' extension 04:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:45:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:45:54 INFO - building 'psutil._psutil_posix' extension 04:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:45:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:55 INFO - Successfully installed psutil 04:45:55 INFO - Cleaning up... 04:45:55 INFO - Return code: 0 04:45:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:45:55 INFO - Using env: {'DISPLAY': ':0', 04:45:55 INFO - 'HOME': '/home/cltbld', 04:45:55 INFO - 'LANG': 'en_US.UTF-8', 04:45:55 INFO - 'LANGUAGE': 'en_US:en', 04:45:55 INFO - 'LOGNAME': 'cltbld', 04:45:55 INFO - 'MAIL': '/var/mail/cltbld', 04:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:55 INFO - 'MOZ_NO_REMOTE': '1', 04:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:55 INFO - 'NO_EM_RESTART': '1', 04:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:55 INFO - 'PWD': '/builds/slave/test', 04:45:55 INFO - 'SHELL': '/bin/bash', 04:45:55 INFO - 'SHLVL': '1', 04:45:55 INFO - 'TERM': 'linux', 04:45:55 INFO - 'TMOUT': '86400', 04:45:55 INFO - 'USER': 'cltbld', 04:45:55 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:55 INFO - '_': '/tools/buildbot/bin/python'} 04:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:45:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:45:57 INFO - Installing collected packages: mozsystemmonitor 04:45:57 INFO - Running setup.py install for mozsystemmonitor 04:45:57 INFO - Successfully installed mozsystemmonitor 04:45:57 INFO - Cleaning up... 04:45:57 INFO - Return code: 0 04:45:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:45:57 INFO - Using env: {'DISPLAY': ':0', 04:45:57 INFO - 'HOME': '/home/cltbld', 04:45:57 INFO - 'LANG': 'en_US.UTF-8', 04:45:57 INFO - 'LANGUAGE': 'en_US:en', 04:45:57 INFO - 'LOGNAME': 'cltbld', 04:45:57 INFO - 'MAIL': '/var/mail/cltbld', 04:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:57 INFO - 'MOZ_NO_REMOTE': '1', 04:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:57 INFO - 'NO_EM_RESTART': '1', 04:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:57 INFO - 'PWD': '/builds/slave/test', 04:45:57 INFO - 'SHELL': '/bin/bash', 04:45:57 INFO - 'SHLVL': '1', 04:45:57 INFO - 'TERM': 'linux', 04:45:57 INFO - 'TMOUT': '86400', 04:45:57 INFO - 'USER': 'cltbld', 04:45:57 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:57 INFO - '_': '/tools/buildbot/bin/python'} 04:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:59 INFO - Downloading docopt-0.6.1.tar.gz 04:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:59 INFO - Running setup.py install for blobuploader 04:45:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:59 INFO - Running setup.py install for requests 04:46:00 INFO - Running setup.py install for docopt 04:46:00 INFO - Successfully installed blobuploader requests docopt 04:46:00 INFO - Cleaning up... 04:46:00 INFO - Return code: 0 04:46:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:00 INFO - Using env: {'DISPLAY': ':0', 04:46:00 INFO - 'HOME': '/home/cltbld', 04:46:00 INFO - 'LANG': 'en_US.UTF-8', 04:46:00 INFO - 'LANGUAGE': 'en_US:en', 04:46:00 INFO - 'LOGNAME': 'cltbld', 04:46:00 INFO - 'MAIL': '/var/mail/cltbld', 04:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:00 INFO - 'MOZ_NO_REMOTE': '1', 04:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:00 INFO - 'NO_EM_RESTART': '1', 04:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:00 INFO - 'PWD': '/builds/slave/test', 04:46:00 INFO - 'SHELL': '/bin/bash', 04:46:00 INFO - 'SHLVL': '1', 04:46:00 INFO - 'TERM': 'linux', 04:46:00 INFO - 'TMOUT': '86400', 04:46:00 INFO - 'USER': 'cltbld', 04:46:00 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:00 INFO - '_': '/tools/buildbot/bin/python'} 04:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:00 INFO - Running setup.py (path:/tmp/pip-bBXfty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:00 INFO - Running setup.py (path:/tmp/pip-l7eOgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:00 INFO - Running setup.py (path:/tmp/pip-Of5syU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:00 INFO - Running setup.py (path:/tmp/pip-ZI8kfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:01 INFO - Running setup.py (path:/tmp/pip-9kNM_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:01 INFO - Running setup.py (path:/tmp/pip-tz2rcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:01 INFO - Running setup.py (path:/tmp/pip-L8gMxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:01 INFO - Running setup.py (path:/tmp/pip-6e9PjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:01 INFO - Running setup.py (path:/tmp/pip-JZ7ruO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:01 INFO - Running setup.py (path:/tmp/pip-y2E1Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:01 INFO - Running setup.py (path:/tmp/pip-ZtPFKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:01 INFO - Running setup.py (path:/tmp/pip-8DF9_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:01 INFO - Running setup.py (path:/tmp/pip-qf1vQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:01 INFO - Running setup.py (path:/tmp/pip-yKZI58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:01 INFO - Running setup.py (path:/tmp/pip-BxBrTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:01 INFO - Running setup.py (path:/tmp/pip-dNtq2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:01 INFO - Running setup.py (path:/tmp/pip-zWyeIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:01 INFO - Running setup.py install for manifestparser 04:46:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for mozcrash 04:46:02 INFO - Running setup.py install for mozdebug 04:46:02 INFO - Running setup.py install for mozdevice 04:46:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for mozfile 04:46:02 INFO - Running setup.py install for mozhttpd 04:46:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for mozinfo 04:46:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for mozInstall 04:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for mozleak 04:46:02 INFO - Running setup.py install for mozlog 04:46:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:02 INFO - Running setup.py install for moznetwork 04:46:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Running setup.py install for mozprocess 04:46:03 INFO - Running setup.py install for mozprofile 04:46:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Running setup.py install for mozrunner 04:46:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Running setup.py install for mozscreenshot 04:46:03 INFO - Running setup.py install for moztest 04:46:03 INFO - Running setup.py install for mozversion 04:46:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:03 INFO - Cleaning up... 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:03 INFO - Using env: {'DISPLAY': ':0', 04:46:03 INFO - 'HOME': '/home/cltbld', 04:46:03 INFO - 'LANG': 'en_US.UTF-8', 04:46:03 INFO - 'LANGUAGE': 'en_US:en', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MAIL': '/var/mail/cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SHLVL': '1', 04:46:03 INFO - 'TERM': 'linux', 04:46:03 INFO - 'TMOUT': '86400', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - '_': '/tools/buildbot/bin/python'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:03 INFO - Running setup.py (path:/tmp/pip-1AmVl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:03 INFO - Running setup.py (path:/tmp/pip-vfG341-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:04 INFO - Running setup.py (path:/tmp/pip-XXY2JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:04 INFO - Running setup.py (path:/tmp/pip-_KkWmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:04 INFO - Running setup.py (path:/tmp/pip-cBGlQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:04 INFO - Running setup.py (path:/tmp/pip-c8ZOAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:04 INFO - Running setup.py (path:/tmp/pip-MmJfxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:04 INFO - Running setup.py (path:/tmp/pip-xlUn0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:04 INFO - Running setup.py (path:/tmp/pip-5A0ZzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:04 INFO - Running setup.py (path:/tmp/pip-D1uEAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:04 INFO - Running setup.py (path:/tmp/pip-XzpWtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:04 INFO - Running setup.py (path:/tmp/pip-9Cxv1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:04 INFO - Running setup.py (path:/tmp/pip-p53O8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:04 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)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:04 INFO - Running setup.py (path:/tmp/pip-4pd3rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:04 INFO - Running setup.py (path:/tmp/pip-Xaavp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:05 INFO - Running setup.py (path:/tmp/pip-Yfxc49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:05 INFO - Running setup.py (path:/tmp/pip-8oTm_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - Downloading blessings-1.5.1.tar.gz 04:46:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:06 INFO - Installing collected packages: blessings 04:46:06 INFO - Running setup.py install for blessings 04:46:07 INFO - Successfully installed blessings 04:46:07 INFO - Cleaning up... 04:46:07 INFO - Return code: 0 04:46:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:07 INFO - Reading from file tmpfile_stdout 04:46:07 INFO - Current package versions: 04:46:07 INFO - argparse == 1.2.1 04:46:07 INFO - blessings == 1.5.1 04:46:07 INFO - blobuploader == 1.2.4 04:46:07 INFO - docopt == 0.6.1 04:46:07 INFO - manifestparser == 1.1 04:46:07 INFO - mozInstall == 1.12 04:46:07 INFO - mozcrash == 0.16 04:46:07 INFO - mozdebug == 0.1 04:46:07 INFO - mozdevice == 0.47 04:46:07 INFO - mozfile == 1.2 04:46:07 INFO - mozhttpd == 0.7 04:46:07 INFO - mozinfo == 0.9 04:46:07 INFO - mozleak == 0.1 04:46:07 INFO - mozlog == 3.1 04:46:07 INFO - moznetwork == 0.27 04:46:07 INFO - mozprocess == 0.22 04:46:07 INFO - mozprofile == 0.28 04:46:07 INFO - mozrunner == 6.11 04:46:07 INFO - mozscreenshot == 0.1 04:46:07 INFO - mozsystemmonitor == 0.0 04:46:07 INFO - moztest == 0.7 04:46:07 INFO - mozversion == 1.4 04:46:07 INFO - psutil == 3.1.1 04:46:07 INFO - requests == 1.2.3 04:46:07 INFO - wsgiref == 0.1.2 04:46:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:07 INFO - Using env: {'DISPLAY': ':0', 04:46:07 INFO - 'HOME': '/home/cltbld', 04:46:07 INFO - 'LANG': 'en_US.UTF-8', 04:46:07 INFO - 'LANGUAGE': 'en_US:en', 04:46:07 INFO - 'LOGNAME': 'cltbld', 04:46:07 INFO - 'MAIL': '/var/mail/cltbld', 04:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:07 INFO - 'MOZ_NO_REMOTE': '1', 04:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:07 INFO - 'NO_EM_RESTART': '1', 04:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:07 INFO - 'PWD': '/builds/slave/test', 04:46:07 INFO - 'SHELL': '/bin/bash', 04:46:07 INFO - 'SHLVL': '1', 04:46:07 INFO - 'TERM': 'linux', 04:46:07 INFO - 'TMOUT': '86400', 04:46:07 INFO - 'USER': 'cltbld', 04:46:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:07 INFO - '_': '/tools/buildbot/bin/python'} 04:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 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)) 04:46:07 INFO - Cleaning up... 04:46:07 INFO - Return code: 0 04:46:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:07 INFO - Using env: {'DISPLAY': ':0', 04:46:07 INFO - 'HOME': '/home/cltbld', 04:46:07 INFO - 'LANG': 'en_US.UTF-8', 04:46:07 INFO - 'LANGUAGE': 'en_US:en', 04:46:07 INFO - 'LOGNAME': 'cltbld', 04:46:07 INFO - 'MAIL': '/var/mail/cltbld', 04:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:07 INFO - 'MOZ_NO_REMOTE': '1', 04:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:07 INFO - 'NO_EM_RESTART': '1', 04:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:07 INFO - 'PWD': '/builds/slave/test', 04:46:07 INFO - 'SHELL': '/bin/bash', 04:46:07 INFO - 'SHLVL': '1', 04:46:07 INFO - 'TERM': 'linux', 04:46:07 INFO - 'TMOUT': '86400', 04:46:07 INFO - 'USER': 'cltbld', 04:46:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:07 INFO - '_': '/tools/buildbot/bin/python'} 04:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:07 INFO - Downloading/unpacking jsonschema 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:46:09 INFO - Downloading/unpacking functools32 (from jsonschema) 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:09 INFO - warning: no files found matching '*.txt' 04:46:09 INFO - no previously-included directories found matching 'build' 04:46:09 INFO - no previously-included directories found matching 'dist' 04:46:09 INFO - no previously-included directories found matching '.git*' 04:46:09 INFO - Installing collected packages: jsonschema, functools32 04:46:09 INFO - Running setup.py install for functools32 04:46:09 INFO - warning: no files found matching '*.txt' 04:46:09 INFO - no previously-included directories found matching 'build' 04:46:09 INFO - no previously-included directories found matching 'dist' 04:46:09 INFO - no previously-included directories found matching '.git*' 04:46:09 INFO - Successfully installed jsonschema functools32 04:46:09 INFO - Cleaning up... 04:46:09 INFO - Return code: 0 04:46:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29180acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2033dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:46:09 INFO - Using env: {'DISPLAY': ':0', 04:46:09 INFO - 'HOME': '/home/cltbld', 04:46:09 INFO - 'LANG': 'en_US.UTF-8', 04:46:09 INFO - 'LANGUAGE': 'en_US:en', 04:46:09 INFO - 'LOGNAME': 'cltbld', 04:46:09 INFO - 'MAIL': '/var/mail/cltbld', 04:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:09 INFO - 'MOZ_NO_REMOTE': '1', 04:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:09 INFO - 'NO_EM_RESTART': '1', 04:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:09 INFO - 'PWD': '/builds/slave/test', 04:46:09 INFO - 'SHELL': '/bin/bash', 04:46:09 INFO - 'SHLVL': '1', 04:46:09 INFO - 'TERM': 'linux', 04:46:09 INFO - 'TMOUT': '86400', 04:46:09 INFO - 'USER': 'cltbld', 04:46:09 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:09 INFO - '_': '/tools/buildbot/bin/python'} 04:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:10 INFO - Downloading/unpacking flake8 04:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:46:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:46:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:46:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:12 INFO - no previously-included directories found matching 'docs/_build' 04:46:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:46:12 INFO - Running setup.py install for pep8 04:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:12 INFO - no previously-included directories found matching 'docs/_build' 04:46:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:46:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:46:12 INFO - Cleaning up... 04:46:12 INFO - Return code: 0 04:46:12 INFO - Running post-action listener: _resource_record_post_action 04:46:12 INFO - Running post-action listener: _start_resource_monitoring 04:46:12 INFO - Starting resource monitoring. 04:46:12 INFO - ##### 04:46:12 INFO - ##### Running install step. 04:46:12 INFO - ##### 04:46:12 INFO - Running pre-action listener: _resource_record_pre_action 04:46:12 INFO - Running main action method: install 04:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:12 INFO - Reading from file tmpfile_stdout 04:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:12 INFO - Reading from file tmpfile_stdout 04:46:12 INFO - Output received: 04:46:12 INFO - Usage: mozinstall [options] installer 04:46:12 INFO - Options: 04:46:12 INFO - -h, --help show this help message and exit 04:46:12 INFO - -d DEST, --destination=DEST 04:46:12 INFO - Directory to install application into. [default: 04:46:12 INFO - "/builds/slave/test"] 04:46:12 INFO - --app=APP Application being installed. [default: firefox] 04:46:12 INFO - mkdir: /builds/slave/test/build/application 04:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:46:28 INFO - Reading from file tmpfile_stdout 04:46:28 INFO - Output received: 04:46:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:46:28 INFO - Running post-action listener: _resource_record_post_action 04:46:28 INFO - ##### 04:46:28 INFO - ##### Running run-tests step. 04:46:28 INFO - ##### 04:46:28 INFO - Running pre-action listener: _resource_record_pre_action 04:46:28 INFO - Running main action method: run_tests 04:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:28 INFO - Python 2.7.3 04:46:28 INFO - Return code: 0 04:46:28 INFO - grabbing minidump binary from tooltool 04:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:28 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 0x20c63d0>, '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 0x2031ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2032360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:46:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:46:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:28 INFO - Return code: 0 04:46:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:46:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:46:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:46:29 INFO - Return code: 0 04:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:46:29 INFO - Using env: {'DISPLAY': ':0', 04:46:29 INFO - 'HOME': '/home/cltbld', 04:46:29 INFO - 'LANG': 'en_US.UTF-8', 04:46:29 INFO - 'LANGUAGE': 'en_US:en', 04:46:29 INFO - 'LOGNAME': 'cltbld', 04:46:29 INFO - 'MAIL': '/var/mail/cltbld', 04:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:29 INFO - 'MOZ_NO_REMOTE': '1', 04:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:29 INFO - 'NO_EM_RESTART': '1', 04:46:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:29 INFO - 'PWD': '/builds/slave/test', 04:46:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:29 INFO - 'SHELL': '/bin/bash', 04:46:29 INFO - 'SHLVL': '1', 04:46:29 INFO - 'TERM': 'linux', 04:46:29 INFO - 'TMOUT': '86400', 04:46:29 INFO - 'USER': 'cltbld', 04:46:29 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605', 04:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:29 INFO - '_': '/tools/buildbot/bin/python'} 04:46:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:46:29 INFO - mozversion application_buildid: 20151221030135 04:46:29 INFO - mozversion application_changeset: 3f3f0361567c418a2f7c23a1930ba8ac953d3358 04:46:29 INFO - mozversion application_display_name: Nightly 04:46:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:29 INFO - mozversion application_name: Firefox 04:46:29 INFO - mozversion application_remotingname: firefox 04:46:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:46:29 INFO - mozversion application_vendor: Mozilla 04:46:29 INFO - mozversion application_version: 46.0a1 04:46:29 INFO - mozversion platform_buildid: 20151221030135 04:46:29 INFO - mozversion platform_changeset: 3f3f0361567c418a2f7c23a1930ba8ac953d3358 04:46:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:46:29 INFO - mozversion platform_version: 46.0a1 04:46:29 INFO - using testdate: 1450701989 04:46:29 INFO - actual date: 1450701989 04:46:29 INFO - starting webserver on 'localhost:58565' 04:46:29 INFO - SUITE-START | Running 3 tests 04:46:29 INFO - TEST-START | dromaeo_css 04:46:29 INFO - operating with platform_type : linux_ 04:46:29 INFO - Initialising browser for dromaeo_css test... 04:46:29 INFO - TEST-INFO | started process 26113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHQRBU/profile http://localhost:58565/getInfo.html) 04:46:33 INFO - PROCESS | 26113 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:46:33 INFO - PROCESS | 26113 | __metrics Screen width/height:1600/1200 04:46:33 INFO - PROCESS | 26113 | colorDepth:24 04:46:33 INFO - PROCESS | 26113 | Browser inner width/height: 1024/697 04:46:33 INFO - PROCESS | 26113 | __metrics 04:46:33 INFO - PROCESS | 26113 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:46:33 INFO - PROCESS | 26113 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:35 INFO - TEST-INFO | 26113: exit 0 04:46:35 INFO - Browser initialized. 04:46:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:35 INFO - TEST-INFO | started process 26204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHQRBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:47 INFO - PROCESS | 26204 | RSS: Main: 149864448 04:46:47 INFO - PROCESS | 26204 | 04:47:38 INFO - PROCESS | 26204 | 1450702058049 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:49:50 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58565/tests/dromaeo/cssquery-ext.html) 04:49:51 INFO - PROCESS | 26204 | RSS: Main: 282374144 04:49:51 INFO - PROCESS | 26204 | 04:52:54 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-ext.html (next: http://localhost:58565/tests/dromaeo/cssquery-jquery.html) 04:52:54 INFO - PROCESS | 26204 | RSS: Main: 225492992 04:52:54 INFO - PROCESS | 26204 | 04:55:56 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58565/tests/dromaeo/cssquery-mootools.html) 04:55:57 INFO - PROCESS | 26204 | RSS: Main: 223596544 04:55:57 INFO - PROCESS | 26204 | 04:58:59 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58565/tests/dromaeo/cssquery-prototype.html) 04:58:59 INFO - PROCESS | 26204 | RSS: Main: 204828672 04:58:59 INFO - PROCESS | 26204 | 05:02:02 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58565/tests/dromaeo/cssquery-yui.html) 05:02:03 INFO - PROCESS | 26204 | RSS: Main: 208064512 05:02:03 INFO - PROCESS | 26204 | 05:05:05 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:58565/tests/dromaeo/cssquery-yui.html (next: http://localhost:58565/tests/dromaeo/cssquery-dojo.html) 05:05:06 INFO - PROCESS | 26204 | RSS: Main: 296968192 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | __start_tp_report 05:05:06 INFO - PROCESS | 26204 | _x_x_mozilla_page_load 05:05:06 INFO - PROCESS | 26204 | _x_x_mozilla_page_load_details 05:05:06 INFO - PROCESS | 26204 | |i|pagename|runs| 05:05:06 INFO - PROCESS | 26204 | |0;dojo.html;2579.909703160389;2630.1189101650934;2634.4335967766924;2646.192911162095;2666.506696261192;4377.277749171383;4500.954990450098;4505.459344878615;4545.318202269657;4558.680892337529;4569.177548041352;4657.51096134906;4671.159191345557;4677.462091859437;4686.250199968006;4185.916281674357;4255.106427650182;4262.381954616579;4267.935980960288;4354.695171338008;4303.225419424502;4332.090261045184;4374.628156606692;4378.584034516716;4420.005498762769;4162.146759914211;4267.018585725301;4304;4370.235208838472;4372.803223854934;4219.831206751726;4243.936340954888;4245.129748401601;4295.7327588361195;4350.0647360817575;4232.4286221360335;4261.914761704779;4263.275243208662;4284.892877678052;4289.549597292271;4571.3600095986585;4588.541145885418;4597.494275629711;4624.583787459145;4630.930536041962;4811.230203167512;4814.3019262207135;4942.233953737176;4942.629302802268;4997.5002499749735;5017.222330538772;5025.924611130836;5038.244263360489;5061.544460998528;5068.72122033288;4617.746023968647;4622.745748983838;4626.861194164147;4629.120467111238;4665.903512674518;4855.684380515255;4984.127777638899;5114.488551144856;5120.385553733576;5120.719820044988;4739.431268247832;4823.638227132979;4825.396825396825;4848.515148485123;4866.586340161126;4944.887400334896;4948.307236986825;4953.182724850431;4969.751512424365;4992.850214493571;4783.1868582341085;4888.071266459432;4890.315355850184;4917.213245880714;4935.629827762932;4751.097291514601;4809.062232864628;4871.098846713369;4903.117438860968;4910;4194.937075943863;4209.894752631209;4211.305134652748;4215.852445164404;4253.766042867672;3705.5368078990127;3708.6847617952776;3713.7586056906216;3719.9770063232827;3737.6449237322413;4155.210510003089;4242.851500197478;4254.170436764801;4255.404243405926;4362.171187474433;5047.570956468668;5047.873803154877;5053.898922021539;5056.418511871108;5096.566791822663;4324.654027677778;4328.956710432918;4334.848280310174;4336.566343365638;4367.541408152162;4290.249206388869;4396.472423309224;4401.361802538614;4401.493828209733;4510.548945105529;4761.262004389325;4762.833300834385;4779.30700048498;4787.4494433140635;4823.2282834746275;5042.495750424928;5056.317397151338;5057.140286151437;5057.418396884405;5104.821331253388;4615.284630882219;4675.696079754805;4739.59713424349;4744.691595046311;4817.205161148371;4953.653244272867;4985.526374994515;4990.3762029746285;4994.775235114356;5042.773075211551;5060.367454068241;5068.797248110034;5071.036503064406;5073.125914385954;5076.923846142237;4714.764261786829;4726.243800991825;4820.204666230173;4853.150698627796;4861.295112208781;4878.609711223165;4922.581580565692;4922.630802689741;4924.1728967094;4971.304017437489;4788.11419887322;4809.062232864558;4812.687175333592;4820.831270905642;4848.296996935495;4687.2031754602485;4798.424189097331;4807.903841923212;4810.326554282473;4819.132556139928;4678.50875658051;4702.811887524461;4790.640701947298;4793.23308270675;4803.615710743202 05:05:06 INFO - PROCESS | 26204 | |1;ext.html;514.8326793792017;518.5514529931608;524.394324555139;540.9991515695965;556.7216391804095;27337.45325093497;35913;36260.63739362606;36329.81835090821;36376.2724745505;40434.79782601083;41075.79462102686;41115.38326925091;41136.58863411365;41156.58843411565;7022.789316320493;7180.8922866157045;7961.761147165595;8132.227438393373;8136.1050284468665;10246.53890574926;10485.108765754881;10496.895031049668;10512;10516.31643943145;10185.89814101857;10282.691519254435;10309.123724483428;10313.63902263421;10318.277720559527;7095.219525852152;7256.8911466328045;10235.897641023568;10315.277930544902;10317.638882639147;10304.536295866705;10590.629327973484;10598.258121931467;10600.257981941268;10600.628977985734;36744.265114697555;37537.62462375396;37562.06094847623;37580.43629345562;37620.62379376199;2883.884644614213;2904.7095290470993;2932.780041496896;3370.410178218802;3539.628339024391;26057.348566285993;26340.60489092665;26452.47095058107;26481.33796655099;26639;3437.845296961643;3440.82795860206;3461;3485.4771784232316;3575.284943011408;219258;220074;220620;221467.89266053727;221785;47013;48118.5188148121;48215.51784482181;61098;62249.68875155595;54440.18339724907;54452.72773636106;54578.72710636501;54618;54688;14252.643683907778;14436.639084022983;14479.78280325796;14506.202158881362;14531.273436328142;10934.835977460345;11047.060999814945;11059.778804424028;11202.551897924155;11234.10127189823;18696.252149914122;19084.522886927938;19088.71366929497;19099.90450047741;19111.80888191128;7093.361597456254;7240.565566066053;7320.121585409678;7363.079615048119;7427.62861856905;829.9792505187298;831.2767891934056;892.5358813416987;980.9460479673686;992.1963209800085;23275;25498.745012549636;27411.31471713223;27466.45067098647;27526;927.7263207353847;942.7313215733483;969.5290858725745;1050.144132531984;1067.9626213082504;12988.740225195632;13944.721105578035;15301.46444874424;15395.016802879376;15450.38198472071;248242;252129.04774046436;252317;253813;253903;45936.770316148206;46429.5357046432;46582.301265481045;46599.30101048487;46633.30050049252;1020.6886899495726;1072.7479042425025;1099.8790133085195;1183.4910988275124;1211.5275042733342;23573.29280121599;30675.386492269583;31657;32101.197470063435;32615.18462038373;42829.78585107055;43355.566444335156;43417;43443.56556434522;43475.130497390506;141560;143946;153590.23204883904;156221;156281;40139.397909030806;40167.397489038274;40197;40275.173858483395;40347;43048.139037219706;43123.137537249706;43317;43492;43517.56482435135;35647.46528802018;35939.28121437504;36296;37412;37485.43771843479;36235.27529449449;36974.63025369712;37066.629333707395;37219.62780372162;37285.440718389786;36119.27761444704;36301.27397452089;36545.63454365529;40086;40856.1828763429;30438.39123217479;33065.50401743928;33480.497792532646;33556.496652549744;35031;23969.16107936214;24010.39974000664;24226.51546969086;24333.02667893335;25700 05:05:06 INFO - PROCESS | 26204 | |2;jquery.html;299.5566561488998;304.7227023408698;306.96776838431964;309.7723173467502;312.7513626666801;12695.365231738422;13108;15118.092914425142;15561.144137072457;15652.765208521867;14872.107673539595;15036.774448383283;16244;16294.674106517892;16323;4880.780364883589;4979.053979743846;5047.596192304625;5056.620753443506;5061.848144555651;3405.8807941722043;3502.229509507917;5005.899882002358;5030.195168772997;5196.922046169291;5169.896602067956;5194.065068287707;5194.298769666103;5208.244804503344;5215.58275337972;5027.673201241908;5174.172132458807;5204.349456317941;5205.193195054772;5210.53105220532;5004.449510553836;5018.498150184989;5020.623453240985;5022.045811295842;5026.974865125688;17682.29270829178;18381.908090459463;18463.076846157637;19033.14350854201;19062.998385169634;1789.9015554144516;1869.9158537865828;1880.3700760245333;1923.6729755941524;1947.0751393088312;8764.912350876537;8825.470471771714;8917.866232006525;9074.682386116454;9451.905480945172;1718.218210714122;1732.9826701733073;1735.8698097642728;1757.6484703059311;1781.358710864088;53193.73403132959;54051.45948540504;54303;54342.72828635871;55744.0979131461;9226.907730922605;9244.8613270801;9353.672621458216;9362;9378.062193780705;11651.475683594259;11731.47208375625;11748.471318790675;11793;11795.469203885847;6908.205556361083;6909.689063992132;6952.339527744856;6988.860222795515;6989.860202795916;6842.452603791685;6852.862942741117;6916.930830691729;6924.169099708067;6935.098437203233;3845.8846234613006;3862.208247309295;3882.7087968402484;4005.839766409311;4013.3578627419474;1539.2226925402824;1582.0507695382908;1601.087380193302;1631.1436495839541;1664.7752553405378;823.8269963307772;837.4389159263308;878.4816957994686;885.7829831691148;968.9079537443931;15266.160361180242;15455.30451129702;15663.765043524356;15796.526104216891;15920.601984950237;729.7664747280925;770.1451388958252;785.3128512551517;794.3605397654943;814.698561532225;8243.752687419386;8394.706185283609;8518.659253629909;8527.403081784216;8579.2707619853;431199;431943;437296;438372;439277;70107.64946175237;70359.29640703528;70975;71205.64397178084;71251.2874871255;998.8601595776597;1008.626808081;1010.838265877456;1010.9443980581138;1034.9741256468799;13265.204087754766;13483.730325393633;13666.794998074838;13757.79363309531;13776.24230667323;30208.58834403355;33228.169295766835;34105.31789364248;34168.31663366769;34351.828240859635;39873.60126398815;40519.392209117475;41267;41523.37714934339;43898.78050609727;8108.2297181767635;8653.480791152551;8765.474071555473;8766.91233087661;8794.164554367326;9697.854532182164;9779.511024448606;9832.360896541702;9856.063673950963;9919.20646348276;10897.56409743633;13503.257320847448;13668.762683568126;13728.313584320544;13827.377768000666;12858.67853303675;12997.935010324887;13010.219386836441;13396.866031339561;13404.597862064154;13702.588922332347;13732.65668358299;14250.643733906321;14441.927790361402;14498.927505362406;8670.306375490072;8710.869336960077;8744.475331480131;8761.430507017023;8867.600957956778;13768.173909565458;13885.861141388861;13953.162810231419;13989.860101398855;14158.86729061652 05:05:06 INFO - PROCESS | 26204 | |3;mootools.html;1256.2525297448026;1647.1270226779807;1669.1654172913543;1712.3578658003241;1720.9655806883864;5998.310194327648;6799.932000679992;6966.442684585234;6983.057287266218;6999.930000700004;6934.583924964506;6976.093107895967;7025.6135912524915;7031.964840175805;7038.788836334906;1990.4725247809342;2019.61627290815;2033.8677985930942;2034.5727397246521;2037.0324096054403;2046.4474591860264;2076.4912596413824;2082.333653230967;2087.4572611121143;2089.101686274909;2024.4635171679517;2038.3884834549576;2067.9586408271825;2070;2071.5856828634332;2022.413500084981;2046.130394582304;2051.292304155064;2052.404802607242;2052.969205461919;2023.5447024419389;2037.1443993522607;2070.099506714569;2073.5956488484753;2073.7304150460345;7016.579005259649;7103.112110986127;7109.360157585842;7110.502264841463;7111.466640001969;4119.464469618961;4156.106437116035;4177.8537751178565;4216.2199993001395;4237.957620423787;2570.961435578468;2592.3907881647797;2622.069165446277;2695.3800625855965;2696.7707744841514;807.8142027333746;826.1078035721406;835.1231207232443;845.6279237135641;848.7284069097891;9515.000924902855;9525.333226674136;9533.142017218413;9537.618495260182;9548.37935534188;3735.9252814944093;3771.321162190777;3804.7526910751267;3818;3835.76985380878;8206.917930820615;8208.0560735515;8208.753737387888;8232.34141268697;8235.876461853077;4233.7883105844585;4250.829966801355;4251.957480425156;4271.957280427218;4274.465691788527;3174.3968645957193;3239.206394433379;3696.2053158570498;3895.4351619015083;3895.590962948906;3295.340931813647;3312.271300313927;3344.063662174595;3359.6136444308727;3360.4119279126057;1017.4149863828328;1026.10728666061;1029.891861354562;1037.8910214427528;1039.0440794469107;895.583553647557;979.2313034268066;981.3228872078244;982.1455333859445;1102.8511150994514;6424.1327420798525;6436.871262574722;6458.483321334282;6464.5798023128345;6470.676466176672;411.99588004120176;417;421.3700517726019;423.0629156418548;423.8558889977422;5112.463191364853;5127.307813445212;5165.070287348238;5168.431472538018;5170.069387510209;8191.549464779494;8281.337493000545;8380.8742868857;8610;8616.655333786704;8372.288355489729;8479.15208479147;8490.320774338039;8495.660173592987;8503.362247831314;6496.317886622026;6565.015247712786;6605.372489613479;6622.503312251601;6639.668016599151;6578.177727784027;6668.66656667155;6681.031250468558;6689.632070236184;6698.631575263213;7476.850462990818;7577.696892124473;7590.848183036419;7689.192634773268;7692.307692307719;7575.280348366897;7639.083310002835;7684.231576842271;7699.961500192688;7729.768106956801;5322.042032434044;5453.563714902719;5853.9121913172185;5926.703664816656;5932.940670593412;6444.258910225384;6619.669016549057;6622.966885165543;6643.40209381158;6669.899951500828;6089.238845144357;6242.563020588515;6329;6371.681415929278;6377.0753240778895;6143.96928015357;6187.84530386744;6235.314115447388;6288.276848162337;6324.430801227912;6188.319284878749;6205.751769929152;6277.2153480814895;6280.9685951569945;6288.371162883675;5781.046127388934;5815.156802263733;5817.243758311392;5819.243498345358;5829.970850145722;5814.30228372598;5876.911846322223;5919.4080591940465;5920.644761314335;5924.496417804535 05:05:06 INFO - PROCESS | 26204 | |4;prototype.html;288.26492444267114;290.45104752018676;294.88941646882415;298.8804478208715;302.3393884362669;5233.73831308434;5258.290130832336;5297.258383826267;5314.043472175012;5326.707031113297;5207.817726379578;5215.817446389377;5215.947840521593;5225.399079105904;5229.921551176735;4094.2425651254466;4104.322786740185;4111.979440102796;4115.938260926088;4116.073883376246;3907.374820028782;3993.2812093823245;4019.176068905882;4068.3694027425795;4068.4914385701786;4029.516458025041;4032.6169013943627;4050.250703619825;4055.2295063937904;4060.1473690525027;3835.252125835463;3917.0990672145567;4064.634182923536;4076.694247931402;4076.9592304076878;3477.426224672926;3570.839312230956;3575.3921833288146;3576.3741345264475;3577.6601222883783;5048.899022019576;5054.545090941833;5060.74696265189;5063.417706963673;5066.46802085783;4668.533146685339;4676.321933319649;4679.110968915895;4679.789409476582;4680.297955306697;5399.78400863965;5532.585056120767;5535;5537.473939975695;5544.1960915667005;3872.9806350968065;3888.319544079803;3891.571927088018;3895.104126050996;3909.0618251619408;5826.009578371687;5826.242588463472;5830.737616807254;5844.327902291248;5847.853803654943;4007.0984028593334;4015.19696060789;4025.3156963316305;4028.254772867029;4029.979850100731;3796.126890815073;4078.4290199372113;4080.6735461163034;4088.0801819590356;4094.6314831665295;4231.965546117949;4396.516383197845;4512.481064677604;4522.163399771053;4649.465311489154;5345.118055520873;5538.280023596906;5547.417521160301;5551.916721249185;5552.416996215339;1418.2625034981752;1428.407211007441;1430.4635761589404;1431.1270125223605;1431.6564024634222;946.7301818981557;948.3124734567383;958.8609651600618;963.4797209506788;969.8496733006396;4861.416630004352;4878.0975519529;4879.878003049881;4881;4887.340209071801;5764.596478246566;5765.88468230633;5772.163036359789;5778.306603207642;5780.306363236355;4864.124457597595;4871.610271178297;4875.390576177978;4877.829275975395;4878.146324393217;3002.6246719160104;3076.553899684533;3087.4442600332154;3124;3124.718775310233;5298.894022119536;5400.324959380077;5410.675359478444;5442.700651464128;5508.338999320107;5977.970110149508;5986.281646202397;5986.491148252448;5988.221531200916;5988.820335389945;5508.862278442991;5510.090835012338;5510.614257002052;5512.476314750093;5516.062269414209;5684.289463817023;5812.3025236971835;5822.7670893163795;5829.737661805144;5830.912536311874;5638.097904335286;5651.660900345993;5654.491095801398;5656.745446454837;5661.490465858093;5447.073997420369;5479;5496.862578435571;5497.092979658311;5500;3970.861019864291;4069.064115253449;4069.7965101745385;4074.6129117733767;4081.6530594898577;5808.30300363959;5813.505852002627;5815.110089221104;5816.47651711348;5816.621919575214;5575.135853942646;5613.382527922007;5613.971930140323;5617.073182924772;5620.74706638194;5590.189422533791;5609.158626206102;5619.8876022480135;5620.662760234399;5625.943740562706;5348.812791552277;5482.588805839658;5486.753096110605;5521.889562208814;5526.696031718133;5612.803551875665;5613.57898157648;5613.691246981455;5616.466435688603;5668.971655141698;5498.285222921155;5502.614816962774;5503.862403439786;5509.173623956278;5513.173024046425 05:05:06 INFO - PROCESS | 26204 | |5;yui.html;664.1930054983196;708.9220185779564;761.3908872901679;776.6233376812248;804.3846457460044;11653.883461165386;11710.297382157067;11745.647630571075;11765.352905590189;11805.173637845353;11521.36632485213;11583.942080289607;12070.275783452998;12087.637370878865;12107.455164517596;628.2272804450529;638.1162090504638;792.0495405513393;792.6472719639762;808.3290868579065;796.2475460689651;805.569020573993;810.2100452059254;812.155358427235;812.634314558451;826.7933016745814;837.4975014991018;842.1410161635129;842.465034702965;843.7300063979529;660.9438197753196;670.430134385773;825.4469505431315;838.1660248053226;840.0591337701752;620.280474649409;622.3993845938645;626.9467095296906;627.3600927054379;627.6202897247146;11291.717707057307;11464.541418343257;11465.197436179471;11476;11477.311361318265;10532.894671053267;11507.712307192303;11605.709857253552;11611.361375124365;11769.293842369485;9151.405158664666;9187.310951678584;9392.248620110375;9392.389494682824;9495.762605934908;3193.840307984615;3222.2266656002625;3259.2340799912004;3264.575605171336;3280.327532855759;38589.22821543582;38813.80593097045;38825;38862.80568597139;38996.41505377422;8670.219680228809;8694.652213911373;8767.281277807977;8871.512066836256;8993.055729148477;16429.83570164283;16454.341826326814;16649;16665.41671041532;16670.249408847405;6535.640539770358;6557.082008518812;6615.272320044791;6744.966275168593;6792.762253321209;3568.232829941523;3647.1429214134655;3650.945235821465;3656.798876061789;3661.7253705971625;2640.9603855942178;2663.880125394362;2684.758371746513;2691.7039125696156;2692.488427198826;468.75858932649714;474.93350930869707;478.77258302306126;490.5682998960892;494.5969035236343;514.6680391147763;536.6404508978993;552.9411177594941;567.7643777832236;573.931128264611;7163.856722865514;7323.084614423197;7336.669849856769;7389.334959853639;7463.962680186564;431.7646882449073;541.3125330829903;555.6527170518426;563.2874413866463;570.6775671745451;3386.1873150444208;3460.3944309745693;3574.12433953683;3587.408077667208;3650.543682039745;49501.257481137814;50646;50707;50710.239346409835;50780;42781.57218427838;43237.78381108074;43457.56542434599;43772;44087;41037;41170.58829411668;41301.380479292835;41630.58369416267;41631.375529367084;7150.678219480032;7168.928310717035;8009.1487470412885;8105.311048560939;8290.668373265244;30347.848260758554;30932.381352373275;31383;31456.370872581963;32369.676303237607;41548;41691.58308416877;42080.78959605182;42145.578544214164;42153.78923105365;9546.618135274512;9549.52252387364;9558.61765529371;9699.272554558294;9876.35803672759;10776.892231077902;10896.61861834832;10921.071708904514;10949;11451.370174640475;9827;10164.288499805238;10281.691549253534;10284.382937023802;10290.742731431774;10352.482375881327;10382.117520010883;10404.68785936423;10446.488669508517;10476.52855621514;8963.820723585623;9100.135487128713;9897.406155630397;10104.393736375841;10282.845757313497;7288.927110728825;8247.876281855897;8493.150684931457;8512.91487085146;8794.60424280896;7410.888836667346;8579.403262800226;8856.3800533962;8987.640494380414;9236.907630923604 05:05:06 INFO - PROCESS | 26204 | __end_tp_report 05:05:06 INFO - PROCESS | 26204 | __start_cc_report 05:05:06 INFO - PROCESS | 26204 | _x_x_mozilla_cycle_collect,1142 05:05:06 INFO - PROCESS | 26204 | __end_cc_report 05:05:06 INFO - PROCESS | 26204 | __startTimestamp1450703106235__endTimestamp 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | ------- Summary: start ------- 05:05:06 INFO - PROCESS | 26204 | Number of tests: 6 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#0] dojo.html Cycles:165 Average:4595.82 Median:4739.43 stddev:478.07 (10.1%) stddev-sans-first:452.62 05:05:06 INFO - PROCESS | 26204 | Values: 2579.9 2630.1 2634.4 2646.2 2666.5 4377.3 4501.0 4505.5 4545.3 4558.7 4569.2 4657.5 4671.2 4677.5 4686.3 4185.9 4255.1 4262.4 4267.9 4354.7 4303.2 4332.1 4374.6 4378.6 4420.0 4162.1 4267.0 4304.0 4370.2 4372.8 4219.8 4243.9 4245.1 4295.7 4350.1 4232.4 4261.9 4263.3 4284.9 4289.5 4571.4 4588.5 4597.5 4624.6 4630.9 4811.2 4814.3 4942.2 4942.6 4997.5 5017.2 5025.9 5038.2 5061.5 5068.7 4617.7 4622.7 4626.9 4629.1 4665.9 4855.7 4984.1 5114.5 5120.4 5120.7 4739.4 4823.6 4825.4 4848.5 4866.6 4944.9 4948.3 4953.2 4969.8 4992.9 4783.2 4888.1 4890.3 4917.2 4935.6 4751.1 4809.1 4871.1 4903.1 4910.0 4194.9 4209.9 4211.3 4215.9 4253.8 3705.5 3708.7 3713.8 3720.0 3737.6 4155.2 4242.9 4254.2 4255.4 4362.2 5047.6 5047.9 5053.9 5056.4 5096.6 4324.7 4329.0 4334.8 4336.6 4367.5 4290.2 4396.5 4401.4 4401.5 4510.5 4761.3 4762.8 4779.3 4787.4 4823.2 5042.5 5056.3 5057.1 5057.4 5104.8 4615.3 4675.7 4739.6 4744.7 4817.2 4953.7 4985.5 4990.4 4994.8 5042.8 5060.4 5068.8 5071.0 5073.1 5076.9 4714.8 4726.2 4820.2 4853.2 4861.3 4878.6 4922.6 4922.6 4924.2 4971.3 4788.1 4809.1 4812.7 4820.8 4848.3 4687.2 4798.4 4807.9 4810.3 4819.1 4678.5 4702.8 4790.6 4793.2 4803.6 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#1] ext.html Cycles:180 Average:38707.25 Median:3450.91 stddev:54978.57 (1593.2%) stddev-sans-first:55058.00 05:05:06 INFO - PROCESS | 26204 | Values: 514.8 518.6 524.4 541.0 556.7 27337.5 35913.0 36260.6 36329.8 36376.3 40434.8 41075.8 41115.4 41136.6 41156.6 7022.8 7180.9 7961.8 8132.2 8136.1 10246.5 10485.1 10496.9 10512.0 10516.3 10185.9 10282.7 10309.1 10313.6 10318.3 7095.2 7256.9 10235.9 10315.3 10317.6 10304.5 10590.6 10598.3 10600.3 10600.6 36744.3 37537.6 37562.1 37580.4 37620.6 2883.9 2904.7 2932.8 3370.4 3539.6 26057.3 26340.6 26452.5 26481.3 26639.0 3437.8 3440.8 3461.0 3485.5 3575.3 219258.0 220074.0 220620.0 221467.9 221785.0 47013.0 48118.5 48215.5 61098.0 62249.7 54440.2 54452.7 54578.7 54618.0 54688.0 14252.6 14436.6 14479.8 14506.2 14531.3 10934.8 11047.1 11059.8 11202.6 11234.1 18696.3 19084.5 19088.7 19099.9 19111.8 7093.4 7240.6 7320.1 7363.1 7427.6 830.0 831.3 892.5 980.9 992.2 23275.0 25498.7 27411.3 27466.5 27526.0 927.7 942.7 969.5 1050.1 1068.0 12988.7 13944.7 15301.5 15395.0 15450.4 248242.0 252129.0 252317.0 253813.0 253903.0 45936.8 46429.5 46582.3 46599.3 46633.3 1020.7 1072.7 1099.9 1183.5 1211.5 23573.3 30675.4 31657.0 32101.2 32615.2 42829.8 43355.6 43417.0 43443.6 43475.1 141560.0 143946.0 153590.2 156221.0 156281.0 40139.4 40167.4 40197.0 40275.2 40347.0 43048.1 43123.1 43317.0 43492.0 43517.6 35647.5 35939.3 36296.0 37412.0 37485.4 36235.3 36974.6 37066.6 37219.6 37285.4 36119.3 36301.3 36545.6 40086.0 40856.2 30438.4 33065.5 33480.5 33556.5 35031.0 23969.2 24010.4 24226.5 24333.0 25700.0 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#2] jquery.html Cycles:180 Average:24558.17 Median:431571.00 stddev:71239.91 (16.5%) stddev-sans-first:71416.47 05:05:06 INFO - PROCESS | 26204 | Values: 299.6 304.7 307.0 309.8 312.8 12695.4 13108.0 15118.1 15561.1 15652.8 14872.1 15036.8 16244.0 16294.7 16323.0 4880.8 4979.1 5047.6 5056.6 5061.8 3405.9 3502.2 5005.9 5030.2 5196.9 5169.9 5194.1 5194.3 5208.2 5215.6 5027.7 5174.2 5204.3 5205.2 5210.5 5004.4 5018.5 5020.6 5022.0 5027.0 17682.3 18381.9 18463.1 19033.1 19063.0 1789.9 1869.9 1880.4 1923.7 1947.1 8764.9 8825.5 8917.9 9074.7 9451.9 1718.2 1733.0 1735.9 1757.6 1781.4 53193.7 54051.5 54303.0 54342.7 55744.1 9226.9 9244.9 9353.7 9362.0 9378.1 11651.5 11731.5 11748.5 11793.0 11795.5 6908.2 6909.7 6952.3 6988.9 6989.9 6842.5 6852.9 6916.9 6924.2 6935.1 3845.9 3862.2 3882.7 4005.8 4013.4 1539.2 1582.1 1601.1 1631.1 1664.8 823.8 837.4 878.5 885.8 968.9 15266.2 15455.3 15663.8 15796.5 15920.6 729.8 770.1 785.3 794.4 814.7 8243.8 8394.7 8518.7 8527.4 8579.3 431199.0 431943.0 437296.0 438372.0 439277.0 70107.6 70359.3 70975.0 71205.6 71251.3 998.9 1008.6 1010.8 1010.9 1035.0 13265.2 13483.7 13666.8 13757.8 13776.2 30208.6 33228.2 34105.3 34168.3 34351.8 39873.6 40519.4 41267.0 41523.4 43898.8 8108.2 8653.5 8765.5 8766.9 8794.2 9697.9 9779.5 9832.4 9856.1 9919.2 10897.6 13503.3 13668.8 13728.3 13827.4 12858.7 12997.9 13010.2 13396.9 13404.6 13702.6 13732.7 14250.6 14441.9 14498.9 8670.3 8710.9 8744.5 8761.4 8867.6 13768.2 13885.9 13953.2 13989.9 14158.9 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#3] mootools.html Cycles:180 Average:4868.62 Median:5965.63 stddev:2560.29 (42.9%) stddev-sans-first:2553.08 05:05:06 INFO - PROCESS | 26204 | Values: 1256.3 1647.1 1669.2 1712.4 1721.0 5998.3 6799.9 6966.4 6983.1 6999.9 6934.6 6976.1 7025.6 7032.0 7038.8 1990.5 2019.6 2033.9 2034.6 2037.0 2046.4 2076.5 2082.3 2087.5 2089.1 2024.5 2038.4 2068.0 2070.0 2071.6 2022.4 2046.1 2051.3 2052.4 2053.0 2023.5 2037.1 2070.1 2073.6 2073.7 7016.6 7103.1 7109.4 7110.5 7111.5 4119.5 4156.1 4177.9 4216.2 4238.0 2571.0 2592.4 2622.1 2695.4 2696.8 807.8 826.1 835.1 845.6 848.7 9515.0 9525.3 9533.1 9537.6 9548.4 3735.9 3771.3 3804.8 3818.0 3835.8 8206.9 8208.1 8208.8 8232.3 8235.9 4233.8 4250.8 4252.0 4272.0 4274.5 3174.4 3239.2 3696.2 3895.4 3895.6 3295.3 3312.3 3344.1 3359.6 3360.4 1017.4 1026.1 1029.9 1037.9 1039.0 895.6 979.2 981.3 982.1 1102.9 6424.1 6436.9 6458.5 6464.6 6470.7 412.0 417.0 421.4 423.1 423.9 5112.5 5127.3 5165.1 5168.4 5170.1 8191.5 8281.3 8380.9 8610.0 8616.7 8372.3 8479.2 8490.3 8495.7 8503.4 6496.3 6565.0 6605.4 6622.5 6639.7 6578.2 6668.7 6681.0 6689.6 6698.6 7476.9 7577.7 7590.8 7689.2 7692.3 7575.3 7639.1 7684.2 7700.0 7729.8 5322.0 5453.6 5853.9 5926.7 5932.9 6444.3 6619.7 6623.0 6643.4 6669.9 6089.2 6242.6 6329.0 6371.7 6377.1 6144.0 6187.8 6235.3 6288.3 6324.4 6188.3 6205.8 6277.2 6281.0 6288.4 5781.0 5815.2 5817.2 5819.2 5830.0 5814.3 5876.9 5919.4 5920.6 5924.5 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#4] prototype.html Cycles:180 Average:4611.97 Median:5246.01 stddev:1365.21 (26.0%) stddev-sans-first:1329.91 05:05:06 INFO - PROCESS | 26204 | Values: 288.3 290.5 294.9 298.9 302.3 5233.7 5258.3 5297.3 5314.0 5326.7 5207.8 5215.8 5215.9 5225.4 5229.9 4094.2 4104.3 4112.0 4115.9 4116.1 3907.4 3993.3 4019.2 4068.4 4068.5 4029.5 4032.6 4050.3 4055.2 4060.1 3835.3 3917.1 4064.6 4076.7 4077.0 3477.4 3570.8 3575.4 3576.4 3577.7 5048.9 5054.5 5060.7 5063.4 5066.5 4668.5 4676.3 4679.1 4679.8 4680.3 5399.8 5532.6 5535.0 5537.5 5544.2 3873.0 3888.3 3891.6 3895.1 3909.1 5826.0 5826.2 5830.7 5844.3 5847.9 4007.1 4015.2 4025.3 4028.3 4030.0 3796.1 4078.4 4080.7 4088.1 4094.6 4232.0 4396.5 4512.5 4522.2 4649.5 5345.1 5538.3 5547.4 5551.9 5552.4 1418.3 1428.4 1430.5 1431.1 1431.7 946.7 948.3 958.9 963.5 969.8 4861.4 4878.1 4879.9 4881.0 4887.3 5764.6 5765.9 5772.2 5778.3 5780.3 4864.1 4871.6 4875.4 4877.8 4878.1 3002.6 3076.6 3087.4 3124.0 3124.7 5298.9 5400.3 5410.7 5442.7 5508.3 5978.0 5986.3 5986.5 5988.2 5988.8 5508.9 5510.1 5510.6 5512.5 5516.1 5684.3 5812.3 5822.8 5829.7 5830.9 5638.1 5651.7 5654.5 5656.7 5661.5 5447.1 5479.0 5496.9 5497.1 5500.0 3970.9 4069.1 4069.8 4074.6 4081.7 5808.3 5813.5 5815.1 5816.5 5816.6 5575.1 5613.4 5614.0 5617.1 5620.7 5590.2 5609.2 5619.9 5620.7 5625.9 5348.8 5482.6 5486.8 5521.9 5526.7 5612.8 5613.6 5613.7 5616.5 5669.0 5498.3 5502.6 5503.9 5509.2 5513.2 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - PROCESS | 26204 | [#5] yui.html Cycles:180 Average:12143.02 Median:492.58 stddev:13914.34 (2824.8%) stddev-sans-first:13926.68 05:05:06 INFO - PROCESS | 26204 | Values: 664.2 708.9 761.4 776.6 804.4 11653.9 11710.3 11745.6 11765.4 11805.2 11521.4 11583.9 12070.3 12087.6 12107.5 628.2 638.1 792.0 792.6 808.3 796.2 805.6 810.2 812.2 812.6 826.8 837.5 842.1 842.5 843.7 660.9 670.4 825.4 838.2 840.1 620.3 622.4 626.9 627.4 627.6 11291.7 11464.5 11465.2 11476.0 11477.3 10532.9 11507.7 11605.7 11611.4 11769.3 9151.4 9187.3 9392.2 9392.4 9495.8 3193.8 3222.2 3259.2 3264.6 3280.3 38589.2 38813.8 38825.0 38862.8 38996.4 8670.2 8694.7 8767.3 8871.5 8993.1 16429.8 16454.3 16649.0 16665.4 16670.2 6535.6 6557.1 6615.3 6745.0 6792.8 3568.2 3647.1 3650.9 3656.8 3661.7 2641.0 2663.9 2684.8 2691.7 2692.5 468.8 474.9 478.8 490.6 494.6 514.7 536.6 552.9 567.8 573.9 7163.9 7323.1 7336.7 7389.3 7464.0 431.8 541.3 555.7 563.3 570.7 3386.2 3460.4 3574.1 3587.4 3650.5 49501.3 50646.0 50707.0 50710.2 50780.0 42781.6 43237.8 43457.6 43772.0 44087.0 41037.0 41170.6 41301.4 41630.6 41631.4 7150.7 7168.9 8009.1 8105.3 8290.7 30347.8 30932.4 31383.0 31456.4 32369.7 41548.0 41691.6 42080.8 42145.6 42153.8 9546.6 9549.5 9558.6 9699.3 9876.4 10776.9 10896.6 10921.1 10949.0 11451.4 9827.0 10164.3 10281.7 10284.4 10290.7 10352.5 10382.1 10404.7 10446.5 10476.5 8963.8 9100.1 9897.4 10104.4 10282.8 7288.9 8247.9 8493.2 8512.9 8794.6 7410.9 8579.4 8856.4 8987.6 9236.9 05:05:06 INFO - PROCESS | 26204 | -------- Summary: end -------- 05:05:06 INFO - PROCESS | 26204 | 05:05:06 INFO - TEST-INFO | 26204: exit 0 05:05:06 INFO - TEST-OK | dromaeo_css | took 1117321ms 05:05:06 INFO - TEST-START | kraken 05:05:06 INFO - operating with platform_type : linux_ 05:05:06 INFO - Initialising browser for kraken test... 05:05:06 INFO - TEST-INFO | started process 26395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNcCEB/profile http://localhost:58565/getInfo.html) 05:05:11 INFO - PROCESS | 26395 | __metrics Screen width/height:1600/1200 05:05:11 INFO - PROCESS | 26395 | colorDepth:24 05:05:11 INFO - PROCESS | 26395 | Browser inner width/height: 1024/697 05:05:11 INFO - PROCESS | 26395 | __metrics 05:05:11 INFO - PROCESS | 26395 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:05:11 INFO - PROCESS | 26395 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:12 INFO - TEST-INFO | 26395: exit 0 05:05:12 INFO - Browser initialized. 05:05:12 INFO - Running cycle 1/1 for kraken test... 05:05:12 INFO - TEST-INFO | started process 26477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNcCEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:24 INFO - PROCESS | 26477 | RSS: Main: 150224896 05:05:24 INFO - PROCESS | 26477 | 05:05:26 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58565/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:27 INFO - PROCESS | 26477 | RSS: Main: 184414208 05:05:27 INFO - PROCESS | 26477 | 05:05:30 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58565/tests/kraken/driver.html?testName=audio-dft) 05:05:30 INFO - PROCESS | 26477 | RSS: Main: 175120384 05:05:30 INFO - PROCESS | 26477 | 05:05:33 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58565/tests/kraken/driver.html?testName=audio-fft) 05:05:34 INFO - PROCESS | 26477 | RSS: Main: 163565568 05:05:34 INFO - PROCESS | 26477 | 05:05:36 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58565/tests/kraken/driver.html?testName=audio-oscillator) 05:05:36 INFO - PROCESS | 26477 | RSS: Main: 162361344 05:05:36 INFO - PROCESS | 26477 | 05:05:39 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:39 INFO - PROCESS | 26477 | RSS: Main: 164315136 05:05:39 INFO - PROCESS | 26477 | 05:05:42 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58565/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:43 INFO - PROCESS | 26477 | RSS: Main: 165605376 05:05:43 INFO - PROCESS | 26477 | 05:05:46 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58565/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:47 INFO - PROCESS | 26477 | RSS: Main: 166924288 05:05:47 INFO - PROCESS | 26477 | 05:05:50 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58565/tests/kraken/driver.html?testName=json-parse-financial) 05:05:50 INFO - PROCESS | 26477 | RSS: Main: 166055936 05:05:50 INFO - PROCESS | 26477 | 05:05:52 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:53 INFO - PROCESS | 26477 | RSS: Main: 173801472 05:05:53 INFO - PROCESS | 26477 | 05:05:54 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:55 INFO - PROCESS | 26477 | RSS: Main: 173633536 05:05:55 INFO - PROCESS | 26477 | 05:05:57 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:58 INFO - PROCESS | 26477 | RSS: Main: 186400768 05:05:58 INFO - PROCESS | 26477 | 05:06:00 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:01 INFO - PROCESS | 26477 | RSS: Main: 192602112 05:06:01 INFO - PROCESS | 26477 | 05:06:03 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:04 INFO - PROCESS | 26477 | RSS: Main: 190251008 05:06:04 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | Cycle 1(1): loaded http://localhost:58565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58565/tests/kraken/driver.html?testName=ai-astar) 05:06:06 INFO - PROCESS | 26477 | RSS: Main: 248512512 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | __start_tp_report 05:06:06 INFO - PROCESS | 26477 | _x_x_mozilla_page_load 05:06:06 INFO - PROCESS | 26477 | _x_x_mozilla_page_load_details 05:06:06 INFO - PROCESS | 26477 | |i|pagename|runs| 05:06:06 INFO - PROCESS | 26477 | |0;ai-astar;110;113;106;112;112;112;102;112;112;105 05:06:06 INFO - PROCESS | 26477 | |1;audio-beat-detection;156;129;156;162;135;156;149;132;169;133 05:06:06 INFO - PROCESS | 26477 | |2;audio-dft;161;162;161;162;162;162;162;162;163;162 05:06:06 INFO - PROCESS | 26477 | |3;audio-fft;72;72;78;91;72;73;72;107;98;77 05:06:06 INFO - PROCESS | 26477 | |4;audio-oscillator;96;95;134;95;96;95;133;95;93;130 05:06:06 INFO - PROCESS | 26477 | |5;imaging-gaussian-blur;110;109;109;110;109;109;110;110;110;110 05:06:06 INFO - PROCESS | 26477 | |6;imaging-darkroom;145;147;146;146;147;147;147;146;146;147 05:06:06 INFO - PROCESS | 26477 | |7;imaging-desaturate;95;96;96;96;95;110;96;97;95;95 05:06:06 INFO - PROCESS | 26477 | |8;json-parse-financial;69;69;70;69;69;71;69;79;66;67 05:06:06 INFO - PROCESS | 26477 | |9;json-stringify-tinderbox;69;69;68;68;68;69;69;68;75;69 05:06:06 INFO - PROCESS | 26477 | |10;stanford-crypto-aes;84;82;84;83;81;83;81;91;91;83 05:06:06 INFO - PROCESS | 26477 | |11;stanford-crypto-ccm;120;119;118;116;118;118;119;120;126;127 05:06:06 INFO - PROCESS | 26477 | |12;stanford-crypto-pbkdf2;135;146;145;149;151;157;145;158;148;135 05:06:06 INFO - PROCESS | 26477 | |13;stanford-crypto-sha256-iterative;71;71;70;68;71;70;71;67;71;69 05:06:06 INFO - PROCESS | 26477 | __end_tp_report 05:06:06 INFO - PROCESS | 26477 | __start_cc_report 05:06:06 INFO - PROCESS | 26477 | _x_x_mozilla_cycle_collect,984 05:06:06 INFO - PROCESS | 26477 | __end_cc_report 05:06:06 INFO - PROCESS | 26477 | __startTimestamp1450703166483__endTimestamp 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | ------- Summary: start ------- 05:06:06 INFO - PROCESS | 26477 | Number of tests: 14 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:3.84 (3.4%) stddev-sans-first:4.07 05:06:06 INFO - PROCESS | 26477 | Values: 110.0 113.0 106.0 112.0 112.0 112.0 102.0 112.0 112.0 105.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.00 stddev:14.30 (9.2%) stddev-sans-first:14.85 05:06:06 INFO - PROCESS | 26477 | Values: 156.0 129.0 156.0 162.0 135.0 156.0 149.0 132.0 169.0 133.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:06:06 INFO - PROCESS | 26477 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 162.0 162.0 163.0 162.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:12.81 (17.1%) stddev-sans-first:13.15 05:06:06 INFO - PROCESS | 26477 | Values: 72.0 72.0 78.0 91.0 72.0 73.0 72.0 107.0 98.0 77.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.08 (19.0%) stddev-sans-first:18.79 05:06:06 INFO - PROCESS | 26477 | Values: 96.0 95.0 134.0 95.0 96.0 95.0 133.0 95.0 93.0 130.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:06:06 INFO - PROCESS | 26477 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:06:06 INFO - PROCESS | 26477 | Values: 145.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:4.58 (4.8%) stddev-sans-first:4.80 05:06:06 INFO - PROCESS | 26477 | Values: 95.0 96.0 96.0 96.0 95.0 110.0 96.0 97.0 95.0 95.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:69.00 stddev:3.52 (5.1%) stddev-sans-first:3.72 05:06:06 INFO - PROCESS | 26477 | Values: 69.0 69.0 70.0 69.0 69.0 71.0 69.0 79.0 66.0 67.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:2.10 (3.0%) stddev-sans-first:2.22 05:06:06 INFO - PROCESS | 26477 | Values: 69.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 75.0 69.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.68 (4.4%) stddev-sans-first:3.91 05:06:06 INFO - PROCESS | 26477 | Values: 84.0 82.0 84.0 83.0 81.0 83.0 81.0 91.0 91.0 83.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:119.50 stddev:3.57 (3.0%) stddev-sans-first:3.79 05:06:06 INFO - PROCESS | 26477 | Values: 120.0 119.0 118.0 116.0 118.0 118.0 119.0 120.0 126.0 127.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:148.50 stddev:7.74 (5.2%) stddev-sans-first:6.91 05:06:06 INFO - PROCESS | 26477 | Values: 135.0 146.0 145.0 149.0 151.0 157.0 145.0 158.0 148.0 135.0 05:06:06 INFO - PROCESS | 26477 | 05:06:06 INFO - PROCESS | 26477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:71.00 stddev:1.45 (2.0%) stddev-sans-first:1.48 05:06:06 INFO - PROCESS | 26477 | Values: 71.0 71.0 70.0 68.0 71.0 70.0 71.0 67.0 71.0 69.0 05:06:06 INFO - PROCESS | 26477 | -------- Summary: end -------- 05:06:06 INFO - PROCESS | 26477 | 05:06:07 INFO - TEST-INFO | 26477: exit 0 05:06:07 INFO - TEST-OK | kraken | took 60505ms 05:06:07 INFO - TEST-START | v8_7 05:06:07 INFO - operating with platform_type : linux_ 05:06:07 INFO - Initialising browser for v8_7 test... 05:06:07 INFO - TEST-INFO | started process 26724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m32jM/profile http://localhost:58565/getInfo.html) 05:06:11 INFO - PROCESS | 26724 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:06:11 INFO - PROCESS | 26724 | __metrics Screen width/height:1600/1200 05:06:11 INFO - PROCESS | 26724 | colorDepth:24 05:06:11 INFO - PROCESS | 26724 | Browser inner width/height: 1024/697 05:06:11 INFO - PROCESS | 26724 | __metrics 05:06:11 INFO - PROCESS | 26724 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:06:12 INFO - PROCESS | 26724 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:12 ERROR - PROCESS | 26724 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:06:13 INFO - TEST-INFO | 26724: exit 0 05:06:13 INFO - Browser initialized. 05:06:13 INFO - Running cycle 1/1 for v8_7 test... 05:06:13 INFO - TEST-INFO | started process 26806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m32jM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:24 INFO - PROCESS | 26806 | RSS: Main: 149741568 05:06:24 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | Cycle 1(1): loaded http://localhost:58565/tests/v8_7/run.html (next: http://localhost:58565/tests/v8_7/run.html) 05:06:46 INFO - PROCESS | 26806 | RSS: Main: 449802240 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | __start_tp_report 05:06:46 INFO - PROCESS | 26806 | _x_x_mozilla_page_load 05:06:46 INFO - PROCESS | 26806 | _x_x_mozilla_page_load_details 05:06:46 INFO - PROCESS | 26806 | |i|pagename|runs| 05:06:46 INFO - PROCESS | 26806 | |0;Richards;168.20857863751053 05:06:46 INFO - PROCESS | 26806 | |1;DeltaBlue;186.1850679575498 05:06:46 INFO - PROCESS | 26806 | |2;Encrypt;279.87685418415896 05:06:46 INFO - PROCESS | 26806 | |3;Decrypt;5148.717948717948 05:06:46 INFO - PROCESS | 26806 | |4;RayTrace;1992.03187250996 05:06:46 INFO - PROCESS | 26806 | |5;Earley;786.7820613690008 05:06:46 INFO - PROCESS | 26806 | |6;Boyer;11917.64705882353 05:06:46 INFO - PROCESS | 26806 | |7;RegExp;27351.35135135135 05:06:46 INFO - PROCESS | 26806 | |8;Splay;618.8118811881188 05:06:46 INFO - PROCESS | 26806 | |9;NavierStokes;4826.923076923077 05:06:46 INFO - PROCESS | 26806 | __end_tp_report 05:06:46 INFO - PROCESS | 26806 | __startTimestamp1450703206601__endTimestamp 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | ------- Summary: start ------- 05:06:46 INFO - PROCESS | 26806 | Number of tests: 10 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 168.2 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 186.2 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 279.9 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 5148.7 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 1992.0 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 786.8 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#6] Boyer Cycles:1 Average:11917.65 Median:11917.65 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 11917.6 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#7] RegExp Cycles:1 Average:27351.35 Median:27351.35 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 27351.4 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#8] Splay Cycles:1 Average:618.81 Median:618.81 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 618.8 05:06:46 INFO - PROCESS | 26806 | 05:06:46 INFO - PROCESS | 26806 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:06:46 INFO - PROCESS | 26806 | Values: 4826.9 05:06:46 INFO - PROCESS | 26806 | -------- Summary: end -------- 05:06:46 INFO - PROCESS | 26806 | 05:06:47 INFO - TEST-INFO | 26806: exit 0 05:06:47 INFO - TEST-OK | v8_7 | took 40053ms 05:06:47 INFO - SUITE-END | took 1217s 05:06:47 INFO - Completed test suite (00:20:18) 05:06:47 INFO - Working with test: dromaeo_css 05:06:47 INFO - Generating results file: dromaeo_css 05:06:47 INFO - Working with test: kraken 05:06:47 INFO - Generating results file: kraken 05:06:47 INFO - javascript benchmark 05:06:47 INFO - Working with test: v8_7 05:06:47 INFO - Generating results file: v8_7 05:06:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:06:47 INFO - process_Request line: dromaeo_css 6228.45 graph.html#tests=[[72,132,35]] 05:06:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:47 INFO - process_Request line: kraken 1519.90 graph.html#tests=[[232,132,35]] 05:06:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:47 INFO - process_Request line: v8_7 19753.08 graph.html#tests=[[230,132,35]] 05:06:47 INFO - RETURN: dromaeo_css: 6228.45 05:06:47 INFO - RETURN: kraken: 1519.90 05:06:47 INFO - RETURN: v8_7: 19753.08 05:06:47 INFO - javascript benchmark 05:06:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2579.909703160389, 2630.1189101650934, 2634.4335967766924, 2646.192911162095, 2666.506696261192, 4377.277749171383, 4500.954990450098, 4505.459344878615, 4545.318202269657, 4558.680892337529, 4569.177548041352, 4657.51096134906, 4671.159191345557, 4677.462091859437, 4686.250199968006, 4185.916281674357, 4255.106427650182, 4262.381954616579, 4267.935980960288, 4354.695171338008, 4303.225419424502, 4332.090261045184, 4374.628156606692, 4378.584034516716, 4420.005498762769, 4162.146759914211, 4267.018585725301, 4304.0, 4370.235208838472, 4372.803223854934, 4219.831206751726, 4243.936340954888, 4245.129748401601, 4295.7327588361195, 4350.0647360817575, 4232.4286221360335, 4261.914761704779, 4263.275243208662, 4284.892877678052, 4289.549597292271, 4571.3600095986585, 4588.541145885418, 4597.494275629711, 4624.583787459145, 4630.930536041962, 4811.230203167512, 4814.3019262207135, 4942.233953737176, 4942.629302802268, 4997.5002499749735, 5017.222330538772, 5025.924611130836, 5038.244263360489, 5061.544460998528, 5068.72122033288, 4617.746023968647, 4622.745748983838, 4626.861194164147, 4629.120467111238, 4665.903512674518, 4855.684380515255, 4984.127777638899, 5114.488551144856, 5120.385553733576, 5120.719820044988, 4739.431268247832, 4823.638227132979, 4825.396825396825, 4848.515148485123, 4866.586340161126, 4944.887400334896, 4948.307236986825, 4953.182724850431, 4969.751512424365, 4992.850214493571, 4783.1868582341085, 4888.071266459432, 4890.315355850184, 4917.213245880714, 4935.629827762932, 4751.097291514601, 4809.062232864628, 4871.098846713369, 4903.117438860968, 4910.0, 4194.937075943863, 4209.894752631209, 4211.305134652748, 4215.852445164404, 4253.766042867672, 3705.5368078990127, 3708.6847617952776, 3713.7586056906216, 3719.9770063232827, 3737.6449237322413, 4155.210510003089, 4242.851500197478, 4254.170436764801, 4255.404243405926, 4362.171187474433, 5047.570956468668, 5047.873803154877, 5053.898922021539, 5056.418511871108, 5096.566791822663, 4324.654027677778, 4328.956710432918, 4334.848280310174, 4336.566343365638, 4367.541408152162, 4290.249206388869, 4396.472423309224, 4401.361802538614, 4401.493828209733, 4510.548945105529, 4761.262004389325, 4762.833300834385, 4779.30700048498, 4787.4494433140635, 4823.2282834746275, 5042.495750424928, 5056.317397151338, 5057.140286151437, 5057.418396884405, 5104.821331253388, 4615.284630882219, 4675.696079754805, 4739.59713424349, 4744.691595046311, 4817.205161148371, 4953.653244272867, 4985.526374994515, 4990.3762029746285, 4994.775235114356, 5042.773075211551, 5060.367454068241, 5068.797248110034, 5071.036503064406, 5073.125914385954, 5076.923846142237, 4714.764261786829, 4726.243800991825, 4820.204666230173, 4853.150698627796, 4861.295112208781, 4878.609711223165, 4922.581580565692, 4922.630802689741, 4924.1728967094, 4971.304017437489, 4788.11419887322, 4809.062232864558, 4812.687175333592, 4820.831270905642, 4848.296996935495, 4687.2031754602485, 4798.424189097331, 4807.903841923212, 4810.326554282473, 4819.132556139928, 4678.50875658051, 4702.811887524461, 4790.640701947298, 4793.23308270675, 4803.615710743202], "unit": "score", "name": "dojo.html", "value": 4565.863624898219}, {"lowerIsBetter": false, "replicates": [514.8326793792017, 518.5514529931608, 524.394324555139, 540.9991515695965, 556.7216391804095, 27337.45325093497, 35913.0, 36260.63739362606, 36329.81835090821, 36376.2724745505, 40434.79782601083, 41075.79462102686, 41115.38326925091, 41136.58863411365, 41156.58843411565, 7022.789316320493, 7180.8922866157045, 7961.761147165595, 8132.227438393373, 8136.1050284468665, 10246.53890574926, 10485.108765754881, 10496.895031049668, 10512.0, 10516.31643943145, 10185.89814101857, 10282.691519254435, 10309.123724483428, 10313.63902263421, 10318.277720559527, 7095.219525852152, 7256.8911466328045, 10235.897641023568, 10315.277930544902, 10317.638882639147, 10304.536295866705, 10590.629327973484, 10598.258121931467, 10600.257981941268, 10600.628977985734, 36744.265114697555, 37537.62462375396, 37562.06094847623, 37580.43629345562, 37620.62379376199, 2883.884644614213, 2904.7095290470993, 2932.780041496896, 3370.410178218802, 3539.628339024391, 26057.348566285993, 26340.60489092665, 26452.47095058107, 26481.33796655099, 26639.0, 3437.845296961643, 3440.82795860206, 3461.0, 3485.4771784232316, 3575.284943011408, 219258.0, 220074.0, 220620.0, 221467.89266053727, 221785.0, 47013.0, 48118.5188148121, 48215.51784482181, 61098.0, 62249.68875155595, 54440.18339724907, 54452.72773636106, 54578.72710636501, 54618.0, 54688.0, 14252.643683907778, 14436.639084022983, 14479.78280325796, 14506.202158881362, 14531.273436328142, 10934.835977460345, 11047.060999814945, 11059.778804424028, 11202.551897924155, 11234.10127189823, 18696.252149914122, 19084.522886927938, 19088.71366929497, 19099.90450047741, 19111.80888191128, 7093.361597456254, 7240.565566066053, 7320.121585409678, 7363.079615048119, 7427.62861856905, 829.9792505187298, 831.2767891934056, 892.5358813416987, 980.9460479673686, 992.1963209800085, 23275.0, 25498.745012549636, 27411.31471713223, 27466.45067098647, 27526.0, 927.7263207353847, 942.7313215733483, 969.5290858725745, 1050.144132531984, 1067.9626213082504, 12988.740225195632, 13944.721105578035, 15301.46444874424, 15395.016802879376, 15450.38198472071, 248242.0, 252129.04774046436, 252317.0, 253813.0, 253903.0, 45936.770316148206, 46429.5357046432, 46582.301265481045, 46599.30101048487, 46633.30050049252, 1020.6886899495726, 1072.7479042425025, 1099.8790133085195, 1183.4910988275124, 1211.5275042733342, 23573.29280121599, 30675.386492269583, 31657.0, 32101.197470063435, 32615.18462038373, 42829.78585107055, 43355.566444335156, 43417.0, 43443.56556434522, 43475.130497390506, 141560.0, 143946.0, 153590.23204883904, 156221.0, 156281.0, 40139.397909030806, 40167.397489038274, 40197.0, 40275.173858483395, 40347.0, 43048.139037219706, 43123.137537249706, 43317.0, 43492.0, 43517.56482435135, 35647.46528802018, 35939.28121437504, 36296.0, 37412.0, 37485.43771843479, 36235.27529449449, 36974.63025369712, 37066.629333707395, 37219.62780372162, 37285.440718389786, 36119.27761444704, 36301.27397452089, 36545.63454365529, 40086.0, 40856.1828763429, 30438.39123217479, 33065.50401743928, 33480.497792532646, 33556.496652549744, 35031.0, 23969.16107936214, 24010.39974000664, 24226.51546969086, 24333.02667893335, 25700.0], "unit": "score", "name": "ext.html", "value": 17516.292373531465}, {"lowerIsBetter": false, "replicates": [299.5566561488998, 304.7227023408698, 306.96776838431964, 309.7723173467502, 312.7513626666801, 12695.365231738422, 13108.0, 15118.092914425142, 15561.144137072457, 15652.765208521867, 14872.107673539595, 15036.774448383283, 16244.0, 16294.674106517892, 16323.0, 4880.780364883589, 4979.053979743846, 5047.596192304625, 5056.620753443506, 5061.848144555651, 3405.8807941722043, 3502.229509507917, 5005.899882002358, 5030.195168772997, 5196.922046169291, 5169.896602067956, 5194.065068287707, 5194.298769666103, 5208.244804503344, 5215.58275337972, 5027.673201241908, 5174.172132458807, 5204.349456317941, 5205.193195054772, 5210.53105220532, 5004.449510553836, 5018.498150184989, 5020.623453240985, 5022.045811295842, 5026.974865125688, 17682.29270829178, 18381.908090459463, 18463.076846157637, 19033.14350854201, 19062.998385169634, 1789.9015554144516, 1869.9158537865828, 1880.3700760245333, 1923.6729755941524, 1947.0751393088312, 8764.912350876537, 8825.470471771714, 8917.866232006525, 9074.682386116454, 9451.905480945172, 1718.218210714122, 1732.9826701733073, 1735.8698097642728, 1757.6484703059311, 1781.358710864088, 53193.73403132959, 54051.45948540504, 54303.0, 54342.72828635871, 55744.0979131461, 9226.907730922605, 9244.8613270801, 9353.672621458216, 9362.0, 9378.062193780705, 11651.475683594259, 11731.47208375625, 11748.471318790675, 11793.0, 11795.469203885847, 6908.205556361083, 6909.689063992132, 6952.339527744856, 6988.860222795515, 6989.860202795916, 6842.452603791685, 6852.862942741117, 6916.930830691729, 6924.169099708067, 6935.098437203233, 3845.8846234613006, 3862.208247309295, 3882.7087968402484, 4005.839766409311, 4013.3578627419474, 1539.2226925402824, 1582.0507695382908, 1601.087380193302, 1631.1436495839541, 1664.7752553405378, 823.8269963307772, 837.4389159263308, 878.4816957994686, 885.7829831691148, 968.9079537443931, 15266.160361180242, 15455.30451129702, 15663.765043524356, 15796.526104216891, 15920.601984950237, 729.7664747280925, 770.1451388958252, 785.3128512551517, 794.3605397654943, 814.698561532225, 8243.752687419386, 8394.706185283609, 8518.659253629909, 8527.403081784216, 8579.2707619853, 431199.0, 431943.0, 437296.0, 438372.0, 439277.0, 70107.64946175237, 70359.29640703528, 70975.0, 71205.64397178084, 71251.2874871255, 998.8601595776597, 1008.626808081, 1010.838265877456, 1010.9443980581138, 1034.9741256468799, 13265.204087754766, 13483.730325393633, 13666.794998074838, 13757.79363309531, 13776.24230667323, 30208.58834403355, 33228.169295766835, 34105.31789364248, 34168.31663366769, 34351.828240859635, 39873.60126398815, 40519.392209117475, 41267.0, 41523.37714934339, 43898.78050609727, 8108.2297181767635, 8653.480791152551, 8765.474071555473, 8766.91233087661, 8794.164554367326, 9697.854532182164, 9779.511024448606, 9832.360896541702, 9856.063673950963, 9919.20646348276, 10897.56409743633, 13503.257320847448, 13668.762683568126, 13728.313584320544, 13827.377768000666, 12858.67853303675, 12997.935010324887, 13010.219386836441, 13396.866031339561, 13404.597862064154, 13702.588922332347, 13732.65668358299, 14250.643733906321, 14441.927790361402, 14498.927505362406, 8670.306375490072, 8710.869336960077, 8744.475331480131, 8761.430507017023, 8867.600957956778, 13768.173909565458, 13885.861141388861, 13953.162810231419, 13989.860101398855, 14158.86729061652], "unit": "score", "name": "jquery.html", "value": 7961.593964125749}, {"lowerIsBetter": false, "replicates": [1256.2525297448026, 1647.1270226779807, 1669.1654172913543, 1712.3578658003241, 1720.9655806883864, 5998.310194327648, 6799.932000679992, 6966.442684585234, 6983.057287266218, 6999.930000700004, 6934.583924964506, 6976.093107895967, 7025.6135912524915, 7031.964840175805, 7038.788836334906, 1990.4725247809342, 2019.61627290815, 2033.8677985930942, 2034.5727397246521, 2037.0324096054403, 2046.4474591860264, 2076.4912596413824, 2082.333653230967, 2087.4572611121143, 2089.101686274909, 2024.4635171679517, 2038.3884834549576, 2067.9586408271825, 2070.0, 2071.5856828634332, 2022.413500084981, 2046.130394582304, 2051.292304155064, 2052.404802607242, 2052.969205461919, 2023.5447024419389, 2037.1443993522607, 2070.099506714569, 2073.5956488484753, 2073.7304150460345, 7016.579005259649, 7103.112110986127, 7109.360157585842, 7110.502264841463, 7111.466640001969, 4119.464469618961, 4156.106437116035, 4177.8537751178565, 4216.2199993001395, 4237.957620423787, 2570.961435578468, 2592.3907881647797, 2622.069165446277, 2695.3800625855965, 2696.7707744841514, 807.8142027333746, 826.1078035721406, 835.1231207232443, 845.6279237135641, 848.7284069097891, 9515.000924902855, 9525.333226674136, 9533.142017218413, 9537.618495260182, 9548.37935534188, 3735.9252814944093, 3771.321162190777, 3804.7526910751267, 3818.0, 3835.76985380878, 8206.917930820615, 8208.0560735515, 8208.753737387888, 8232.34141268697, 8235.876461853077, 4233.7883105844585, 4250.829966801355, 4251.957480425156, 4271.957280427218, 4274.465691788527, 3174.3968645957193, 3239.206394433379, 3696.2053158570498, 3895.4351619015083, 3895.590962948906, 3295.340931813647, 3312.271300313927, 3344.063662174595, 3359.6136444308727, 3360.4119279126057, 1017.4149863828328, 1026.10728666061, 1029.891861354562, 1037.8910214427528, 1039.0440794469107, 895.583553647557, 979.2313034268066, 981.3228872078244, 982.1455333859445, 1102.8511150994514, 6424.1327420798525, 6436.871262574722, 6458.483321334282, 6464.5798023128345, 6470.676466176672, 411.99588004120176, 417.0, 421.3700517726019, 423.0629156418548, 423.8558889977422, 5112.463191364853, 5127.307813445212, 5165.070287348238, 5168.431472538018, 5170.069387510209, 8191.549464779494, 8281.337493000545, 8380.8742868857, 8610.0, 8616.655333786704, 8372.288355489729, 8479.15208479147, 8490.320774338039, 8495.660173592987, 8503.362247831314, 6496.317886622026, 6565.015247712786, 6605.372489613479, 6622.503312251601, 6639.668016599151, 6578.177727784027, 6668.66656667155, 6681.031250468558, 6689.632070236184, 6698.631575263213, 7476.850462990818, 7577.696892124473, 7590.848183036419, 7689.192634773268, 7692.307692307719, 7575.280348366897, 7639.083310002835, 7684.231576842271, 7699.961500192688, 7729.768106956801, 5322.042032434044, 5453.563714902719, 5853.9121913172185, 5926.703664816656, 5932.940670593412, 6444.258910225384, 6619.669016549057, 6622.966885165543, 6643.40209381158, 6669.899951500828, 6089.238845144357, 6242.563020588515, 6329.0, 6371.681415929278, 6377.0753240778895, 6143.96928015357, 6187.84530386744, 6235.314115447388, 6288.276848162337, 6324.430801227912, 6188.319284878749, 6205.751769929152, 6277.2153480814895, 6280.9685951569945, 6288.371162883675, 5781.046127388934, 5815.156802263733, 5817.243758311392, 5819.243498345358, 5829.970850145722, 5814.30228372598, 5876.911846322223, 5919.4080591940465, 5920.644761314335, 5924.496417804535], "unit": "score", "name": "mootools.html", "value": 3916.361738886268}, {"lowerIsBetter": false, "replicates": [288.26492444267114, 290.45104752018676, 294.88941646882415, 298.8804478208715, 302.3393884362669, 5233.73831308434, 5258.290130832336, 5297.258383826267, 5314.043472175012, 5326.707031113297, 5207.817726379578, 5215.817446389377, 5215.947840521593, 5225.399079105904, 5229.921551176735, 4094.2425651254466, 4104.322786740185, 4111.979440102796, 4115.938260926088, 4116.073883376246, 3907.374820028782, 3993.2812093823245, 4019.176068905882, 4068.3694027425795, 4068.4914385701786, 4029.516458025041, 4032.6169013943627, 4050.250703619825, 4055.2295063937904, 4060.1473690525027, 3835.252125835463, 3917.0990672145567, 4064.634182923536, 4076.694247931402, 4076.9592304076878, 3477.426224672926, 3570.839312230956, 3575.3921833288146, 3576.3741345264475, 3577.6601222883783, 5048.899022019576, 5054.545090941833, 5060.74696265189, 5063.417706963673, 5066.46802085783, 4668.533146685339, 4676.321933319649, 4679.110968915895, 4679.789409476582, 4680.297955306697, 5399.78400863965, 5532.585056120767, 5535.0, 5537.473939975695, 5544.1960915667005, 3872.9806350968065, 3888.319544079803, 3891.571927088018, 3895.104126050996, 3909.0618251619408, 5826.009578371687, 5826.242588463472, 5830.737616807254, 5844.327902291248, 5847.853803654943, 4007.0984028593334, 4015.19696060789, 4025.3156963316305, 4028.254772867029, 4029.979850100731, 3796.126890815073, 4078.4290199372113, 4080.6735461163034, 4088.0801819590356, 4094.6314831665295, 4231.965546117949, 4396.516383197845, 4512.481064677604, 4522.163399771053, 4649.465311489154, 5345.118055520873, 5538.280023596906, 5547.417521160301, 5551.916721249185, 5552.416996215339, 1418.2625034981752, 1428.407211007441, 1430.4635761589404, 1431.1270125223605, 1431.6564024634222, 946.7301818981557, 948.3124734567383, 958.8609651600618, 963.4797209506788, 969.8496733006396, 4861.416630004352, 4878.0975519529, 4879.878003049881, 4881.0, 4887.340209071801, 5764.596478246566, 5765.88468230633, 5772.163036359789, 5778.306603207642, 5780.306363236355, 4864.124457597595, 4871.610271178297, 4875.390576177978, 4877.829275975395, 4878.146324393217, 3002.6246719160104, 3076.553899684533, 3087.4442600332154, 3124.0, 3124.718775310233, 5298.894022119536, 5400.324959380077, 5410.675359478444, 5442.700651464128, 5508.338999320107, 5977.970110149508, 5986.281646202397, 5986.491148252448, 5988.221531200916, 5988.820335389945, 5508.862278442991, 5510.090835012338, 5510.614257002052, 5512.476314750093, 5516.062269414209, 5684.289463817023, 5812.3025236971835, 5822.7670893163795, 5829.737661805144, 5830.912536311874, 5638.097904335286, 5651.660900345993, 5654.491095801398, 5656.745446454837, 5661.490465858093, 5447.073997420369, 5479.0, 5496.862578435571, 5497.092979658311, 5500.0, 3970.861019864291, 4069.064115253449, 4069.7965101745385, 4074.6129117733767, 4081.6530594898577, 5808.30300363959, 5813.505852002627, 5815.110089221104, 5816.47651711348, 5816.621919575214, 5575.135853942646, 5613.382527922007, 5613.971930140323, 5617.073182924772, 5620.74706638194, 5590.189422533791, 5609.158626206102, 5619.8876022480135, 5620.662760234399, 5625.943740562706, 5348.812791552277, 5482.588805839658, 5486.753096110605, 5521.889562208814, 5526.696031718133, 5612.803551875665, 5613.57898157648, 5613.691246981455, 5616.466435688603, 5668.971655141698, 5498.285222921155, 5502.614816962774, 5503.862403439786, 5509.173623956278, 5513.173024046425], "unit": "score", "name": "prototype.html", "value": 4170.639809661356}, {"lowerIsBetter": false, "replicates": [664.1930054983196, 708.9220185779564, 761.3908872901679, 776.6233376812248, 804.3846457460044, 11653.883461165386, 11710.297382157067, 11745.647630571075, 11765.352905590189, 11805.173637845353, 11521.36632485213, 11583.942080289607, 12070.275783452998, 12087.637370878865, 12107.455164517596, 628.2272804450529, 638.1162090504638, 792.0495405513393, 792.6472719639762, 808.3290868579065, 796.2475460689651, 805.569020573993, 810.2100452059254, 812.155358427235, 812.634314558451, 826.7933016745814, 837.4975014991018, 842.1410161635129, 842.465034702965, 843.7300063979529, 660.9438197753196, 670.430134385773, 825.4469505431315, 838.1660248053226, 840.0591337701752, 620.280474649409, 622.3993845938645, 626.9467095296906, 627.3600927054379, 627.6202897247146, 11291.717707057307, 11464.541418343257, 11465.197436179471, 11476.0, 11477.311361318265, 10532.894671053267, 11507.712307192303, 11605.709857253552, 11611.361375124365, 11769.293842369485, 9151.405158664666, 9187.310951678584, 9392.248620110375, 9392.389494682824, 9495.762605934908, 3193.840307984615, 3222.2266656002625, 3259.2340799912004, 3264.575605171336, 3280.327532855759, 38589.22821543582, 38813.80593097045, 38825.0, 38862.80568597139, 38996.41505377422, 8670.219680228809, 8694.652213911373, 8767.281277807977, 8871.512066836256, 8993.055729148477, 16429.83570164283, 16454.341826326814, 16649.0, 16665.41671041532, 16670.249408847405, 6535.640539770358, 6557.082008518812, 6615.272320044791, 6744.966275168593, 6792.762253321209, 3568.232829941523, 3647.1429214134655, 3650.945235821465, 3656.798876061789, 3661.7253705971625, 2640.9603855942178, 2663.880125394362, 2684.758371746513, 2691.7039125696156, 2692.488427198826, 468.75858932649714, 474.93350930869707, 478.77258302306126, 490.5682998960892, 494.5969035236343, 514.6680391147763, 536.6404508978993, 552.9411177594941, 567.7643777832236, 573.931128264611, 7163.856722865514, 7323.084614423197, 7336.669849856769, 7389.334959853639, 7463.962680186564, 431.7646882449073, 541.3125330829903, 555.6527170518426, 563.2874413866463, 570.6775671745451, 3386.1873150444208, 3460.3944309745693, 3574.12433953683, 3587.408077667208, 3650.543682039745, 49501.257481137814, 50646.0, 50707.0, 50710.239346409835, 50780.0, 42781.57218427838, 43237.78381108074, 43457.56542434599, 43772.0, 44087.0, 41037.0, 41170.58829411668, 41301.380479292835, 41630.58369416267, 41631.375529367084, 7150.678219480032, 7168.928310717035, 8009.1487470412885, 8105.311048560939, 8290.668373265244, 30347.848260758554, 30932.381352373275, 31383.0, 31456.370872581963, 32369.676303237607, 41548.0, 41691.58308416877, 42080.78959605182, 42145.578544214164, 42153.78923105365, 9546.618135274512, 9549.52252387364, 9558.61765529371, 9699.272554558294, 9876.35803672759, 10776.892231077902, 10896.61861834832, 10921.071708904514, 10949.0, 11451.370174640475, 9827.0, 10164.288499805238, 10281.691549253534, 10284.382937023802, 10290.742731431774, 10352.482375881327, 10382.117520010883, 10404.68785936423, 10446.488669508517, 10476.52855621514, 8963.820723585623, 9100.135487128713, 9897.406155630397, 10104.393736375841, 10282.845757313497, 7288.927110728825, 8247.876281855897, 8493.150684931457, 8512.91487085146, 8794.60424280896, 7410.888836667346, 8579.403262800226, 8856.3800533962, 8987.640494380414, 9236.907630923604], "unit": "score", "name": "yui.html", "value": 5612.809162634957}], "name": "dromaeo_css", "value": 6228.448783834797}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 112.0, 112.0, 112.0, 102.0, 112.0, 112.0, 105.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 156.0, 162.0, 135.0, 156.0, 149.0, 132.0, 169.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 91.0, 72.0, 73.0, 72.0, 107.0, 98.0, 77.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 134.0, 95.0, 96.0, 95.0, 133.0, 95.0, 93.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 110.0, 96.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 71.0, 69.0, 79.0, 66.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 75.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 83.0, 81.0, 83.0, 81.0, 91.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 118.0, 116.0, 118.0, 118.0, 119.0, 120.0, 126.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [135.0, 146.0, 145.0, 149.0, 151.0, 157.0, 145.0, 158.0, 148.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 68.0, 71.0, 70.0, 71.0, 67.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1519.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.20857863751053], "unit": "score", "name": "Richards", "value": 209.87038999999996}, {"lowerIsBetter": false, "replicates": [186.1850679575498], "unit": "score", "name": "DeltaBlue", "value": 355.1197780000001}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [11917.64705882353], "unit": "score", "name": "Boyer", "value": 55.922364264560706}, {"lowerIsBetter": false, "replicates": [27351.35135135135], "unit": "score", "name": "RegExp", "value": 33.306763833992065}, {"lowerIsBetter": false, "replicates": [618.8118811881188], "unit": "score", "name": "Splay", "value": 131.68945600000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19753.084313868396}]} 05:06:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19753.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6228.45"}}} 05:06:47 INFO - Return code: 0 05:06:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:06:47 ERROR - # TBPL SUCCESS # 05:06:47 INFO - Running post-action listener: _resource_record_post_action 05:06:47 INFO - Running post-run listener: _resource_record_post_run 05:06:48 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555302912; Read time: 12; Write time: 653084 05:06:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 237789184; Read time: 0; Write time: 348444 05:06:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317513728; Read time: 12; Write time: 304640 05:06:49 INFO - Running post-run listener: _upload_blobber_files 05:06:49 INFO - Blob upload gear active. 05:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:49 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 05:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:50 INFO - (blobuploader) - INFO - Done attempting. 05:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:51 INFO - (blobuploader) - INFO - Done attempting. 05:06:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:51 INFO - Return code: 0 05:06:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ecf41c8cffca6e82e1e8ed0573cb0049a5cb5a031c1475cc39ae5f40c61ab54963e1965e6e5b912271b0836cf51386c23b7ed5128225cf78e0e826123896e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94b9ad18afe144b32d542b4fb4e62a70a110f3ed969fdea6f375debb3a53770b82253e58aa701abe0dc7b2c850fade65b22faf778ab9844700553ae70a83b3d9"} 05:06:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:51 INFO - Contents: 05:06:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ecf41c8cffca6e82e1e8ed0573cb0049a5cb5a031c1475cc39ae5f40c61ab54963e1965e6e5b912271b0836cf51386c23b7ed5128225cf78e0e826123896e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94b9ad18afe144b32d542b4fb4e62a70a110f3ed969fdea6f375debb3a53770b82253e58aa701abe0dc7b2c850fade65b22faf778ab9844700553ae70a83b3d9"} 05:06:51 INFO - Copying logs to upload dir... 05:06:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.208304 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 05:06:50.298272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:06:50.301627) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ecf41c8cffca6e82e1e8ed0573cb0049a5cb5a031c1475cc39ae5f40c61ab54963e1965e6e5b912271b0836cf51386c23b7ed5128225cf78e0e826123896e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94b9ad18afe144b32d542b4fb4e62a70a110f3ed969fdea6f375debb3a53770b82253e58aa701abe0dc7b2c850fade65b22faf778ab9844700553ae70a83b3d9"} build_url:https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/a9UDLuKRQweRueTPlilbqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ecf41c8cffca6e82e1e8ed0573cb0049a5cb5a031c1475cc39ae5f40c61ab54963e1965e6e5b912271b0836cf51386c23b7ed5128225cf78e0e826123896e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94b9ad18afe144b32d542b4fb4e62a70a110f3ed969fdea6f375debb3a53770b82253e58aa701abe0dc7b2c850fade65b22faf778ab9844700553ae70a83b3d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:06:50.327669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:06:50.328130) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450701345.213278-2029847605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:06:50.410326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:06:50.410691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:06:50.411020) ========= ========= Total master_lag: 0.23 =========