builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1470919944.44 results: success (0) buildid: 20160811041522 builduid: 55130c828f034769b55c8ecbc0e7a465 revision: 39fdb9c2017e96940075926234809cef0f8b5f1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.442415) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.443041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.443636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.459082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.459423) ========= 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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 05:52:24-- 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% 42.5M=0s 2016-08-11 05:52:25 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.592330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.592652) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020723 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.647456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:24.648133) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39fdb9c2017e96940075926234809cef0f8b5f1b --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 39fdb9c2017e96940075926234809cef0f8b5f1b --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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 05:52:25,148 truncating revision to first 12 chars 2016-08-11 05:52:25,148 Setting DEBUG logging. 2016-08-11 05:52:25,148 attempt 1/10 2016-08-11 05:52:25,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39fdb9c2017e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 05:52:25,575 unpacking tar archive at: fx-team-39fdb9c2017e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:25.430297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:25.430652) ========= script_repo_revision: 39fdb9c2017e96940075926234809cef0f8b5f1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:25.431115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:25.431452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 05:52:25.442866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-11 05:52:25.443316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:26 INFO - MultiFileLogger online at 20160811 05:52:26 in /builds/slave/test 05:52:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:26 INFO - {'append_to_log': False, 05:52:26 INFO - 'base_work_dir': '/builds/slave/test', 05:52:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:26 INFO - 'branch': 'Fx-Team-Non-PGO', 05:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:26 INFO - 'config_files': ('talos/linux_config.py',), 05:52:26 INFO - 'default_actions': ('clobber', 05:52:26 INFO - 'read-buildbot-config', 05:52:26 INFO - 'download-and-extract', 05:52:26 INFO - 'populate-webroot', 05:52:26 INFO - 'create-virtualenv', 05:52:26 INFO - 'install', 05:52:26 INFO - 'run-tests'), 05:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:26 INFO - 'download_minidump_stackwalk': True, 05:52:26 INFO - 'download_symbols': 'ondemand', 05:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:26 INFO - 'installer_path': 'installer.exe', 05:52:26 INFO - 'log_level': 'info', 05:52:26 INFO - 'log_name': 'talos', 05:52:26 INFO - 'log_to_console': True, 05:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:26 INFO - 'opt_config_files': (), 05:52:26 INFO - 'pip_index': False, 05:52:26 INFO - 'sps_profile': False, 05:52:26 INFO - 'sps_profile_interval': 0, 05:52:26 INFO - 'suite': 'dromaeojs', 05:52:26 INFO - 'system_bits': '32', 05:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:26 INFO - 'title': 'talos-linux64-ix-021', 05:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:26 INFO - 'use_talos_json': True, 05:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:26 INFO - 'work_dir': 'build'} 05:52:26 INFO - [mozharness: 2016-08-11 12:52:26.033020Z] Running clobber step. 05:52:26 INFO - Running pre-action listener: _resource_record_pre_action 05:52:26 INFO - Running main action method: clobber 05:52:26 INFO - rmtree: /builds/slave/test/build 05:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:27 INFO - Running post-action listener: _resource_record_post_action 05:52:27 INFO - [mozharness: 2016-08-11 12:52:27.013095Z] Finished clobber step (success) 05:52:27 INFO - [mozharness: 2016-08-11 12:52:27.013197Z] Running read-buildbot-config step. 05:52:27 INFO - Running pre-action listener: _resource_record_pre_action 05:52:27 INFO - Running main action method: read_buildbot_config 05:52:27 INFO - Using buildbot properties: 05:52:27 INFO - { 05:52:27 INFO - "project": "", 05:52:27 INFO - "product": "firefox", 05:52:27 INFO - "script_repo_revision": "production", 05:52:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:52:27 INFO - "repository": "", 05:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:52:27 INFO - "buildid": "20160811041522", 05:52:27 INFO - "pgo_build": "False", 05:52:27 INFO - "basedir": "/builds/slave/test", 05:52:27 INFO - "buildnumber": 2091, 05:52:27 INFO - "slavename": "talos-linux64-ix-021", 05:52:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:52:27 INFO - "platform": "ubuntu64_hw", 05:52:27 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 05:52:27 INFO - "branch": "fx-team", 05:52:27 INFO - "repo_path": "integration/fx-team", 05:52:27 INFO - "revision": "39fdb9c2017e96940075926234809cef0f8b5f1b", 05:52:27 INFO - "stage_platform": "linux64", 05:52:27 INFO - "builduid": "55130c828f034769b55c8ecbc0e7a465", 05:52:27 INFO - "slavebuilddir": "test" 05:52:27 INFO - } 05:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:52:27 INFO - Running post-action listener: _resource_record_post_action 05:52:27 INFO - [mozharness: 2016-08-11 12:52:27.015670Z] Finished read-buildbot-config step (success) 05:52:27 INFO - [mozharness: 2016-08-11 12:52:27.015761Z] Running download-and-extract step. 05:52:27 INFO - Running pre-action listener: _resource_record_pre_action 05:52:27 INFO - Running main action method: download_and_extract 05:52:27 INFO - mkdir: /builds/slave/test/build/tests 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:27 INFO - trying https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:27 INFO - Downloaded 1361 bytes. 05:52:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:52:27 INFO - Using the following test package requirements: 05:52:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'jsshell-linux-x86_64.zip'], 05:52:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:27 INFO - trying https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:28 INFO - Downloaded 20262322 bytes. 05:52:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:29 INFO - Return code: 0 05:52:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:29 INFO - trying https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:52:29 INFO - Downloading https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:30 INFO - Downloaded 20262322 bytes. 05:52:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:32 INFO - Return code: 0 05:52:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:32 INFO - trying https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:32 INFO - Downloading https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:33 INFO - Downloaded 14413719 bytes. 05:52:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:52:33 INFO - Return code: 0 05:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:33 INFO - trying https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:35 INFO - Downloaded 55619670 bytes. 05:52:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:52:35 INFO - mkdir: /builds/slave/test/properties 05:52:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:35 INFO - Contents: 05:52:35 INFO - build_url:https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:52:36 INFO - Running post-action listener: _resource_record_post_action 05:52:36 INFO - Running post-action listener: set_extra_try_arguments 05:52:36 INFO - [mozharness: 2016-08-11 12:52:36.261018Z] Finished download-and-extract step (success) 05:52:36 INFO - [mozharness: 2016-08-11 12:52:36.261290Z] Running populate-webroot step. 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: populate_webroot 05:52:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:36 INFO - '--tppagecycles', 05:52:36 INFO - '7'], 05:52:36 INFO - 'tests': ['tsvgm']}}, 05:52:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['damp', 'tps']}, 05:52:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'tests': ['damp', 'tps']}, 05:52:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['dromaeo_dom']}, 05:52:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['basic_compositor_video']}, 05:52:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['a11yr', 05:52:36 INFO - 'ts_paint', 05:52:36 INFO - 'tpaint', 05:52:36 INFO - 'sessionrestore', 05:52:36 INFO - 'sessionrestore_no_auto_restore', 05:52:36 INFO - 'tabpaint']}, 05:52:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['tsvgx', 05:52:36 INFO - 'tsvgr_opacity', 05:52:36 INFO - 'tart', 05:52:36 INFO - 'tscrollx', 05:52:36 INFO - 'cart']}, 05:52:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:36 INFO - 'tsvgr_opacity', 05:52:36 INFO - 'tart', 05:52:36 INFO - 'tscrollx', 05:52:36 INFO - 'cart']}, 05:52:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'talos_options': ['--disable-e10s'], 05:52:36 INFO - 'tests': ['tp5o']}, 05:52:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'tests': ['tp5o']}, 05:52:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'talos_options': ['--disable-e10s', 05:52:36 INFO - '--xperf_path', 05:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:36 INFO - 'tests': ['tp5n']}, 05:52:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:36 INFO - 'talos_options': ['--xperf_path', 05:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:36 INFO - 'tests': ['tp5n']}}, 05:52:36 INFO - 'talos.zip': {'path': '', 05:52:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:36 INFO - Running post-action listener: _resource_record_post_action 05:52:36 INFO - [mozharness: 2016-08-11 12:52:36.282187Z] Finished populate-webroot step (success) 05:52:36 INFO - [mozharness: 2016-08-11 12:52:36.282277Z] Running create-virtualenv step. 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: create_virtualenv 05:52:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:36 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 05:52:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:36 INFO - Using real prefix '/usr' 05:52:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:38 INFO - Installing pip.................done. 05:52:38 INFO - Return code: 0 05:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:52:38 INFO - Using env: {'DISPLAY': ':0', 05:52:38 INFO - 'HOME': '/home/cltbld', 05:52:38 INFO - 'LANG': 'en_US.UTF-8', 05:52:38 INFO - 'LANGUAGE': 'en_US:en', 05:52:38 INFO - 'LOGNAME': 'cltbld', 05:52:38 INFO - 'MAIL': '/var/mail/cltbld', 05:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:38 INFO - 'MOZ_NO_REMOTE': '1', 05:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:38 INFO - 'NO_EM_RESTART': '1', 05:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:38 INFO - 'PWD': '/builds/slave/test', 05:52:38 INFO - 'SHELL': '/bin/bash', 05:52:38 INFO - 'SHLVL': '1', 05:52:38 INFO - 'TERM': 'linux', 05:52:38 INFO - 'TMOUT': '86400', 05:52:38 INFO - 'USER': 'cltbld', 05:52:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:38 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 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 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 05:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Downloading/unpacking psutil>=3.1.1 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:41 INFO - Installing collected packages: psutil 05:52:41 INFO - Running setup.py install for psutil 05:52:41 INFO - building 'psutil._psutil_linux' extension 05:52:41 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 05:52:41 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 05:52:41 INFO - building 'psutil._psutil_posix' extension 05:52:41 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 05:52:41 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 05:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:41 INFO - Successfully installed psutil 05:52:41 INFO - Cleaning up... 05:52:41 INFO - Return code: 0 05:52:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 05:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 05:52:41 INFO - Using env: {'DISPLAY': ':0', 05:52:41 INFO - 'HOME': '/home/cltbld', 05:52:41 INFO - 'LANG': 'en_US.UTF-8', 05:52:41 INFO - 'LANGUAGE': 'en_US:en', 05:52:41 INFO - 'LOGNAME': 'cltbld', 05:52:41 INFO - 'MAIL': '/var/mail/cltbld', 05:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:41 INFO - 'MOZ_NO_REMOTE': '1', 05:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:41 INFO - 'NO_EM_RESTART': '1', 05:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:41 INFO - 'PWD': '/builds/slave/test', 05:52:41 INFO - 'SHELL': '/bin/bash', 05:52:41 INFO - 'SHLVL': '1', 05:52:41 INFO - 'TERM': 'linux', 05:52:41 INFO - 'TMOUT': '86400', 05:52:41 INFO - 'USER': 'cltbld', 05:52:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:41 INFO - '_': '/tools/buildbot/bin/python'} 05:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:43 INFO - Installing collected packages: mozsystemmonitor 05:52:43 INFO - Running setup.py install for mozsystemmonitor 05:52:44 INFO - Successfully installed mozsystemmonitor 05:52:44 INFO - Cleaning up... 05:52:44 INFO - Return code: 0 05:52:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 05:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 05:52:44 INFO - Using env: {'DISPLAY': ':0', 05:52:44 INFO - 'HOME': '/home/cltbld', 05:52:44 INFO - 'LANG': 'en_US.UTF-8', 05:52:44 INFO - 'LANGUAGE': 'en_US:en', 05:52:44 INFO - 'LOGNAME': 'cltbld', 05:52:44 INFO - 'MAIL': '/var/mail/cltbld', 05:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:44 INFO - 'MOZ_NO_REMOTE': '1', 05:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:44 INFO - 'NO_EM_RESTART': '1', 05:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:44 INFO - 'PWD': '/builds/slave/test', 05:52:44 INFO - 'SHELL': '/bin/bash', 05:52:44 INFO - 'SHLVL': '1', 05:52:44 INFO - 'TERM': 'linux', 05:52:44 INFO - 'TMOUT': '86400', 05:52:44 INFO - 'USER': 'cltbld', 05:52:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:44 INFO - '_': '/tools/buildbot/bin/python'} 05:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:46 INFO - warning: no files found matching '*.txt' 05:52:46 INFO - no previously-included directories found matching 'build' 05:52:46 INFO - no previously-included directories found matching 'dist' 05:52:46 INFO - no previously-included directories found matching '.git*' 05:52:46 INFO - Installing collected packages: jsonschema, functools32 05:52:46 INFO - Running setup.py install for functools32 05:52:46 INFO - warning: no files found matching '*.txt' 05:52:46 INFO - no previously-included directories found matching 'build' 05:52:46 INFO - no previously-included directories found matching 'dist' 05:52:46 INFO - no previously-included directories found matching '.git*' 05:52:46 INFO - Successfully installed jsonschema functools32 05:52:46 INFO - Cleaning up... 05:52:46 INFO - Return code: 0 05:52:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 05:52:46 INFO - Using env: {'DISPLAY': ':0', 05:52:46 INFO - 'HOME': '/home/cltbld', 05:52:46 INFO - 'LANG': 'en_US.UTF-8', 05:52:46 INFO - 'LANGUAGE': 'en_US:en', 05:52:46 INFO - 'LOGNAME': 'cltbld', 05:52:46 INFO - 'MAIL': '/var/mail/cltbld', 05:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:46 INFO - 'MOZ_NO_REMOTE': '1', 05:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:46 INFO - 'NO_EM_RESTART': '1', 05:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:46 INFO - 'PWD': '/builds/slave/test', 05:52:46 INFO - 'SHELL': '/bin/bash', 05:52:46 INFO - 'SHLVL': '1', 05:52:46 INFO - 'TERM': 'linux', 05:52:46 INFO - 'TMOUT': '86400', 05:52:46 INFO - 'USER': 'cltbld', 05:52:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:46 INFO - '_': '/tools/buildbot/bin/python'} 05:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:46 INFO - Cleaning up... 05:52:46 INFO - Return code: 0 05:52:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:52:46 INFO - Using env: {'DISPLAY': ':0', 05:52:46 INFO - 'HOME': '/home/cltbld', 05:52:46 INFO - 'LANG': 'en_US.UTF-8', 05:52:46 INFO - 'LANGUAGE': 'en_US:en', 05:52:46 INFO - 'LOGNAME': 'cltbld', 05:52:46 INFO - 'MAIL': '/var/mail/cltbld', 05:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:46 INFO - 'MOZ_NO_REMOTE': '1', 05:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:46 INFO - 'NO_EM_RESTART': '1', 05:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:46 INFO - 'PWD': '/builds/slave/test', 05:52:46 INFO - 'SHELL': '/bin/bash', 05:52:46 INFO - 'SHLVL': '1', 05:52:46 INFO - 'TERM': 'linux', 05:52:46 INFO - 'TMOUT': '86400', 05:52:46 INFO - 'USER': 'cltbld', 05:52:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:46 INFO - '_': '/tools/buildbot/bin/python'} 05:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 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 05:52:49 INFO - Downloading docopt-0.6.1.tar.gz 05:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:49 INFO - Running setup.py install for blobuploader 05:52:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:49 INFO - Running setup.py install for requests 05:52:50 INFO - Running setup.py install for docopt 05:52:50 INFO - Successfully installed blobuploader requests docopt 05:52:50 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:52:50 INFO - Using env: {'DISPLAY': ':0', 05:52:50 INFO - 'HOME': '/home/cltbld', 05:52:50 INFO - 'LANG': 'en_US.UTF-8', 05:52:50 INFO - 'LANGUAGE': 'en_US:en', 05:52:50 INFO - 'LOGNAME': 'cltbld', 05:52:50 INFO - 'MAIL': '/var/mail/cltbld', 05:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:50 INFO - 'MOZ_NO_REMOTE': '1', 05:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:50 INFO - 'NO_EM_RESTART': '1', 05:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:50 INFO - 'PWD': '/builds/slave/test', 05:52:50 INFO - 'SHELL': '/bin/bash', 05:52:50 INFO - 'SHLVL': '1', 05:52:50 INFO - 'TERM': 'linux', 05:52:50 INFO - 'TMOUT': '86400', 05:52:50 INFO - 'USER': 'cltbld', 05:52:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:50 INFO - '_': '/tools/buildbot/bin/python'} 05:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:50 INFO - Running setup.py (path:/tmp/pip-x911xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:50 INFO - Running setup.py (path:/tmp/pip-GVb4ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:50 INFO - Running setup.py (path:/tmp/pip-KXfuJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:50 INFO - Running setup.py (path:/tmp/pip-tCXcR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:50 INFO - Running setup.py (path:/tmp/pip-5jPsP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:50 INFO - Running setup.py (path:/tmp/pip-bYSWLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:51 INFO - Running setup.py (path:/tmp/pip-LRBZ4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:51 INFO - Running setup.py (path:/tmp/pip-gNOIqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:51 INFO - Running setup.py (path:/tmp/pip-rC2Qn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:51 INFO - Running setup.py (path:/tmp/pip-oRI4kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:51 INFO - Running setup.py (path:/tmp/pip-STFznQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:51 INFO - Running setup.py (path:/tmp/pip-CWym9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:51 INFO - Running setup.py (path:/tmp/pip-kEturY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:51 INFO - Running setup.py (path:/tmp/pip-xcehGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:51 INFO - Running setup.py (path:/tmp/pip-zCrb7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:51 INFO - Running setup.py (path:/tmp/pip-FgLo0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:51 INFO - Running setup.py (path:/tmp/pip-LMvMx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:51 INFO - Running setup.py install for manifestparser 05:52:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:51 INFO - Running setup.py install for mozcrash 05:52:52 INFO - Running setup.py install for mozdebug 05:52:52 INFO - Running setup.py install for mozdevice 05:52:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for mozfile 05:52:52 INFO - Running setup.py install for mozhttpd 05:52:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for mozinfo 05:52:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for mozInstall 05:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for mozleak 05:52:52 INFO - Running setup.py install for mozlog 05:52:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for moznetwork 05:52:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:52 INFO - Running setup.py install for mozprocess 05:52:53 INFO - Running setup.py install for mozprofile 05:52:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:53 INFO - Running setup.py install for mozrunner 05:52:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:53 INFO - Running setup.py install for mozscreenshot 05:52:53 INFO - Running setup.py install for moztest 05:52:53 INFO - Running setup.py install for mozversion 05:52:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:53 INFO - Cleaning up... 05:52:53 INFO - Return code: 0 05:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:52:53 INFO - Using env: {'DISPLAY': ':0', 05:52:53 INFO - 'HOME': '/home/cltbld', 05:52:53 INFO - 'LANG': 'en_US.UTF-8', 05:52:53 INFO - 'LANGUAGE': 'en_US:en', 05:52:53 INFO - 'LOGNAME': 'cltbld', 05:52:53 INFO - 'MAIL': '/var/mail/cltbld', 05:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:53 INFO - 'MOZ_NO_REMOTE': '1', 05:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:53 INFO - 'NO_EM_RESTART': '1', 05:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:53 INFO - 'PWD': '/builds/slave/test', 05:52:53 INFO - 'SHELL': '/bin/bash', 05:52:53 INFO - 'SHLVL': '1', 05:52:53 INFO - 'TERM': 'linux', 05:52:53 INFO - 'TMOUT': '86400', 05:52:53 INFO - 'USER': 'cltbld', 05:52:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:53 INFO - '_': '/tools/buildbot/bin/python'} 05:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:53 INFO - Running setup.py (path:/tmp/pip-7AJw3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:53 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)) 05:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:53 INFO - Running setup.py (path:/tmp/pip-0eLJB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:53 INFO - Running setup.py (path:/tmp/pip-oTMPUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:54 INFO - Running setup.py (path:/tmp/pip-DIBrox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:54 INFO - Running setup.py (path:/tmp/pip-GCxTDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:54 INFO - Running setup.py (path:/tmp/pip-gExeoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:54 INFO - Running setup.py (path:/tmp/pip-_wwtJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:54 INFO - Running setup.py (path:/tmp/pip-YO494J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:54 INFO - Running setup.py (path:/tmp/pip-t_ahPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:54 INFO - Running setup.py (path:/tmp/pip-_I5aWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:54 INFO - Running setup.py (path:/tmp/pip-_FCF_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:54 INFO - Running setup.py (path:/tmp/pip-PkFzP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:54 INFO - Running setup.py (path:/tmp/pip-Yt1oMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:54 INFO - Running setup.py (path:/tmp/pip-pPzV6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:54 INFO - Running setup.py (path:/tmp/pip-rJlF1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:54 INFO - Running setup.py (path:/tmp/pip-WuzsLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:54 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)) 05:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:54 INFO - Running setup.py (path:/tmp/pip-QbMbLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:55 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)) 05:52:55 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:55 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:55 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)) 05:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:56 INFO - Downloading blessings-1.6.tar.gz 05:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:57 INFO - Installing collected packages: blessings 05:52:57 INFO - Running setup.py install for blessings 05:52:57 INFO - Successfully installed blessings 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:57 INFO - Reading from file tmpfile_stdout 05:52:57 INFO - Current package versions: 05:52:57 INFO - argparse == 1.2.1 05:52:57 INFO - blessings == 1.6 05:52:57 INFO - blobuploader == 1.2.4 05:52:57 INFO - docopt == 0.6.1 05:52:57 INFO - functools32 == 3.2.3-2 05:52:57 INFO - jsonschema == 2.5.1 05:52:57 INFO - manifestparser == 1.1 05:52:57 INFO - mozInstall == 1.12 05:52:57 INFO - mozcrash == 0.17 05:52:57 INFO - mozdebug == 0.1 05:52:57 INFO - mozdevice == 0.48 05:52:57 INFO - mozfile == 1.2 05:52:57 INFO - mozhttpd == 0.7 05:52:57 INFO - mozinfo == 0.9 05:52:57 INFO - mozleak == 0.1 05:52:57 INFO - mozlog == 3.3 05:52:57 INFO - moznetwork == 0.27 05:52:57 INFO - mozprocess == 0.23 05:52:57 INFO - mozprofile == 0.28 05:52:57 INFO - mozrunner == 6.12 05:52:57 INFO - mozscreenshot == 0.1 05:52:57 INFO - mozsystemmonitor == 0.3 05:52:57 INFO - moztest == 0.7 05:52:57 INFO - mozversion == 1.4 05:52:57 INFO - psutil == 3.1.1 05:52:57 INFO - requests == 1.2.3 05:52:57 INFO - wsgiref == 0.1.2 05:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 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)) 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1199030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, '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': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', '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 05:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Running post-action listener: _resource_record_post_action 05:52:57 INFO - Running post-action listener: _start_resource_monitoring 05:52:57 INFO - Starting resource monitoring. 05:52:57 INFO - [mozharness: 2016-08-11 12:52:57.889058Z] Finished create-virtualenv step (success) 05:52:57 INFO - [mozharness: 2016-08-11 12:52:57.889599Z] Running install step. 05:52:57 INFO - Running pre-action listener: _resource_record_pre_action 05:52:57 INFO - Running main action method: install 05:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:58 INFO - Reading from file tmpfile_stdout 05:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:58 INFO - Reading from file tmpfile_stdout 05:52:58 INFO - Output received: 05:52:58 INFO - Usage: mozinstall [options] installer 05:52:58 INFO - Options: 05:52:58 INFO - -h, --help show this help message and exit 05:52:58 INFO - -d DEST, --destination=DEST 05:52:58 INFO - Directory to install application into. [default: 05:52:58 INFO - "/builds/slave/test"] 05:52:58 INFO - --app=APP Application being installed. [default: firefox] 05:52:58 INFO - mkdir: /builds/slave/test/build/application 05:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:53:15 INFO - Reading from file tmpfile_stdout 05:53:15 INFO - Output received: 05:53:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:15 INFO - Running post-action listener: _resource_record_post_action 05:53:15 INFO - [mozharness: 2016-08-11 12:53:15.450888Z] Finished install step (success) 05:53:15 INFO - [mozharness: 2016-08-11 12:53:15.451135Z] Running run-tests step. 05:53:15 INFO - Running pre-action listener: _resource_record_pre_action 05:53:15 INFO - Running main action method: run_tests 05:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:15 INFO - Python 2.7.3 05:53:15 INFO - Return code: 0 05:53:15 INFO - grabbing minidump binary from tooltool 05:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:15 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14583b0>, '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 0x14592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1459740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:15 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 05:53:15 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 05:53:15 INFO - Calling ['/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'] with output_timeout 600 05:53:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:15 INFO - Return code: 0 05:53:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:15 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/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:53:15 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/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 05:53:15 INFO - Using env: {'DISPLAY': ':0', 05:53:15 INFO - 'HOME': '/home/cltbld', 05:53:15 INFO - 'LANG': 'en_US.UTF-8', 05:53:15 INFO - 'LANGUAGE': 'en_US:en', 05:53:15 INFO - 'LOGNAME': 'cltbld', 05:53:15 INFO - 'MAIL': '/var/mail/cltbld', 05:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:15 INFO - 'MOZ_NO_REMOTE': '1', 05:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:15 INFO - 'NO_EM_RESTART': '1', 05:53:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:15 INFO - 'PWD': '/builds/slave/test', 05:53:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:15 INFO - 'SHELL': '/bin/bash', 05:53:15 INFO - 'SHLVL': '1', 05:53:15 INFO - 'TERM': 'linux', 05:53:15 INFO - 'TMOUT': '86400', 05:53:15 INFO - 'USER': 'cltbld', 05:53:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470917742.345943-543004227', 05:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:15 INFO - '_': '/tools/buildbot/bin/python'} 05:53:15 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/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:53:17 INFO - mozversion application_buildid: 20160811041522 05:53:17 INFO - mozversion application_changeset: 39fdb9c2017e96940075926234809cef0f8b5f1b 05:53:17 INFO - mozversion application_display_name: Nightly 05:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:17 INFO - mozversion application_name: Firefox 05:53:17 INFO - mozversion application_remotingname: firefox 05:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:53:17 INFO - mozversion application_vendor: Mozilla 05:53:17 INFO - mozversion application_version: 51.0a1 05:53:17 INFO - mozversion platform_buildid: 20160811041522 05:53:17 INFO - mozversion platform_changeset: 39fdb9c2017e96940075926234809cef0f8b5f1b 05:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:53:17 INFO - mozversion platform_version: 51.0a1 05:53:17 INFO - using testdate: 1470919997 05:53:17 INFO - actual date: 1470919997 05:53:17 INFO - starting webserver on 'localhost:47601' 05:53:17 INFO - SUITE-START | Running 2 tests 05:53:17 INFO - TEST-START | dromaeo_css 05:53:17 INFO - operating with platform_type : linux_ 05:53:17 INFO - Initialising browser for dromaeo_css test... 05:53:17 INFO - TEST-INFO | started process 9733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGtD19Y/profile http://localhost:47601/getInfo.html) 05:53:23 INFO - PROCESS | 9733 | __metrics Screen width/height:1600/1200 05:53:23 INFO - PROCESS | 9733 | colorDepth:24 05:53:23 INFO - PROCESS | 9733 | Browser inner width/height: 1024/697 05:53:23 INFO - PROCESS | 9733 | __metrics 05:53:24 INFO - PROCESS | 9733 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:24 INFO - PROCESS | 9733 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:25 INFO - TEST-INFO | 9733: exit 0 05:53:25 INFO - Browser initialized. 05:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:25 INFO - TEST-INFO | started process 9814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGtD19Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:37 INFO - PROCESS | 9814 | RSS: Main: 156999680 05:53:37 INFO - PROCESS | 9814 | 05:54:28 INFO - PROCESS | 9814 | 1470920068501 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] 05:56:42 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47601/tests/dromaeo/cssquery-ext.html) 05:56:43 INFO - PROCESS | 9814 | RSS: Main: 246132736 05:56:43 INFO - PROCESS | 9814 | 05:59:46 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-ext.html (next: http://localhost:47601/tests/dromaeo/cssquery-jquery.html) 05:59:46 INFO - PROCESS | 9814 | RSS: Main: 250601472 05:59:46 INFO - PROCESS | 9814 | 06:02:49 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47601/tests/dromaeo/cssquery-mootools.html) 06:02:49 INFO - PROCESS | 9814 | RSS: Main: 215121920 06:02:49 INFO - PROCESS | 9814 | 06:05:51 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47601/tests/dromaeo/cssquery-prototype.html) 06:05:52 INFO - PROCESS | 9814 | RSS: Main: 199131136 06:05:52 INFO - PROCESS | 9814 | 06:08:55 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47601/tests/dromaeo/cssquery-yui.html) 06:08:56 INFO - PROCESS | 9814 | RSS: Main: 189505536 06:08:56 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | Cycle 1(1): loaded http://localhost:47601/tests/dromaeo/cssquery-yui.html (next: http://localhost:47601/tests/dromaeo/cssquery-dojo.html) 06:11:59 INFO - PROCESS | 9814 | RSS: Main: 225812480 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | __start_tp_report 06:11:59 INFO - PROCESS | 9814 | _x_x_mozilla_page_load 06:11:59 INFO - PROCESS | 9814 | _x_x_mozilla_page_load_details 06:11:59 INFO - PROCESS | 9814 | |i|pagename|runs| 06:11:59 INFO - PROCESS | 9814 | |0;dojo.html;2624.960625590616;2640.0627777139116;2666.6000099985;2691.798115141365;2711.5254830404688;4626.65300102492;4673.135469938055;4798.184308667526;4870.853874383765;4885.755712214393;4820.3733514643045;4851;4855.684380515273;4897.412310522734;4926.630502712302;4340.8697739067875;4426.601605855472;4451.799669014886;4496.437945256843;4572.748498832563;4484.394606728099;4514.458265008204;4530.365748795171;4541.977290113561;4551.522090180533;4289.077848262638;4334.32817913224;4337.154254920292;4383.364412160219;4392.736435813861;4323.07053983392;4344.391785150082;4384.539623339567;4422.5577442255835;4461.196984542781;4307.052448461333;4360.324149756792;4368.803403846835;4370.781460926941;4423.535528769497;4762.452317983407;4767.189577771753;4773.140834649762;4827.396575428072;4830;4898.485659005824;5061.114304996611;5117.002184574009;5127.692338459704;5201.791928322863;5161.148410512261;5189;5224.582033437316;5229.477052294778;5289;4617.353570500132;4926.75366231687;4927.679700819435;4929.309896614477;4930.926036109461;5133.255677926754;5252.763625636855;5309.522143007148;5311.973440132774;5383.596230282745;5131.281620573122;5172.7413629319135;5174.24973378858;5181;5183.50756678115;4962.925556116661;5213.322268105122;5262.315898933114;5271.446498117719;5273.2617433559335;4970.15507363749;4999.775010124553;5038.319826823332;5071.670341427795;5122.948770512322;5063.3923929128005;5063.746812659352;5074.08666440037;5075.467075957045;5123.052235336475;4184.560621134798;4283.079137985348;4286.61420472159;4289.506706728766;4333.7833108345085;3692.3722967095123;3785.432185172246;3791.2227993261317;3806.7715937043868;3888.2806680764147;4467.776611169428;4493.393391892053;4495.910081798345;4499.752513611783;4538.319252112209;5222.268882356473;5227.817026404057;5229.267902493654;5229.555487783505;5270.393904700932;4302.7848607569495;4374.58441448062;4410.316400957857;4415.558444155623;4481.170983368087;4567.954320456819;4600;4602.171609110393;4602.7468489233415;4636.026434448736;4810.975945120252;4839.685420447659;4857.465678775332;4866.270059491105;4913.508649135058;4989.201727723546;5077.974610126926;5114.181730923035;5124.487551244845;5199.090159222196;4830.2513110467935;4848.95151048485;4865.051314993542;4873.244647079709;4919.286703428054;5066.138756411346;5072.163093089599;5073.746312684425;5078.238264260391;5125.513076257749;4948.455669876239;5030;5064.670796398223;5083.5678967288195;5141.305923700253;4967.975160124176;4972.179590367694;4982.6512144149565;4983.775730092082;5009.77456014473;4902.558769710743;4944;4963.627727920492;4965.1807451770055;5002.474740152232;4716.268978308368;4857.441394239708;4910.950890491049;4921.31101645777;4977.402711674622;5047.369078865142;5054.09026375256;5056.115179843586;5058.038972595195;5115.897682046264;4723.385959825201;4959.578435832995;4967.205247160437;4969.875753106201;4970.155073637563 06:11:59 INFO - PROCESS | 9814 | |1;ext.html;573.6328749600256;581.4737662415513;584.1034012790368;584.3221862639339;586.8826234753051;28551.857240713794;39649.20701585967;40792.592074079286;40850.7957460213;44260.3360949586;40289;40642.59357406425;40654.18691626166;40670;40999.79500102503;7277.090363704537;7576.090869095702;7785.961070194669;7813.453058285922;7814.765557033298;7187.7843664690145;7438.404927605806;7438.77683669488;9791.216702663805;10074.546645400938;9938.950305248463;9993.950030249838;9997.750056248615;10011.299209055369;10027.097561219489;9991.300608957376;10042.548085336177;10044.648437304731;10050.597976080948;10054.64808731691;9874.60501579936;9922.553485093189;9932.553035113437;9938.204943604494;9968.700938971842;38059.61940380588;38383.80808095942;38387.8080609598;38423;38484;3104.6584875663657;3175.3014336846086;3323.6510166432417;3473.600535938349;3484.181217413906;28961.56557651637;29223.97716079927;29497.26256843596;29522.852385737933;30675.846620766977;3267.8856240031487;3278.8196649184283;3316.651751566099;3350.977951724723;3442.4492081266876;248761;249636;249787;249986;250058;29087;55614.721926390106;55703.721481392335;56163.438365615824;56254;30978.225544361572;32703;32744.672553274162;32777.18057048593;32871.3425731484;13456.46174153023;13715.177089374669;13749.037567370187;13754.65613359674;13800;11226.887731122748;11381.089512838953;11418.257813242113;11419.31484110956;11461.140414468948;7302.306280903305;7478.663460144307;7484.476086673881;7619.771406857803;7723.691052357955;3078.3073808392933;3078.5228289615147;3124.3438877835456;3146.1505393543616;3164.715175634204;876.1632640828121;894.8523493623479;926.249737712455;926.9988412514468;1044.1072882685194;28575.14261572991;29226.707732922823;29441.411171776872;29748.40503189924;29853.253668658457;961.3654987708079;978.882534095913;1061.7398737309409;1062.3307316390778;1106.1095817866533;14781.187034712979;15433.45982890616;15455.077756716406;15582.9220853895;15835.287412066255;396028;398365;401442;402937;403437;43815.12369752587;49029.75485122623;49928.75035624798;50152.49847501551;50843.74578127086;1137.5449820071872;1151.6257216404535;1159.8260260960924;1169.5323862843854;1172.9472173752201;28067;29303.70696293095;29665.851670741507;30401.543976840807;30465;43979.560204398826;44314.77842610766;44340;44345;44385;403286;418473;420480;666945;668214;39862.800685996386;40143;40479;40527.59472405238;40893.59106409017;42630.57369426266;42777;42997;43347.349789752545;43770.56229437665;37191.25617487581;37312.626873732;37322.253554929295;37653.05867353338;38650.22699546049;36340;36772.81613591915;37267.48202225375;37948.430773538974;38463.807680961414;36839;37277;37695.623043770305;37948.62051379451;37997.24005519819;31900.840495797373;33442.16394590155;34011.82994085014;34036;34216.657833422345;25243.368915777253;26060.478790423706;26359.34101647474;26476.602850957635;26559.203223903314 06:11:59 INFO - PROCESS | 9814 | |2;jquery.html;336.69024497462334;355.6941030713586;359.9820008999549;363.2335771522088;381.78047622617004;12724;13748;13924.791128133085;17261.223244953977;17310.307587696476;15513;16123.677526449464;16216.918915405406;16398.098104604243;16781.24484398202;4649.721016738989;4791.137595232856;4797.496262892399;4799;4806.3030860525205;3550.3609350316933;5128.640995130342;5309.601779866506;5387.19192121181;5443.1835224716215;5429.267048948381;5432.864178395552;5441.455854414567;5442.047641662713;5459.071957767169;5100.795968161269;5357.678539287635;5371.597130215249;5418.539424148952;5428.4842939920645;5236.554892834114;5245.816396426145;5265.605079619006;5278.577713782888;5290.656107353048;11864.644060678194;12776.744465110738;20430.387088387222;20951;20963.895180524152;1820.717788742747;1953.2870502266712;2135.188628321228;2349.91903724287;2369.881505924714;8763.956180219122;8923;8951.910480895238;9082;9526;1642.89321194122;1689.6282817780068;1729.3082766893217;1760.2167035669133;1795.5421367551191;65273;67147.66426167838;67747.32252677459;68238.65880670564;68621;9636.132748052709;9645.71062868115;9874.753131171634;9919.107280344804;10111.292209545261;12519.93740031294;13353;13366.866331336756;13375.866241337657;13384.063115581816;7097.858042839114;7108.822279442952;7251.56490610565;7301.269873012762;7316.6341682915645;6769.120014398097;6795.3204679531655;6957.512974091866;6974;6992.265812089658;4038.1318016626565;4149.734331029004;4165.16696660663;4264.722793018444;4279.379489973936;1561.4925149326514;1686.190628498303;1714.1857617631774;1770.805211426742;1793.6681713882713;703.9296070393023;822.3380178955879;844.6916875340579;885.3359980014989;955.5508910811907;16856.74714879278;17303.30786768515;17352.39266625662;17877.553061173316;17971.640567188584;842.3724325377633;867.8090820019586;875.9080296568768;887.689308741948;920.3879420185635;9547.52262386878;9941.950290248502;10002;10101.646442374482;10154.949225253975;382641;383338;383972;403388;410004;77536.61231693806;78970;80469.59765201136;81319;81992.59003705063;871.4342679854994;889.6174644902754;891.2736120062128;906.7007887397143;919.4850883505392;15199.392024318904;15320.46378376796;15590.84409155894;15892.205389730236;16374.836251637807;39042;39092.413613795245;39226;39805.80097099496;41186;48237;48615.756921215165;49097.75451122721;50513.10889505415;50684;4688;4984.651074424755;7371.8157046074275;7518.398528117628;7640.617969101634;11342.546298148312;11426;12505.937470312954;12827.615171544869;12954.093213475344;10245.897541024495;10453.68638940833;10491.108255798343;10946.56213751473;11093.944530277297;9703;9901.603935842486;9912.950435247778;10089.142422893843;10105.141063009727;10448.895511044791;10514.369137851754;10553.102986245947;10990.911726771888;11374.43127843621;7400.481966262525;7619.923800762143;7744.070711514429;7794.181610930771;7852;10689.572417103229;10840.403777792297;10986.670399887696;11045.171612128961;11084.111310144526 06:11:59 INFO - PROCESS | 9814 | |3;mootools.html;1332.3138583629432;1401.3273628658244;1425.2018869433118;1629.1446990330082;1666.4500714764129;7278.526895751773;7910.564918929456;7911.208879112086;7912.525248485095;7913.643886025128;6483.254425741041;7379.298966598165;7574.545527268354;7617.23827617238;7718.884216736739;2159.5896779611903;2186.9015894284717;2192.0574153114153;2198.373463562885;2200.2299195281685;2141.518158414352;2173.7717539658347;2176.85850419723;2199.747029091651;2204.47092697753;1763.303495119427;2020.605981833543;2091.717618121557;2106.5997460482536;2128.5849259394427;2119.2370746531237;2119.8304135669187;2139.9251026214006;2141.1221399226242;2143.485563464773;2161.2003558683386;2167.382296045635;2167.5556510915226;2168.035224325176;2168.0894024509585;7587.886181707278;7662.885056724153;7674.270944260286;7675.078990521118;7675.462717609769;4383.342498625232;4455.866324010285;4509.1883460977015;4511.187986162489;4512.4133862597655;2841.531147360683;2898.4927637663322;2914.825110493356;2933.1347252560545;2953.2173973896934;901.0989010989011;960.6061514778977;973.4889183178817;981.0679854138525;993.1359717046216;10359.067683908484;10368.170546356348;10395.116415104725;10395.740106497247;10398.324108932895;3658.341498530237;3829.310724069694;3977.5226972763453;3980.5820388859333;4000.0399904023407;8890.377673562789;8892.510911899908;8920.776980575407;8922.375433719708;8942.150495702897;4472.262076757299;4478.910421791611;4493.236149854467;4500.954990450119;4501.504834468205;4015.859444919414;4031.5766844481495;4043.3934909763184;4052.0477687743355;4052.068024354415;3556.804375759358;3599.1002249437643;3662.432322989941;3700.2784457031157;3700.648438398348;1098.0940723902813;1160.3154139057997;1164.574930150506;1175.61204802415;1176.1590462819127;592.4756590417511;778.8636988526985;817.7832874288318;843.35904712419;853.8763313989914;4998.400191976913;5384.703841288689;5516.14499752539;5518.944810551843;5594.468525490072;853.8761879527434;870.6865528409768;884.5311984648147;921.5898924978454;941.8587211918131;3627.365211088049;3683.3676504232376;3684.852605895734;3703.814809259526;3738.476613274144;9200.723978280663;9516.429014259167;9532.90467095334;9538.14156725898;9542.141207291377;9431.15119639222;9480.573374198178;9502.524873756285;9505;9526.428414295164;7395.4083673306;7537.773866784005;7546.1321947976685;7560;7560.773176804704;5065.56942659878;5148.30497882781;5155.2782610433815;5201;5312.4156342803035;8829.955850220707;8861.379703420698;8947.731568052968;8964.641414343354;9004.774880627774;8243.381746368927;8668.219860212612;8689;8901.376903616685;8988.235999940078;6335.746570137143;6512.674366281762;6513.772017979348;6519.608823470607;6525.249596296487;7208.495405321787;7279.8180045497165;7281.235470275545;7281.672324745293;7282.708691652275;6443.323451037761;6486.870262594816;6511.641859697762;6528.640924749185;6753.223379311442;6084.90872636902;6171.290301615371;6197;6310;6389.201349831271;5994.681170142736;6102.9694851525455;6106.755729770759;6112.205413296243;6114.296855861633;4583.74789386587;4782.473927868002;4809.062232864558;4839.540243676845;4841.346418233494;4621.861344159681;4743.549362810528;4743.928841067456;4772.880677982939;4986.6010719143105 06:11:59 INFO - PROCESS | 9814 | |4;prototype.html;279.7901573819635;284.1688062417429;285.15167377053257;291.16710308607315;298.1487852182019;4691.132140554;4780.928286075712;4792.233242681172;4862.343583616215;4873.975630121853;4656.79044443;4746.738929358884;4751.434225518225;4788.20994535902;4795.616350691945;3810.771353718772;3826.9808650956775;3829.5596006459195;3840.5391353037535;3848.134169811784;3630.2739452109686;3641.7997010164563;3833.8083095845095;3857.286402015636;3869.1814847021997;3758.9325870771104;3792.677622402099;3800.1639639279315;3812.90467738306;3837.6546110850018;3813.771173729585;3814.1227517670955;3831.1571454280015;3842.1931394407206;3854.2484215578115;3392.9830350848333;3395.9320813583836;3400.60892997306;3401.506781516691;3412.419888618916;4568.223402021665;4692.41344831896;4700.694454860423;4730.455997560291;4799.3041009053495;4289.6997210195295;4324.351347297899;4329.805158767863;4334.111507141029;4341.2836881914445;4987.177115775893;4987.47631498691;4994.300797888299;5012.122878496249;5015.874603134915;3374.5444365010653;3572.464130380438;3658.8536458541626;3679.1721862580707;3705.1292946157632;5235.136202526579;5264.631475796696;5268.236105764643;5268.604854635918;5275.781773118395;3660;3667.001484191122;3671.100580357776;3680.5399325084363;3694.815259237081;3732.1789206374556;3735.34631439497;3744.831482583236;3747.3442147624055;3750.8499660013294;4165.812538435777;4229.851955181553;4249.532551419341;4251.426057482262;4262.211490874198;5038.279329162285;5064.088464076428;5071.644984851099;5079.415867175322;5085.974570127126;1204.4880925606583;1237.1772771107112;1238.9442475088642;1270.1934271737514;1287.3177216075494;781.4881252779438;790.8966991047456;835.9592307577105;851.1445996773203;872.7294538693026;4435.3125265583885;4445.533219012022;4446.866594002185;4464.687471876938;4494.415725955605;5206.609504287194;5232.488405565274;5234.973825130926;5235.424103348629;5239.1093514102695;4325.243082460557;4527.569880861313;4532.660050496226;4534.433195850519;4540.909181816345;2744.300203448108;2777.750012494386;2782.526970415034;2799.188235411708;2807.4806160860308;4858.1012512685265;4976.253561965734;4989.525995030466;4990.72551009698;5008.398992120969;5304.443033481429;5350.545203657655;5352.973235133877;5356.464353564613;5385.784568617211;4898.338724272177;4913.361263035782;4959;4965.963954778524;4973.204287314013;5049.722265275445;5192.584593232456;5205.167173252262;5251.579873610179;5253;5126.769295381642;5134.486551344985;5137.51193636604;5147.40804807452;5156.7421628917655;4897.2654101885;4932.901341973212;4944.728039957837;4947.703137811743;4973.602111831117;3417.384870723194;3621.8370173341737;3664.8900532984053;3683.631636836295;3692.335379631692;5196.870078248074;5205.895882082413;5214.921776173436;5251.264822924717;5271.367435907716;5042.512458824583;5052.621053421081;5057.772400242072;5085.288059671575;5104.821331253388;4892.168331383602;5089;5096.821611243588;5122.46214147524;5130.024940397899;4798.328234047306;4881.267809828412;4969.627277954096;4981.488050924017;5021.6735912165595;5093.682374519511;5099.821506247264;5110.897782044412;5114.846554603368;5116.820911268237;5001.299818025552;5002.449730529566;5025.422076461107;5027.446980832033;5028.64799464034 06:11:59 INFO - PROCESS | 9814 | |5;yui.html;637.6620391192668;649.9470857211319;711.7864640607817;721.9675114619841;723.9239879812623;13453.730925381487;14332.498362557313;14338.139711617285;14342.354594043267;14359.92820035901;12427.937860310709;13935.512257071005;14462.710745785103;14470.204138772364;14966.17686027268;623.3486007122568;757.9621018949044;788.45202584204;796.5817945578559;797.0156856282515;756.5687558091889;775.9262870027338;779.9337056350189;785.8899754034439;787.6416230615085;818.0428898189103;819.5328662662284;820.1347578304886;820.6922404098464;820.8932838730957;647.119916912998;816.5345752920838;817.3012074676155;817.452306954342;817.7219745286601;571.9656820590778;586.4018700925033;587.7854583077188;590.8375196820866;591.3760982163816;12912.548060817826;12924.806127908088;12939.741205175938;12966.092373533857;12966.286854223014;12248.265104093694;12603.936980315131;12857.871421285761;13025.153365031243;13386.330683465787;12067.456964436622;12101;12123.696907577381;12175.756484870253;12338.259704417764;4149.771762553059;4176.519700234481;4198.958010419918;4235.322348424237;4325.4593175853015;66336.66831665907;66399;66955.66522167358;67987;68364;9233.492157931378;10039.196864250842;10102.898971010343;10213.693589192188;10514.421706806046;18567.44297671072;18902.81097189038;18910.05449727508;18955.431337059912;18958.336458223897;6772.577758670635;6827.52207345481;6858.177018757781;7083.716651333889;7149.92850071503;3666.156783939709;3793.6206379361843;3804.562475315319;3810.0855794609647;3867.303885300673;2646.5765477523887;2748.9725102749117;2759.8344099354103;2761.737634924679;2763.557830747071;495.1953076251092;498.521419437337;498.8727874392007;501.9899602007939;507.2619338861947;598.9727617136632;600.8167508909737;620.9511299519338;620.9844753881189;634.1312402009277;8165.730687632597;8641.395102342776;8662.6101825418;8689.913100869036;8875.644974201088;487.2496355612388;496.85342823867046;610.860178681577;619.7149311316845;632.3929028133044;3857.5370955485523;3888.2806680764147;4117.958820411817;4185.979070104691;4255.680823938217;58124.70937645369;59536;78235.21764782393;81507;106174;45813;46275.53724462712;46795.29807052897;58895.41104588985;73887;43316;43792.562074379486;58122.54693632693;69002;69316.65341673259;8506.319494440553;8901.643934242817;9080.318976076689;9135;9200;39012.609873900896;45649.77175114103;45679.31481027721;46348;46450.76774616105;53764.73117634387;54058.91882162256;56253;57617;60222.69888650704;10888.346699198073;11675.134451907043;11708.414579271173;11791.88208117908;12225.694357640774;12483.375831208585;12753.553625623059;13196.406161722938;13489.865101348862;13529.59411217665;12344.95067919201;12369.190157443098;12518.99848012175;12851.550195743104;13054.34728263602;12396.752064958831;12621.242725436503;12841.486340546273;13078.476860925457;13105.934470327587;11418.771624567296;11764.58823941158;12144.696382590153;12211.877881221075;12241.632751017483;9794.461304628314;9914.950425247827;10113.64602238918;10265.384076955406;10373.170146388422;9393.718188454357;9646.276529260474;10259.7435064124;10562.71893865997;10696 06:11:59 INFO - PROCESS | 9814 | __end_tp_report 06:11:59 INFO - PROCESS | 9814 | __start_cc_report 06:11:59 INFO - PROCESS | 9814 | _x_x_mozilla_cycle_collect,989 06:11:59 INFO - PROCESS | 9814 | __end_cc_report 06:11:59 INFO - PROCESS | 9814 | __startTimestamp1470921119298__endTimestamp 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | ------- Summary: start ------- 06:11:59 INFO - PROCESS | 9814 | Number of tests: 6 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#0] dojo.html Cycles:165 Average:4747.81 Median:4902.56 stddev:506.74 (10.3%) stddev-sans-first:480.15 06:11:59 INFO - PROCESS | 9814 | Values: 2625.0 2640.1 2666.6 2691.8 2711.5 4626.7 4673.1 4798.2 4870.9 4885.8 4820.4 4851.0 4855.7 4897.4 4926.6 4340.9 4426.6 4451.8 4496.4 4572.7 4484.4 4514.5 4530.4 4542.0 4551.5 4289.1 4334.3 4337.2 4383.4 4392.7 4323.1 4344.4 4384.5 4422.6 4461.2 4307.1 4360.3 4368.8 4370.8 4423.5 4762.5 4767.2 4773.1 4827.4 4830.0 4898.5 5061.1 5117.0 5127.7 5201.8 5161.1 5189.0 5224.6 5229.5 5289.0 4617.4 4926.8 4927.7 4929.3 4930.9 5133.3 5252.8 5309.5 5312.0 5383.6 5131.3 5172.7 5174.2 5181.0 5183.5 4962.9 5213.3 5262.3 5271.4 5273.3 4970.2 4999.8 5038.3 5071.7 5122.9 5063.4 5063.7 5074.1 5075.5 5123.1 4184.6 4283.1 4286.6 4289.5 4333.8 3692.4 3785.4 3791.2 3806.8 3888.3 4467.8 4493.4 4495.9 4499.8 4538.3 5222.3 5227.8 5229.3 5229.6 5270.4 4302.8 4374.6 4410.3 4415.6 4481.2 4568.0 4600.0 4602.2 4602.7 4636.0 4811.0 4839.7 4857.5 4866.3 4913.5 4989.2 5078.0 5114.2 5124.5 5199.1 4830.3 4849.0 4865.1 4873.2 4919.3 5066.1 5072.2 5073.7 5078.2 5125.5 4948.5 5030.0 5064.7 5083.6 5141.3 4968.0 4972.2 4982.7 4983.8 5009.8 4902.6 4944.0 4963.6 4965.2 5002.5 4716.3 4857.4 4911.0 4921.3 4977.4 5047.4 5054.1 5056.1 5058.0 5115.9 4723.4 4959.6 4967.2 4969.9 4970.2 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#1] ext.html Cycles:180 Average:53085.70 Median:37487.66 stddev:109384.61 (291.8%) stddev-sans-first:109620.40 06:11:59 INFO - PROCESS | 9814 | Values: 573.6 581.5 584.1 584.3 586.9 28551.9 39649.2 40792.6 40850.8 44260.3 40289.0 40642.6 40654.2 40670.0 40999.8 7277.1 7576.1 7786.0 7813.5 7814.8 7187.8 7438.4 7438.8 9791.2 10074.5 9939.0 9994.0 9997.8 10011.3 10027.1 9991.3 10042.5 10044.6 10050.6 10054.6 9874.6 9922.6 9932.6 9938.2 9968.7 38059.6 38383.8 38387.8 38423.0 38484.0 3104.7 3175.3 3323.7 3473.6 3484.2 28961.6 29224.0 29497.3 29522.9 30675.8 3267.9 3278.8 3316.7 3351.0 3442.4 248761.0 249636.0 249787.0 249986.0 250058.0 29087.0 55614.7 55703.7 56163.4 56254.0 30978.2 32703.0 32744.7 32777.2 32871.3 13456.5 13715.2 13749.0 13754.7 13800.0 11226.9 11381.1 11418.3 11419.3 11461.1 7302.3 7478.7 7484.5 7619.8 7723.7 3078.3 3078.5 3124.3 3146.2 3164.7 876.2 894.9 926.2 927.0 1044.1 28575.1 29226.7 29441.4 29748.4 29853.3 961.4 978.9 1061.7 1062.3 1106.1 14781.2 15433.5 15455.1 15582.9 15835.3 396028.0 398365.0 401442.0 402937.0 403437.0 43815.1 49029.8 49928.8 50152.5 50843.7 1137.5 1151.6 1159.8 1169.5 1172.9 28067.0 29303.7 29665.9 30401.5 30465.0 43979.6 44314.8 44340.0 44345.0 44385.0 403286.0 418473.0 420480.0 666945.0 668214.0 39862.8 40143.0 40479.0 40527.6 40893.6 42630.6 42777.0 42997.0 43347.3 43770.6 37191.3 37312.6 37322.3 37653.1 38650.2 36340.0 36772.8 37267.5 37948.4 38463.8 36839.0 37277.0 37695.6 37948.6 37997.2 31900.8 33442.2 34011.8 34036.0 34216.7 25243.4 26060.5 26359.3 26476.6 26559.2 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#2] jquery.html Cycles:180 Average:24284.37 Median:4272.05 stddev:64912.44 (1519.5%) stddev-sans-first:65069.64 06:11:59 INFO - PROCESS | 9814 | Values: 336.7 355.7 360.0 363.2 381.8 12724.0 13748.0 13924.8 17261.2 17310.3 15513.0 16123.7 16216.9 16398.1 16781.2 4649.7 4791.1 4797.5 4799.0 4806.3 3550.4 5128.6 5309.6 5387.2 5443.2 5429.3 5432.9 5441.5 5442.0 5459.1 5100.8 5357.7 5371.6 5418.5 5428.5 5236.6 5245.8 5265.6 5278.6 5290.7 11864.6 12776.7 20430.4 20951.0 20963.9 1820.7 1953.3 2135.2 2349.9 2369.9 8764.0 8923.0 8951.9 9082.0 9526.0 1642.9 1689.6 1729.3 1760.2 1795.5 65273.0 67147.7 67747.3 68238.7 68621.0 9636.1 9645.7 9874.8 9919.1 10111.3 12519.9 13353.0 13366.9 13375.9 13384.1 7097.9 7108.8 7251.6 7301.3 7316.6 6769.1 6795.3 6957.5 6974.0 6992.3 4038.1 4149.7 4165.2 4264.7 4279.4 1561.5 1686.2 1714.2 1770.8 1793.7 703.9 822.3 844.7 885.3 955.6 16856.7 17303.3 17352.4 17877.6 17971.6 842.4 867.8 875.9 887.7 920.4 9547.5 9942.0 10002.0 10101.6 10154.9 382641.0 383338.0 383972.0 403388.0 410004.0 77536.6 78970.0 80469.6 81319.0 81992.6 871.4 889.6 891.3 906.7 919.5 15199.4 15320.5 15590.8 15892.2 16374.8 39042.0 39092.4 39226.0 39805.8 41186.0 48237.0 48615.8 49097.8 50513.1 50684.0 4688.0 4984.7 7371.8 7518.4 7640.6 11342.5 11426.0 12505.9 12827.6 12954.1 10245.9 10453.7 10491.1 10946.6 11093.9 9703.0 9901.6 9913.0 10089.1 10105.1 10448.9 10514.4 10553.1 10990.9 11374.4 7400.5 7619.9 7744.1 7794.2 7852.0 10689.6 10840.4 10986.7 11045.2 11084.1 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#3] mootools.html Cycles:180 Average:5056.10 Median:5348.56 stddev:2811.58 (52.6%) stddev-sans-first:2805.54 06:11:59 INFO - PROCESS | 9814 | Values: 1332.3 1401.3 1425.2 1629.1 1666.5 7278.5 7910.6 7911.2 7912.5 7913.6 6483.3 7379.3 7574.5 7617.2 7718.9 2159.6 2186.9 2192.1 2198.4 2200.2 2141.5 2173.8 2176.9 2199.7 2204.5 1763.3 2020.6 2091.7 2106.6 2128.6 2119.2 2119.8 2139.9 2141.1 2143.5 2161.2 2167.4 2167.6 2168.0 2168.1 7587.9 7662.9 7674.3 7675.1 7675.5 4383.3 4455.9 4509.2 4511.2 4512.4 2841.5 2898.5 2914.8 2933.1 2953.2 901.1 960.6 973.5 981.1 993.1 10359.1 10368.2 10395.1 10395.7 10398.3 3658.3 3829.3 3977.5 3980.6 4000.0 8890.4 8892.5 8920.8 8922.4 8942.2 4472.3 4478.9 4493.2 4501.0 4501.5 4015.9 4031.6 4043.4 4052.0 4052.1 3556.8 3599.1 3662.4 3700.3 3700.6 1098.1 1160.3 1164.6 1175.6 1176.2 592.5 778.9 817.8 843.4 853.9 4998.4 5384.7 5516.1 5518.9 5594.5 853.9 870.7 884.5 921.6 941.9 3627.4 3683.4 3684.9 3703.8 3738.5 9200.7 9516.4 9532.9 9538.1 9542.1 9431.2 9480.6 9502.5 9505.0 9526.4 7395.4 7537.8 7546.1 7560.0 7560.8 5065.6 5148.3 5155.3 5201.0 5312.4 8830.0 8861.4 8947.7 8964.6 9004.8 8243.4 8668.2 8689.0 8901.4 8988.2 6335.7 6512.7 6513.8 6519.6 6525.2 7208.5 7279.8 7281.2 7281.7 7282.7 6443.3 6486.9 6511.6 6528.6 6753.2 6084.9 6171.3 6197.0 6310.0 6389.2 5994.7 6103.0 6106.8 6112.2 6114.3 4583.7 4782.5 4809.1 4839.5 4841.3 4621.9 4743.5 4743.9 4772.9 4986.6 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#4] prototype.html Cycles:180 Average:4212.77 Median:4793.92 stddev:1228.82 (25.6%) stddev-sans-first:1196.28 06:11:59 INFO - PROCESS | 9814 | Values: 279.8 284.2 285.2 291.2 298.1 4691.1 4780.9 4792.2 4862.3 4874.0 4656.8 4746.7 4751.4 4788.2 4795.6 3810.8 3827.0 3829.6 3840.5 3848.1 3630.3 3641.8 3833.8 3857.3 3869.2 3758.9 3792.7 3800.2 3812.9 3837.7 3813.8 3814.1 3831.2 3842.2 3854.2 3393.0 3395.9 3400.6 3401.5 3412.4 4568.2 4692.4 4700.7 4730.5 4799.3 4289.7 4324.4 4329.8 4334.1 4341.3 4987.2 4987.5 4994.3 5012.1 5015.9 3374.5 3572.5 3658.9 3679.2 3705.1 5235.1 5264.6 5268.2 5268.6 5275.8 3660.0 3667.0 3671.1 3680.5 3694.8 3732.2 3735.3 3744.8 3747.3 3750.8 4165.8 4229.9 4249.5 4251.4 4262.2 5038.3 5064.1 5071.6 5079.4 5086.0 1204.5 1237.2 1238.9 1270.2 1287.3 781.5 790.9 836.0 851.1 872.7 4435.3 4445.5 4446.9 4464.7 4494.4 5206.6 5232.5 5235.0 5235.4 5239.1 4325.2 4527.6 4532.7 4534.4 4540.9 2744.3 2777.8 2782.5 2799.2 2807.5 4858.1 4976.3 4989.5 4990.7 5008.4 5304.4 5350.5 5353.0 5356.5 5385.8 4898.3 4913.4 4959.0 4966.0 4973.2 5049.7 5192.6 5205.2 5251.6 5253.0 5126.8 5134.5 5137.5 5147.4 5156.7 4897.3 4932.9 4944.7 4947.7 4973.6 3417.4 3621.8 3664.9 3683.6 3692.3 5196.9 5205.9 5214.9 5251.3 5271.4 5042.5 5052.6 5057.8 5085.3 5104.8 4892.2 5089.0 5096.8 5122.5 5130.0 4798.3 4881.3 4969.6 4981.5 5021.7 5093.7 5099.8 5110.9 5114.8 5116.8 5001.3 5002.4 5025.4 5027.4 5028.6 06:11:59 INFO - PROCESS | 9814 | 06:11:59 INFO - PROCESS | 9814 | [#5] yui.html Cycles:180 Average:16076.50 Median:45746.16 stddev:20865.52 (45.6%) stddev-sans-first:20891.85 06:11:59 INFO - PROCESS | 9814 | Values: 637.7 649.9 711.8 722.0 723.9 13453.7 14332.5 14338.1 14342.4 14359.9 12427.9 13935.5 14462.7 14470.2 14966.2 623.3 758.0 788.5 796.6 797.0 756.6 775.9 779.9 785.9 787.6 818.0 819.5 820.1 820.7 820.9 647.1 816.5 817.3 817.5 817.7 572.0 586.4 587.8 590.8 591.4 12912.5 12924.8 12939.7 12966.1 12966.3 12248.3 12603.9 12857.9 13025.2 13386.3 12067.5 12101.0 12123.7 12175.8 12338.3 4149.8 4176.5 4199.0 4235.3 4325.5 66336.7 66399.0 66955.7 67987.0 68364.0 9233.5 10039.2 10102.9 10213.7 10514.4 18567.4 18902.8 18910.1 18955.4 18958.3 6772.6 6827.5 6858.2 7083.7 7149.9 3666.2 3793.6 3804.6 3810.1 3867.3 2646.6 2749.0 2759.8 2761.7 2763.6 495.2 498.5 498.9 502.0 507.3 599.0 600.8 621.0 621.0 634.1 8165.7 8641.4 8662.6 8689.9 8875.6 487.2 496.9 610.9 619.7 632.4 3857.5 3888.3 4118.0 4186.0 4255.7 58124.7 59536.0 78235.2 81507.0 106174.0 45813.0 46275.5 46795.3 58895.4 73887.0 43316.0 43792.6 58122.5 69002.0 69316.7 8506.3 8901.6 9080.3 9135.0 9200.0 39012.6 45649.8 45679.3 46348.0 46450.8 53764.7 54058.9 56253.0 57617.0 60222.7 10888.3 11675.1 11708.4 11791.9 12225.7 12483.4 12753.6 13196.4 13489.9 13529.6 12345.0 12369.2 12519.0 12851.6 13054.3 12396.8 12621.2 12841.5 13078.5 13105.9 11418.8 11764.6 12144.7 12211.9 12241.6 9794.5 9915.0 10113.6 10265.4 10373.2 9393.7 9646.3 10259.7 10562.7 10696.0 06:11:59 INFO - PROCESS | 9814 | -------- Summary: end -------- 06:11:59 INFO - PROCESS | 9814 | 06:12:00 INFO - TEST-INFO | 9814: exit 0 06:12:00 INFO - TEST-OK | dromaeo_css | took 1123069ms 06:12:00 INFO - TEST-START | kraken 06:12:00 INFO - operating with platform_type : linux_ 06:12:00 INFO - Initialising browser for kraken test... 06:12:00 INFO - TEST-INFO | started process 9999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4VXN_/profile http://localhost:47601/getInfo.html) 06:12:05 INFO - PROCESS | 9999 | __metrics Screen width/height:1600/1200 06:12:05 INFO - PROCESS | 9999 | colorDepth:24 06:12:05 INFO - PROCESS | 9999 | Browser inner width/height: 1024/697 06:12:05 INFO - PROCESS | 9999 | __metrics 06:12:07 INFO - PROCESS | 9999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:12:07 INFO - PROCESS | 9999 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:07 INFO - PROCESS | 9999 | console.error: PushService: 06:12:08 INFO - PROCESS | 9999 | stateChangeProcessEnqueue: Error transitioning state 06:12:08 INFO - PROCESS | 9999 | UnknownError 06:12:08 INFO - TEST-INFO | 9999: exit 0 06:12:08 INFO - Browser initialized. 06:12:08 INFO - Running cycle 1/1 for kraken test... 06:12:08 INFO - TEST-INFO | started process 10079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4VXN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:20 INFO - PROCESS | 10079 | RSS: Main: 156475392 06:12:20 INFO - PROCESS | 10079 | 06:12:23 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47601/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:24 INFO - PROCESS | 10079 | RSS: Main: 212819968 06:12:24 INFO - PROCESS | 10079 | 06:12:26 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47601/tests/kraken/driver.html?testName=audio-dft) 06:12:27 INFO - PROCESS | 10079 | RSS: Main: 191598592 06:12:27 INFO - PROCESS | 10079 | 06:12:30 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47601/tests/kraken/driver.html?testName=audio-fft) 06:12:31 INFO - PROCESS | 10079 | RSS: Main: 271925248 06:12:31 INFO - PROCESS | 10079 | 06:12:33 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47601/tests/kraken/driver.html?testName=audio-oscillator) 06:12:34 INFO - PROCESS | 10079 | RSS: Main: 179744768 06:12:34 INFO - PROCESS | 10079 | 06:12:36 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47601/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:36 INFO - PROCESS | 10079 | RSS: Main: 184459264 06:12:36 INFO - PROCESS | 10079 | 06:12:40 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47601/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:40 INFO - PROCESS | 10079 | RSS: Main: 220377088 06:12:40 INFO - PROCESS | 10079 | 06:12:44 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47601/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:44 INFO - PROCESS | 10079 | RSS: Main: 214536192 06:12:44 INFO - PROCESS | 10079 | 06:12:47 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47601/tests/kraken/driver.html?testName=json-parse-financial) 06:12:48 INFO - PROCESS | 10079 | RSS: Main: 217358336 06:12:48 INFO - PROCESS | 10079 | 06:12:50 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47601/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:50 INFO - PROCESS | 10079 | RSS: Main: 183123968 06:12:50 INFO - PROCESS | 10079 | 06:12:52 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:53 INFO - PROCESS | 10079 | RSS: Main: 189444096 06:12:53 INFO - PROCESS | 10079 | 06:12:55 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:55 INFO - PROCESS | 10079 | RSS: Main: 193622016 06:12:55 INFO - PROCESS | 10079 | 06:12:58 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:59 INFO - PROCESS | 10079 | RSS: Main: 187985920 06:12:59 INFO - PROCESS | 10079 | 06:13:02 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:02 INFO - PROCESS | 10079 | RSS: Main: 190431232 06:13:02 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | Cycle 1(1): loaded http://localhost:47601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47601/tests/kraken/driver.html?testName=ai-astar) 06:13:04 INFO - PROCESS | 10079 | RSS: Main: 242839552 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | __start_tp_report 06:13:04 INFO - PROCESS | 10079 | _x_x_mozilla_page_load 06:13:04 INFO - PROCESS | 10079 | _x_x_mozilla_page_load_details 06:13:04 INFO - PROCESS | 10079 | |i|pagename|runs| 06:13:04 INFO - PROCESS | 10079 | |0;ai-astar;105;115;114;114;116;115;113;114;113;115 06:13:04 INFO - PROCESS | 10079 | |1;audio-beat-detection;158;121;126;189;121;123;147;127;186;124 06:13:04 INFO - PROCESS | 10079 | |2;audio-dft;162;163;162;161;160;161;163;162;160;161 06:13:04 INFO - PROCESS | 10079 | |3;audio-fft;76;76;76;108;76;76;77;76;105;76 06:13:04 INFO - PROCESS | 10079 | |4;audio-oscillator;86;86;130;86;87;86;120;87;86;114 06:13:04 INFO - PROCESS | 10079 | |5;imaging-gaussian-blur;117;117;117;116;118;117;117;117;118;117 06:13:04 INFO - PROCESS | 10079 | |6;imaging-darkroom;146;147;146;146;148;147;145;146;146;146 06:13:04 INFO - PROCESS | 10079 | |7;imaging-desaturate;95;95;94;95;94;95;94;95;95;95 06:13:04 INFO - PROCESS | 10079 | |8;json-parse-financial;65;63;62;63;62;61;64;62;64;63 06:13:04 INFO - PROCESS | 10079 | |9;json-stringify-tinderbox;65;66;66;66;67;66;65;66;66;67 06:13:04 INFO - PROCESS | 10079 | |10;stanford-crypto-aes;81;79;79;79;80;79;88;84;80;78 06:13:04 INFO - PROCESS | 10079 | |11;stanford-crypto-ccm;139;132;132;137;140;130;141;129;158;138 06:13:04 INFO - PROCESS | 10079 | |12;stanford-crypto-pbkdf2;166;168;165;168;167;166;164;165;169;165 06:13:04 INFO - PROCESS | 10079 | |13;stanford-crypto-sha256-iterative;68;68;66;66;67;66;66;66;66;66 06:13:04 INFO - PROCESS | 10079 | __end_tp_report 06:13:04 INFO - PROCESS | 10079 | __start_cc_report 06:13:04 INFO - PROCESS | 10079 | _x_x_mozilla_cycle_collect,1938 06:13:04 INFO - PROCESS | 10079 | __end_cc_report 06:13:04 INFO - PROCESS | 10079 | __startTimestamp1470921184844__endTimestamp 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | ------- Summary: start ------- 06:13:04 INFO - PROCESS | 10079 | Number of tests: 14 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.10 (2.7%) stddev-sans-first:1.00 06:13:04 INFO - PROCESS | 10079 | Values: 105.0 115.0 114.0 114.0 116.0 115.0 113.0 114.0 113.0 115.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:137.00 stddev:26.82 (19.6%) stddev-sans-first:27.83 06:13:04 INFO - PROCESS | 10079 | Values: 158.0 121.0 126.0 189.0 121.0 123.0 147.0 127.0 186.0 124.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 06:13:04 INFO - PROCESS | 10079 | Values: 162.0 163.0 162.0 161.0 160.0 161.0 163.0 162.0 160.0 161.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:12.83 (16.9%) stddev-sans-first:13.41 06:13:04 INFO - PROCESS | 10079 | Values: 76.0 76.0 76.0 108.0 76.0 76.0 77.0 76.0 105.0 76.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:86.00 stddev:17.36 (20.2%) stddev-sans-first:17.97 06:13:04 INFO - PROCESS | 10079 | Values: 86.0 86.0 130.0 86.0 87.0 86.0 120.0 87.0 86.0 114.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:13:04 INFO - PROCESS | 10079 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 118.0 117.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:13:04 INFO - PROCESS | 10079 | Values: 146.0 147.0 146.0 146.0 148.0 147.0 145.0 146.0 146.0 146.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:13:04 INFO - PROCESS | 10079 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.00 06:13:04 INFO - PROCESS | 10079 | Values: 65.0 63.0 62.0 63.0 62.0 61.0 64.0 62.0 64.0 63.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 06:13:04 INFO - PROCESS | 10079 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 66.0 67.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.06 (3.8%) stddev-sans-first:3.24 06:13:04 INFO - PROCESS | 10079 | Values: 81.0 79.0 79.0 79.0 80.0 79.0 88.0 84.0 80.0 78.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.50 stddev:8.37 (6.0%) stddev-sans-first:8.86 06:13:04 INFO - PROCESS | 10079 | Values: 139.0 132.0 132.0 137.0 140.0 130.0 141.0 129.0 158.0 138.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:1.64 (1.0%) stddev-sans-first:1.73 06:13:04 INFO - PROCESS | 10079 | Values: 166.0 168.0 165.0 168.0 167.0 166.0 164.0 165.0 169.0 165.0 06:13:04 INFO - PROCESS | 10079 | 06:13:04 INFO - PROCESS | 10079 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 06:13:04 INFO - PROCESS | 10079 | Values: 68.0 68.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 06:13:04 INFO - PROCESS | 10079 | -------- Summary: end -------- 06:13:04 INFO - PROCESS | 10079 | 06:13:06 INFO - TEST-INFO | 10079: exit 0 06:13:06 INFO - TEST-OK | kraken | took 65937ms 06:13:06 INFO - SUITE-END | took 1189s 06:13:06 INFO - Completed test suite (00:19:49) 06:13:06 INFO - javascript benchmark 06:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.960625590616, 2640.0627777139116, 2666.6000099985, 2691.798115141365, 2711.5254830404688, 4626.65300102492, 4673.135469938055, 4798.184308667526, 4870.853874383765, 4885.755712214393, 4820.3733514643045, 4851.0, 4855.684380515273, 4897.412310522734, 4926.630502712302, 4340.8697739067875, 4426.601605855472, 4451.799669014886, 4496.437945256843, 4572.748498832563, 4484.394606728099, 4514.458265008204, 4530.365748795171, 4541.977290113561, 4551.522090180533, 4289.077848262638, 4334.32817913224, 4337.154254920292, 4383.364412160219, 4392.736435813861, 4323.07053983392, 4344.391785150082, 4384.539623339567, 4422.5577442255835, 4461.196984542781, 4307.052448461333, 4360.324149756792, 4368.803403846835, 4370.781460926941, 4423.535528769497, 4762.452317983407, 4767.189577771753, 4773.140834649762, 4827.396575428072, 4830.0, 4898.485659005824, 5061.114304996611, 5117.002184574009, 5127.692338459704, 5201.791928322863, 5161.148410512261, 5189.0, 5224.582033437316, 5229.477052294778, 5289.0, 4617.353570500132, 4926.75366231687, 4927.679700819435, 4929.309896614477, 4930.926036109461, 5133.255677926754, 5252.763625636855, 5309.522143007148, 5311.973440132774, 5383.596230282745, 5131.281620573122, 5172.7413629319135, 5174.24973378858, 5181.0, 5183.50756678115, 4962.925556116661, 5213.322268105122, 5262.315898933114, 5271.446498117719, 5273.2617433559335, 4970.15507363749, 4999.775010124553, 5038.319826823332, 5071.670341427795, 5122.948770512322, 5063.3923929128005, 5063.746812659352, 5074.08666440037, 5075.467075957045, 5123.052235336475, 4184.560621134798, 4283.079137985348, 4286.61420472159, 4289.506706728766, 4333.7833108345085, 3692.3722967095123, 3785.432185172246, 3791.2227993261317, 3806.7715937043868, 3888.2806680764147, 4467.776611169428, 4493.393391892053, 4495.910081798345, 4499.752513611783, 4538.319252112209, 5222.268882356473, 5227.817026404057, 5229.267902493654, 5229.555487783505, 5270.393904700932, 4302.7848607569495, 4374.58441448062, 4410.316400957857, 4415.558444155623, 4481.170983368087, 4567.954320456819, 4600.0, 4602.171609110393, 4602.7468489233415, 4636.026434448736, 4810.975945120252, 4839.685420447659, 4857.465678775332, 4866.270059491105, 4913.508649135058, 4989.201727723546, 5077.974610126926, 5114.181730923035, 5124.487551244845, 5199.090159222196, 4830.2513110467935, 4848.95151048485, 4865.051314993542, 4873.244647079709, 4919.286703428054, 5066.138756411346, 5072.163093089599, 5073.746312684425, 5078.238264260391, 5125.513076257749, 4948.455669876239, 5030.0, 5064.670796398223, 5083.5678967288195, 5141.305923700253, 4967.975160124176, 4972.179590367694, 4982.6512144149565, 4983.775730092082, 5009.77456014473, 4902.558769710743, 4944.0, 4963.627727920492, 4965.1807451770055, 5002.474740152232, 4716.268978308368, 4857.441394239708, 4910.950890491049, 4921.31101645777, 4977.402711674622, 5047.369078865142, 5054.09026375256, 5056.115179843586, 5058.038972595195, 5115.897682046264, 4723.385959825201, 4959.578435832995, 4967.205247160437, 4969.875753106201, 4970.155073637563], "value": 4715.034411002334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.6328749600256, 581.4737662415513, 584.1034012790368, 584.3221862639339, 586.8826234753051, 28551.857240713794, 39649.20701585967, 40792.592074079286, 40850.7957460213, 44260.3360949586, 40289.0, 40642.59357406425, 40654.18691626166, 40670.0, 40999.79500102503, 7277.090363704537, 7576.090869095702, 7785.961070194669, 7813.453058285922, 7814.765557033298, 7187.7843664690145, 7438.404927605806, 7438.77683669488, 9791.216702663805, 10074.546645400938, 9938.950305248463, 9993.950030249838, 9997.750056248615, 10011.299209055369, 10027.097561219489, 9991.300608957376, 10042.548085336177, 10044.648437304731, 10050.597976080948, 10054.64808731691, 9874.60501579936, 9922.553485093189, 9932.553035113437, 9938.204943604494, 9968.700938971842, 38059.61940380588, 38383.80808095942, 38387.8080609598, 38423.0, 38484.0, 3104.6584875663657, 3175.3014336846086, 3323.6510166432417, 3473.600535938349, 3484.181217413906, 28961.56557651637, 29223.97716079927, 29497.26256843596, 29522.852385737933, 30675.846620766977, 3267.8856240031487, 3278.8196649184283, 3316.651751566099, 3350.977951724723, 3442.4492081266876, 248761.0, 249636.0, 249787.0, 249986.0, 250058.0, 29087.0, 55614.721926390106, 55703.721481392335, 56163.438365615824, 56254.0, 30978.225544361572, 32703.0, 32744.672553274162, 32777.18057048593, 32871.3425731484, 13456.46174153023, 13715.177089374669, 13749.037567370187, 13754.65613359674, 13800.0, 11226.887731122748, 11381.089512838953, 11418.257813242113, 11419.31484110956, 11461.140414468948, 7302.306280903305, 7478.663460144307, 7484.476086673881, 7619.771406857803, 7723.691052357955, 3078.3073808392933, 3078.5228289615147, 3124.3438877835456, 3146.1505393543616, 3164.715175634204, 876.1632640828121, 894.8523493623479, 926.249737712455, 926.9988412514468, 1044.1072882685194, 28575.14261572991, 29226.707732922823, 29441.411171776872, 29748.40503189924, 29853.253668658457, 961.3654987708079, 978.882534095913, 1061.7398737309409, 1062.3307316390778, 1106.1095817866533, 14781.187034712979, 15433.45982890616, 15455.077756716406, 15582.9220853895, 15835.287412066255, 396028.0, 398365.0, 401442.0, 402937.0, 403437.0, 43815.12369752587, 49029.75485122623, 49928.75035624798, 50152.49847501551, 50843.74578127086, 1137.5449820071872, 1151.6257216404535, 1159.8260260960924, 1169.5323862843854, 1172.9472173752201, 28067.0, 29303.70696293095, 29665.851670741507, 30401.543976840807, 30465.0, 43979.560204398826, 44314.77842610766, 44340.0, 44345.0, 44385.0, 403286.0, 418473.0, 420480.0, 666945.0, 668214.0, 39862.800685996386, 40143.0, 40479.0, 40527.59472405238, 40893.59106409017, 42630.57369426266, 42777.0, 42997.0, 43347.349789752545, 43770.56229437665, 37191.25617487581, 37312.626873732, 37322.253554929295, 37653.05867353338, 38650.22699546049, 36340.0, 36772.81613591915, 37267.48202225375, 37948.430773538974, 38463.807680961414, 36839.0, 37277.0, 37695.623043770305, 37948.62051379451, 37997.24005519819, 31900.840495797373, 33442.16394590155, 34011.82994085014, 34036.0, 34216.657833422345, 25243.368915777253, 26060.478790423706, 26359.34101647474, 26476.602850957635, 26559.203223903314], "value": 17526.902091197113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.69024497462334, 355.6941030713586, 359.9820008999549, 363.2335771522088, 381.78047622617004, 12724.0, 13748.0, 13924.791128133085, 17261.223244953977, 17310.307587696476, 15513.0, 16123.677526449464, 16216.918915405406, 16398.098104604243, 16781.24484398202, 4649.721016738989, 4791.137595232856, 4797.496262892399, 4799.0, 4806.3030860525205, 3550.3609350316933, 5128.640995130342, 5309.601779866506, 5387.19192121181, 5443.1835224716215, 5429.267048948381, 5432.864178395552, 5441.455854414567, 5442.047641662713, 5459.071957767169, 5100.795968161269, 5357.678539287635, 5371.597130215249, 5418.539424148952, 5428.4842939920645, 5236.554892834114, 5245.816396426145, 5265.605079619006, 5278.577713782888, 5290.656107353048, 11864.644060678194, 12776.744465110738, 20430.387088387222, 20951.0, 20963.895180524152, 1820.717788742747, 1953.2870502266712, 2135.188628321228, 2349.91903724287, 2369.881505924714, 8763.956180219122, 8923.0, 8951.910480895238, 9082.0, 9526.0, 1642.89321194122, 1689.6282817780068, 1729.3082766893217, 1760.2167035669133, 1795.5421367551191, 65273.0, 67147.66426167838, 67747.32252677459, 68238.65880670564, 68621.0, 9636.132748052709, 9645.71062868115, 9874.753131171634, 9919.107280344804, 10111.292209545261, 12519.93740031294, 13353.0, 13366.866331336756, 13375.866241337657, 13384.063115581816, 7097.858042839114, 7108.822279442952, 7251.56490610565, 7301.269873012762, 7316.6341682915645, 6769.120014398097, 6795.3204679531655, 6957.512974091866, 6974.0, 6992.265812089658, 4038.1318016626565, 4149.734331029004, 4165.16696660663, 4264.722793018444, 4279.379489973936, 1561.4925149326514, 1686.190628498303, 1714.1857617631774, 1770.805211426742, 1793.6681713882713, 703.9296070393023, 822.3380178955879, 844.6916875340579, 885.3359980014989, 955.5508910811907, 16856.74714879278, 17303.30786768515, 17352.39266625662, 17877.553061173316, 17971.640567188584, 842.3724325377633, 867.8090820019586, 875.9080296568768, 887.689308741948, 920.3879420185635, 9547.52262386878, 9941.950290248502, 10002.0, 10101.646442374482, 10154.949225253975, 382641.0, 383338.0, 383972.0, 403388.0, 410004.0, 77536.61231693806, 78970.0, 80469.59765201136, 81319.0, 81992.59003705063, 871.4342679854994, 889.6174644902754, 891.2736120062128, 906.7007887397143, 919.4850883505392, 15199.392024318904, 15320.46378376796, 15590.84409155894, 15892.205389730236, 16374.836251637807, 39042.0, 39092.413613795245, 39226.0, 39805.80097099496, 41186.0, 48237.0, 48615.756921215165, 49097.75451122721, 50513.10889505415, 50684.0, 4688.0, 4984.651074424755, 7371.8157046074275, 7518.398528117628, 7640.617969101634, 11342.546298148312, 11426.0, 12505.937470312954, 12827.615171544869, 12954.093213475344, 10245.897541024495, 10453.68638940833, 10491.108255798343, 10946.56213751473, 11093.944530277297, 9703.0, 9901.603935842486, 9912.950435247778, 10089.142422893843, 10105.141063009727, 10448.895511044791, 10514.369137851754, 10553.102986245947, 10990.911726771888, 11374.43127843621, 7400.481966262525, 7619.923800762143, 7744.070711514429, 7794.181610930771, 7852.0, 10689.572417103229, 10840.403777792297, 10986.670399887696, 11045.171612128961, 11084.111310144526], "value": 8086.398875139815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.3138583629432, 1401.3273628658244, 1425.2018869433118, 1629.1446990330082, 1666.4500714764129, 7278.526895751773, 7910.564918929456, 7911.208879112086, 7912.525248485095, 7913.643886025128, 6483.254425741041, 7379.298966598165, 7574.545527268354, 7617.23827617238, 7718.884216736739, 2159.5896779611903, 2186.9015894284717, 2192.0574153114153, 2198.373463562885, 2200.2299195281685, 2141.518158414352, 2173.7717539658347, 2176.85850419723, 2199.747029091651, 2204.47092697753, 1763.303495119427, 2020.605981833543, 2091.717618121557, 2106.5997460482536, 2128.5849259394427, 2119.2370746531237, 2119.8304135669187, 2139.9251026214006, 2141.1221399226242, 2143.485563464773, 2161.2003558683386, 2167.382296045635, 2167.5556510915226, 2168.035224325176, 2168.0894024509585, 7587.886181707278, 7662.885056724153, 7674.270944260286, 7675.078990521118, 7675.462717609769, 4383.342498625232, 4455.866324010285, 4509.1883460977015, 4511.187986162489, 4512.4133862597655, 2841.531147360683, 2898.4927637663322, 2914.825110493356, 2933.1347252560545, 2953.2173973896934, 901.0989010989011, 960.6061514778977, 973.4889183178817, 981.0679854138525, 993.1359717046216, 10359.067683908484, 10368.170546356348, 10395.116415104725, 10395.740106497247, 10398.324108932895, 3658.341498530237, 3829.310724069694, 3977.5226972763453, 3980.5820388859333, 4000.0399904023407, 8890.377673562789, 8892.510911899908, 8920.776980575407, 8922.375433719708, 8942.150495702897, 4472.262076757299, 4478.910421791611, 4493.236149854467, 4500.954990450119, 4501.504834468205, 4015.859444919414, 4031.5766844481495, 4043.3934909763184, 4052.0477687743355, 4052.068024354415, 3556.804375759358, 3599.1002249437643, 3662.432322989941, 3700.2784457031157, 3700.648438398348, 1098.0940723902813, 1160.3154139057997, 1164.574930150506, 1175.61204802415, 1176.1590462819127, 592.4756590417511, 778.8636988526985, 817.7832874288318, 843.35904712419, 853.8763313989914, 4998.400191976913, 5384.703841288689, 5516.14499752539, 5518.944810551843, 5594.468525490072, 853.8761879527434, 870.6865528409768, 884.5311984648147, 921.5898924978454, 941.8587211918131, 3627.365211088049, 3683.3676504232376, 3684.852605895734, 3703.814809259526, 3738.476613274144, 9200.723978280663, 9516.429014259167, 9532.90467095334, 9538.14156725898, 9542.141207291377, 9431.15119639222, 9480.573374198178, 9502.524873756285, 9505.0, 9526.428414295164, 7395.4083673306, 7537.773866784005, 7546.1321947976685, 7560.0, 7560.773176804704, 5065.56942659878, 5148.30497882781, 5155.2782610433815, 5201.0, 5312.4156342803035, 8829.955850220707, 8861.379703420698, 8947.731568052968, 8964.641414343354, 9004.774880627774, 8243.381746368927, 8668.219860212612, 8689.0, 8901.376903616685, 8988.235999940078, 6335.746570137143, 6512.674366281762, 6513.772017979348, 6519.608823470607, 6525.249596296487, 7208.495405321787, 7279.8180045497165, 7281.235470275545, 7281.672324745293, 7282.708691652275, 6443.323451037761, 6486.870262594816, 6511.641859697762, 6528.640924749185, 6753.223379311442, 6084.90872636902, 6171.290301615371, 6197.0, 6310.0, 6389.201349831271, 5994.681170142736, 6102.9694851525455, 6106.755729770759, 6112.205413296243, 6114.296855861633, 4583.74789386587, 4782.473927868002, 4809.062232864558, 4839.540243676845, 4841.346418233494, 4621.861344159681, 4743.549362810528, 4743.928841067456, 4772.880677982939, 4986.6010719143105], "value": 4084.7384087808946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.7901573819635, 284.1688062417429, 285.15167377053257, 291.16710308607315, 298.1487852182019, 4691.132140554, 4780.928286075712, 4792.233242681172, 4862.343583616215, 4873.975630121853, 4656.79044443, 4746.738929358884, 4751.434225518225, 4788.20994535902, 4795.616350691945, 3810.771353718772, 3826.9808650956775, 3829.5596006459195, 3840.5391353037535, 3848.134169811784, 3630.2739452109686, 3641.7997010164563, 3833.8083095845095, 3857.286402015636, 3869.1814847021997, 3758.9325870771104, 3792.677622402099, 3800.1639639279315, 3812.90467738306, 3837.6546110850018, 3813.771173729585, 3814.1227517670955, 3831.1571454280015, 3842.1931394407206, 3854.2484215578115, 3392.9830350848333, 3395.9320813583836, 3400.60892997306, 3401.506781516691, 3412.419888618916, 4568.223402021665, 4692.41344831896, 4700.694454860423, 4730.455997560291, 4799.3041009053495, 4289.6997210195295, 4324.351347297899, 4329.805158767863, 4334.111507141029, 4341.2836881914445, 4987.177115775893, 4987.47631498691, 4994.300797888299, 5012.122878496249, 5015.874603134915, 3374.5444365010653, 3572.464130380438, 3658.8536458541626, 3679.1721862580707, 3705.1292946157632, 5235.136202526579, 5264.631475796696, 5268.236105764643, 5268.604854635918, 5275.781773118395, 3660.0, 3667.001484191122, 3671.100580357776, 3680.5399325084363, 3694.815259237081, 3732.1789206374556, 3735.34631439497, 3744.831482583236, 3747.3442147624055, 3750.8499660013294, 4165.812538435777, 4229.851955181553, 4249.532551419341, 4251.426057482262, 4262.211490874198, 5038.279329162285, 5064.088464076428, 5071.644984851099, 5079.415867175322, 5085.974570127126, 1204.4880925606583, 1237.1772771107112, 1238.9442475088642, 1270.1934271737514, 1287.3177216075494, 781.4881252779438, 790.8966991047456, 835.9592307577105, 851.1445996773203, 872.7294538693026, 4435.3125265583885, 4445.533219012022, 4446.866594002185, 4464.687471876938, 4494.415725955605, 5206.609504287194, 5232.488405565274, 5234.973825130926, 5235.424103348629, 5239.1093514102695, 4325.243082460557, 4527.569880861313, 4532.660050496226, 4534.433195850519, 4540.909181816345, 2744.300203448108, 2777.750012494386, 2782.526970415034, 2799.188235411708, 2807.4806160860308, 4858.1012512685265, 4976.253561965734, 4989.525995030466, 4990.72551009698, 5008.398992120969, 5304.443033481429, 5350.545203657655, 5352.973235133877, 5356.464353564613, 5385.784568617211, 4898.338724272177, 4913.361263035782, 4959.0, 4965.963954778524, 4973.204287314013, 5049.722265275445, 5192.584593232456, 5205.167173252262, 5251.579873610179, 5253.0, 5126.769295381642, 5134.486551344985, 5137.51193636604, 5147.40804807452, 5156.7421628917655, 4897.2654101885, 4932.901341973212, 4944.728039957837, 4947.703137811743, 4973.602111831117, 3417.384870723194, 3621.8370173341737, 3664.8900532984053, 3683.631636836295, 3692.335379631692, 5196.870078248074, 5205.895882082413, 5214.921776173436, 5251.264822924717, 5271.367435907716, 5042.512458824583, 5052.621053421081, 5057.772400242072, 5085.288059671575, 5104.821331253388, 4892.168331383602, 5089.0, 5096.821611243588, 5122.46214147524, 5130.024940397899, 4798.328234047306, 4881.267809828412, 4969.627277954096, 4981.488050924017, 5021.6735912165595, 5093.682374519511, 5099.821506247264, 5110.897782044412, 5114.846554603368, 5116.820911268237, 5001.299818025552, 5002.449730529566, 5025.422076461107, 5027.446980832033, 5028.64799464034], "value": 3813.8830033337217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.6620391192668, 649.9470857211319, 711.7864640607817, 721.9675114619841, 723.9239879812623, 13453.730925381487, 14332.498362557313, 14338.139711617285, 14342.354594043267, 14359.92820035901, 12427.937860310709, 13935.512257071005, 14462.710745785103, 14470.204138772364, 14966.17686027268, 623.3486007122568, 757.9621018949044, 788.45202584204, 796.5817945578559, 797.0156856282515, 756.5687558091889, 775.9262870027338, 779.9337056350189, 785.8899754034439, 787.6416230615085, 818.0428898189103, 819.5328662662284, 820.1347578304886, 820.6922404098464, 820.8932838730957, 647.119916912998, 816.5345752920838, 817.3012074676155, 817.452306954342, 817.7219745286601, 571.9656820590778, 586.4018700925033, 587.7854583077188, 590.8375196820866, 591.3760982163816, 12912.548060817826, 12924.806127908088, 12939.741205175938, 12966.092373533857, 12966.286854223014, 12248.265104093694, 12603.936980315131, 12857.871421285761, 13025.153365031243, 13386.330683465787, 12067.456964436622, 12101.0, 12123.696907577381, 12175.756484870253, 12338.259704417764, 4149.771762553059, 4176.519700234481, 4198.958010419918, 4235.322348424237, 4325.4593175853015, 66336.66831665907, 66399.0, 66955.66522167358, 67987.0, 68364.0, 9233.492157931378, 10039.196864250842, 10102.898971010343, 10213.693589192188, 10514.421706806046, 18567.44297671072, 18902.81097189038, 18910.05449727508, 18955.431337059912, 18958.336458223897, 6772.577758670635, 6827.52207345481, 6858.177018757781, 7083.716651333889, 7149.92850071503, 3666.156783939709, 3793.6206379361843, 3804.562475315319, 3810.0855794609647, 3867.303885300673, 2646.5765477523887, 2748.9725102749117, 2759.8344099354103, 2761.737634924679, 2763.557830747071, 495.1953076251092, 498.521419437337, 498.8727874392007, 501.9899602007939, 507.2619338861947, 598.9727617136632, 600.8167508909737, 620.9511299519338, 620.9844753881189, 634.1312402009277, 8165.730687632597, 8641.395102342776, 8662.6101825418, 8689.913100869036, 8875.644974201088, 487.2496355612388, 496.85342823867046, 610.860178681577, 619.7149311316845, 632.3929028133044, 3857.5370955485523, 3888.2806680764147, 4117.958820411817, 4185.979070104691, 4255.680823938217, 58124.70937645369, 59536.0, 78235.21764782393, 81507.0, 106174.0, 45813.0, 46275.53724462712, 46795.29807052897, 58895.41104588985, 73887.0, 43316.0, 43792.562074379486, 58122.54693632693, 69002.0, 69316.65341673259, 8506.319494440553, 8901.643934242817, 9080.318976076689, 9135.0, 9200.0, 39012.609873900896, 45649.77175114103, 45679.31481027721, 46348.0, 46450.76774616105, 53764.73117634387, 54058.91882162256, 56253.0, 57617.0, 60222.69888650704, 10888.346699198073, 11675.134451907043, 11708.414579271173, 11791.88208117908, 12225.694357640774, 12483.375831208585, 12753.553625623059, 13196.406161722938, 13489.865101348862, 13529.59411217665, 12344.95067919201, 12369.190157443098, 12518.99848012175, 12851.550195743104, 13054.34728263602, 12396.752064958831, 12621.242725436503, 12841.486340546273, 13078.476860925457, 13105.934470327587, 11418.771624567296, 11764.58823941158, 12144.696382590153, 12211.877881221075, 12241.632751017483, 9794.461304628314, 9914.950425247827, 10113.64602238918, 10265.384076955406, 10373.170146388422, 9393.718188454357, 9646.276529260474, 10259.7435064124, 10562.71893865997, 10696.0], "value": 6543.0228615986, "unit": "score"}], "name": "dromaeo_css", "value": 6390.734485439896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 116.0, 115.0, 113.0, 114.0, 113.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 126.0, 189.0, 121.0, 123.0, 147.0, 127.0, 186.0, 124.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 108.0, 76.0, 76.0, 77.0, 76.0, 105.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 130.0, 86.0, 87.0, 86.0, 120.0, 87.0, 86.0, 114.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 63.0, 62.0, 61.0, 64.0, 62.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 79.0, 80.0, 79.0, 88.0, 84.0, 80.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 132.0, 137.0, 140.0, 130.0, 141.0, 129.0, 158.0, 138.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 165.0, 168.0, 167.0, 166.0, 164.0, 165.0, 169.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1534.1999999999998, "alertThreshold": 2.0}]} 06:13:06 INFO - Return code: 0 06:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:06 INFO - # TBPL SUCCESS # 06:13:06 INFO - Running post-action listener: _resource_record_post_action 06:13:06 INFO - [mozharness: 2016-08-11 13:13:06.630779Z] Finished run-tests step (success) 06:13:06 INFO - Running post-run listener: _resource_record_post_run 06:13:06 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550092800; Read time: 28; Write time: 2011908 06:13:06 INFO - TinderboxPrint: CPU usage
13.1% 06:13:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 06:13:06 INFO - TinderboxPrint: I/O write bytes / time
550,092,800 / 2,011,908 06:13:06 INFO - TinderboxPrint: CPU idle
8,372.4 (86.8%) 06:13:06 INFO - TinderboxPrint: CPU user
1,199.9 (12.4%) 06:13:06 INFO - TinderboxPrint: Swap in / out
0 / 0 06:13:06 INFO - install - Wall time: 18s; CPU: 21.0%; Read bytes: 0; Write bytes: 218042368; Read time: 0; Write time: 1126992 06:13:06 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304455680; Read time: 28; Write time: 619684 06:13:07 INFO - Running post-run listener: _upload_blobber_files 06:13:07 INFO - Blob upload gear active. 06:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:07 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 06:13:07 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'] 06:13:07 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 06:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:10 INFO - (blobuploader) - INFO - Done attempting. 06:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:11 INFO - (blobuploader) - INFO - Done attempting. 06:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:12 INFO - (blobuploader) - INFO - Done attempting. 06:13:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:12 INFO - Return code: 0 06:13:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aab8862a79d310775a0f05909988f62c3c7583f6766b0db588a0b91cd043161aec3b122df75649d64ef58191416d493675cc65cf85fecf47aa6c227331640473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74770d23ca4c70079f4e36381fd7260acdf8999d11114d5ae94aed977b4335854596bdc874b192b01e0211651a762d8124997691a10594cd156b543d3e2603b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683c0d258e30374b299b6a47abf8be378b87f0e270093d6c002157ba9e7e06357cf9012bf38a862108c602e4ed28b3d4cb04d01213fec1c107a11b3944b7a06e"} 06:13:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:12 INFO - Contents: 06:13:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aab8862a79d310775a0f05909988f62c3c7583f6766b0db588a0b91cd043161aec3b122df75649d64ef58191416d493675cc65cf85fecf47aa6c227331640473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74770d23ca4c70079f4e36381fd7260acdf8999d11114d5ae94aed977b4335854596bdc874b192b01e0211651a762d8124997691a10594cd156b543d3e2603b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683c0d258e30374b299b6a47abf8be378b87f0e270093d6c002157ba9e7e06357cf9012bf38a862108c602e4ed28b3d4cb04d01213fec1c107a11b3944b7a06e"} 06:13:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:12 INFO - Copying logs to upload dir... 06:13:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.514721 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-11 06:13:11.976990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 06:13:11.980673) ========= 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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 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/aab8862a79d310775a0f05909988f62c3c7583f6766b0db588a0b91cd043161aec3b122df75649d64ef58191416d493675cc65cf85fecf47aa6c227331640473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74770d23ca4c70079f4e36381fd7260acdf8999d11114d5ae94aed977b4335854596bdc874b192b01e0211651a762d8124997691a10594cd156b543d3e2603b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683c0d258e30374b299b6a47abf8be378b87f0e270093d6c002157ba9e7e06357cf9012bf38a862108c602e4ed28b3d4cb04d01213fec1c107a11b3944b7a06e"} build_url:https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/a7O1L4D2RuqDgASLB7oAdw/artifacts/public/build/firefox-51.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/aab8862a79d310775a0f05909988f62c3c7583f6766b0db588a0b91cd043161aec3b122df75649d64ef58191416d493675cc65cf85fecf47aa6c227331640473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74770d23ca4c70079f4e36381fd7260acdf8999d11114d5ae94aed977b4335854596bdc874b192b01e0211651a762d8124997691a10594cd156b543d3e2603b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683c0d258e30374b299b6a47abf8be378b87f0e270093d6c002157ba9e7e06357cf9012bf38a862108c602e4ed28b3d4cb04d01213fec1c107a11b3944b7a06e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 06:13:12.008253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:13:12.008694) ========= 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=df17445c3590ff7897617a0e00000225-1470917742.345943-543004227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:13:12.095230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 06:13:12.095958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 06:13:12.096612) ========= ========= Total master_lag: 0.18 =========