builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1482940925.17 results: success (0) buildid: 20161228065236 builduid: 06f5df09a87546619a8ebab12ce0629e revision: a6d29e9432f5f88a941c0ea5284cb082f34bd097 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.171131) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.172314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.173087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.189808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.190587) ========= 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=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-28 08:02:06-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-12-28 08:02:07 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.325713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.326080) ========= 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=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022064 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.379591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:05.379975) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6d29e9432f5f88a941c0ea5284cb082f34bd097 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a6d29e9432f5f88a941c0ea5284cb082f34bd097 --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=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-28 08:02:07,142 truncating revision to first 12 chars 2016-12-28 08:02:07,142 Setting DEBUG logging. 2016-12-28 08:02:07,143 attempt 1/10 2016-12-28 08:02:07,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6d29e9432f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-28 08:02:07,451 unpacking tar archive at: mozilla-central-a6d29e9432f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:06.042937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:06.043722) ========= script_repo_revision: a6d29e9432f5f88a941c0ea5284cb082f34bd097 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:06.044856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:06.045613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 08:02:06.059139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-28 08:02:06.062217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:02:07 INFO - MultiFileLogger online at 20161228 08:02:07 in /builds/slave/test 08:02:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:02:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:07 INFO - {'append_to_log': False, 08:02:07 INFO - 'base_work_dir': '/builds/slave/test', 08:02:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:02:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:07 INFO - 'branch': 'Firefox-Non-PGO', 08:02:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:07 INFO - 'config_files': ('talos/linux_config.py',), 08:02:07 INFO - 'default_actions': ('clobber', 08:02:07 INFO - 'read-buildbot-config', 08:02:07 INFO - 'download-and-extract', 08:02:07 INFO - 'populate-webroot', 08:02:07 INFO - 'create-virtualenv', 08:02:07 INFO - 'install', 08:02:07 INFO - 'run-tests'), 08:02:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:07 INFO - 'download_minidump_stackwalk': True, 08:02:07 INFO - 'download_symbols': 'ondemand', 08:02:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:07 INFO - 'installer_path': 'installer.exe', 08:02:07 INFO - 'log_level': 'info', 08:02:07 INFO - 'log_name': 'talos', 08:02:07 INFO - 'log_to_console': True, 08:02:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:02:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:02:07 INFO - 'opt_config_files': (), 08:02:07 INFO - 'pip_index': False, 08:02:07 INFO - 'sps_profile': False, 08:02:07 INFO - 'sps_profile_interval': 0, 08:02:07 INFO - 'suite': 'dromaeojs-e10s', 08:02:07 INFO - 'system_bits': '32', 08:02:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:07 INFO - 'title': 'talos-linux64-ix-017', 08:02:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:07 INFO - 'use_talos_json': True, 08:02:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:07 INFO - 'work_dir': 'build'} 08:02:07 INFO - [mozharness: 2016-12-28 16:02:07.927110Z] Running clobber step. 08:02:07 INFO - Running pre-action listener: _resource_record_pre_action 08:02:07 INFO - Running main action method: clobber 08:02:07 INFO - rmtree: /builds/slave/test/build 08:02:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:08 INFO - Running post-action listener: _resource_record_post_action 08:02:08 INFO - [mozharness: 2016-12-28 16:02:08.389601Z] Finished clobber step (success) 08:02:08 INFO - [mozharness: 2016-12-28 16:02:08.389703Z] Running read-buildbot-config step. 08:02:08 INFO - Running pre-action listener: _resource_record_pre_action 08:02:08 INFO - Running main action method: read_buildbot_config 08:02:08 INFO - Using buildbot properties: 08:02:08 INFO - { 08:02:08 INFO - "project": "", 08:02:08 INFO - "product": "firefox", 08:02:08 INFO - "script_repo_revision": "production", 08:02:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:02:08 INFO - "repository": "", 08:02:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:02:08 INFO - "buildid": "20161228065236", 08:02:08 INFO - "pgo_build": "False", 08:02:08 INFO - "basedir": "/builds/slave/test", 08:02:08 INFO - "buildnumber": 334, 08:02:08 INFO - "slavename": "talos-linux64-ix-017", 08:02:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:02:08 INFO - "platform": "ubuntu64_hw", 08:02:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:02:08 INFO - "branch": "mozilla-central", 08:02:08 INFO - "repo_path": "mozilla-central", 08:02:08 INFO - "revision": "a6d29e9432f5f88a941c0ea5284cb082f34bd097", 08:02:08 INFO - "stage_platform": "linux64", 08:02:08 INFO - "builduid": "06f5df09a87546619a8ebab12ce0629e", 08:02:08 INFO - "slavebuilddir": "test" 08:02:08 INFO - } 08:02:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:02:08 INFO - Running post-action listener: _resource_record_post_action 08:02:08 INFO - [mozharness: 2016-12-28 16:02:08.392234Z] Finished read-buildbot-config step (success) 08:02:08 INFO - [mozharness: 2016-12-28 16:02:08.392325Z] Running download-and-extract step. 08:02:08 INFO - Running pre-action listener: _resource_record_pre_action 08:02:08 INFO - Running main action method: download_and_extract 08:02:08 INFO - mkdir: /builds/slave/test/build/tests 08:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:08 INFO - trying https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:02:08 INFO - Downloading https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:02:08 INFO - Downloaded 1361 bytes. 08:02:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:02:08 INFO - Using the following test package requirements: 08:02:08 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:08 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:02:08 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:02:08 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'jsshell-linux-x86_64.zip'], 08:02:08 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:02:08 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:08 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:02:08 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:02:08 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:02:08 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:02:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:02:09 INFO - Expected file size: 20241338 08:02:09 INFO - Obtained file size: 20241338 08:02:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:02:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:02:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:13 INFO - Fetch https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:02:14 INFO - Expected file size: 20241338 08:02:14 INFO - Obtained file size: 20241338 08:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:02:19 INFO - Expected file size: 14409776 08:02:19 INFO - Obtained file size: 14409776 08:02:19 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')]} 08:02:19 INFO - trying https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:02:20 INFO - Downloaded 55898882 bytes. 08:02:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:02:20 INFO - mkdir: /builds/slave/test/properties 08:02:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:20 INFO - Contents: 08:02:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:02:21 INFO - Running post-action listener: _resource_record_post_action 08:02:21 INFO - Running post-action listener: set_extra_try_arguments 08:02:21 INFO - [mozharness: 2016-12-28 16:02:21.542950Z] Finished download-and-extract step (success) 08:02:21 INFO - [mozharness: 2016-12-28 16:02:21.543179Z] Running populate-webroot step. 08:02:21 INFO - Running pre-action listener: _resource_record_pre_action 08:02:21 INFO - Running main action method: populate_webroot 08:02:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:21 INFO - '--tppagecycles', 08:02:21 INFO - '7'], 08:02:21 INFO - 'tests': ['tsvgm']}}, 08:02:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['damp', 'tps']}, 08:02:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'tests': ['damp', 'tps']}, 08:02:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['dromaeo_dom']}, 08:02:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['basic_compositor_video']}, 08:02:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tsvgx', 08:02:21 INFO - 'tsvgr_opacity', 08:02:21 INFO - 'tart', 08:02:21 INFO - 'tscrollx', 08:02:21 INFO - 'cart', 08:02:21 INFO - 'tsvg_static']}, 08:02:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:21 INFO - 'tsvgr_opacity', 08:02:21 INFO - 'tart', 08:02:21 INFO - 'tscrollx', 08:02:21 INFO - 'cart', 08:02:21 INFO - 'tsvg_static']}, 08:02:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tp5o']}, 08:02:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:02:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s', 08:02:21 INFO - '--xperf_path', 08:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:21 INFO - 'tests': ['tp5n']}, 08:02:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:02:21 INFO - 'talos_options': ['--xperf_path', 08:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:21 INFO - 'tests': ['tp5n']}}, 08:02:21 INFO - 'talos.zip': {'path': '', 08:02:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:21 INFO - Running post-action listener: _resource_record_post_action 08:02:21 INFO - [mozharness: 2016-12-28 16:02:21.564404Z] Finished populate-webroot step (success) 08:02:21 INFO - [mozharness: 2016-12-28 16:02:21.564493Z] Running create-virtualenv step. 08:02:21 INFO - Running pre-action listener: _resource_record_pre_action 08:02:21 INFO - Running main action method: create_virtualenv 08:02:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:21 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 08:02:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:21 INFO - Using real prefix '/usr' 08:02:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:24 INFO - Installing pip.................done. 08:02:24 INFO - Return code: 0 08:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:24 INFO - Reading from file tmpfile_stdout 08:02:24 INFO - Output received: 08:02:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:02:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:24 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 08:02:24 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 08:02:24 INFO - Using env: {'DISPLAY': ':0', 08:02:24 INFO - 'HOME': '/home/cltbld', 08:02:24 INFO - 'LANG': 'en_US.UTF-8', 08:02:24 INFO - 'LANGUAGE': 'en_US:en', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MAIL': '/var/mail/cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SHLVL': '1', 08:02:24 INFO - 'TERM': 'linux', 08:02:24 INFO - 'TMOUT': '86400', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - '_': '/tools/buildbot/bin/python'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 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 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:24 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 08:02:24 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 08:02:24 INFO - Using env: {'DISPLAY': ':0', 08:02:24 INFO - 'HOME': '/home/cltbld', 08:02:24 INFO - 'LANG': 'en_US.UTF-8', 08:02:24 INFO - 'LANGUAGE': 'en_US:en', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MAIL': '/var/mail/cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SHLVL': '1', 08:02:24 INFO - 'TERM': 'linux', 08:02:24 INFO - 'TMOUT': '86400', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - '_': '/tools/buildbot/bin/python'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 INFO - Downloading/unpacking psutil>=3.1.1 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:26 INFO - Installing collected packages: psutil 08:02:26 INFO - Running setup.py install for psutil 08:02:26 INFO - building 'psutil._psutil_linux' extension 08:02:26 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 08:02:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:02:27 INFO - building 'psutil._psutil_posix' extension 08:02:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:02:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:02:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:27 INFO - Successfully installed psutil 08:02:27 INFO - Cleaning up... 08:02:27 INFO - Return code: 0 08:02:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:27 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:27 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 08:02:27 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 08:02:27 INFO - Using env: {'DISPLAY': ':0', 08:02:27 INFO - 'HOME': '/home/cltbld', 08:02:27 INFO - 'LANG': 'en_US.UTF-8', 08:02:27 INFO - 'LANGUAGE': 'en_US:en', 08:02:27 INFO - 'LOGNAME': 'cltbld', 08:02:27 INFO - 'MAIL': '/var/mail/cltbld', 08:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:27 INFO - 'MOZ_NO_REMOTE': '1', 08:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:27 INFO - 'NO_EM_RESTART': '1', 08:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:27 INFO - 'PWD': '/builds/slave/test', 08:02:27 INFO - 'SHELL': '/bin/bash', 08:02:27 INFO - 'SHLVL': '1', 08:02:27 INFO - 'TERM': 'linux', 08:02:27 INFO - 'TMOUT': '86400', 08:02:27 INFO - 'USER': 'cltbld', 08:02:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:27 INFO - '_': '/tools/buildbot/bin/python'} 08:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:29 INFO - Installing collected packages: mozsystemmonitor 08:02:29 INFO - Running setup.py install for mozsystemmonitor 08:02:29 INFO - Successfully installed mozsystemmonitor 08:02:29 INFO - Cleaning up... 08:02:29 INFO - Return code: 0 08:02:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'DISPLAY': ':0', 08:02:29 INFO - 'HOME': '/home/cltbld', 08:02:29 INFO - 'LANG': 'en_US.UTF-8', 08:02:29 INFO - 'LANGUAGE': 'en_US:en', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MAIL': '/var/mail/cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SHLVL': '1', 08:02:29 INFO - 'TERM': 'linux', 08:02:29 INFO - 'TMOUT': '86400', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - '_': '/tools/buildbot/bin/python'} 08:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:30 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:32 INFO - warning: no files found matching '*.txt' 08:02:32 INFO - no previously-included directories found matching 'build' 08:02:32 INFO - no previously-included directories found matching 'dist' 08:02:32 INFO - no previously-included directories found matching '.git*' 08:02:32 INFO - Installing collected packages: jsonschema, functools32 08:02:32 INFO - Running setup.py install for functools32 08:02:32 INFO - warning: no files found matching '*.txt' 08:02:32 INFO - no previously-included directories found matching 'build' 08:02:32 INFO - no previously-included directories found matching 'dist' 08:02:32 INFO - no previously-included directories found matching '.git*' 08:02:32 INFO - Successfully installed jsonschema functools32 08:02:32 INFO - Cleaning up... 08:02:32 INFO - Return code: 0 08:02:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:32 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:32 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 08:02:32 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 08:02:32 INFO - Using env: {'DISPLAY': ':0', 08:02:32 INFO - 'HOME': '/home/cltbld', 08:02:32 INFO - 'LANG': 'en_US.UTF-8', 08:02:32 INFO - 'LANGUAGE': 'en_US:en', 08:02:32 INFO - 'LOGNAME': 'cltbld', 08:02:32 INFO - 'MAIL': '/var/mail/cltbld', 08:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:32 INFO - 'MOZ_NO_REMOTE': '1', 08:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:32 INFO - 'NO_EM_RESTART': '1', 08:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:32 INFO - 'PWD': '/builds/slave/test', 08:02:32 INFO - 'SHELL': '/bin/bash', 08:02:32 INFO - 'SHLVL': '1', 08:02:32 INFO - 'TERM': 'linux', 08:02:32 INFO - 'TMOUT': '86400', 08:02:32 INFO - 'USER': 'cltbld', 08:02:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:32 INFO - '_': '/tools/buildbot/bin/python'} 08:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:32 INFO - Cleaning up... 08:02:32 INFO - Return code: 0 08:02:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:32 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:32 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 08:02:32 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 08:02:32 INFO - Using env: {'DISPLAY': ':0', 08:02:32 INFO - 'HOME': '/home/cltbld', 08:02:32 INFO - 'LANG': 'en_US.UTF-8', 08:02:32 INFO - 'LANGUAGE': 'en_US:en', 08:02:32 INFO - 'LOGNAME': 'cltbld', 08:02:32 INFO - 'MAIL': '/var/mail/cltbld', 08:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:32 INFO - 'MOZ_NO_REMOTE': '1', 08:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:32 INFO - 'NO_EM_RESTART': '1', 08:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:32 INFO - 'PWD': '/builds/slave/test', 08:02:32 INFO - 'SHELL': '/bin/bash', 08:02:32 INFO - 'SHLVL': '1', 08:02:32 INFO - 'TERM': 'linux', 08:02:32 INFO - 'TMOUT': '86400', 08:02:32 INFO - 'USER': 'cltbld', 08:02:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:32 INFO - '_': '/tools/buildbot/bin/python'} 08:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 INFO - Downloading docopt-0.6.1.tar.gz 08:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:35 INFO - Running setup.py install for blobuploader 08:02:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:35 INFO - Running setup.py install for requests 08:02:36 INFO - Running setup.py install for docopt 08:02:36 INFO - Successfully installed blobuploader requests docopt 08:02:36 INFO - Cleaning up... 08:02:36 INFO - Return code: 0 08:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:36 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:36 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 08:02:36 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 08:02:36 INFO - Using env: {'DISPLAY': ':0', 08:02:36 INFO - 'HOME': '/home/cltbld', 08:02:36 INFO - 'LANG': 'en_US.UTF-8', 08:02:36 INFO - 'LANGUAGE': 'en_US:en', 08:02:36 INFO - 'LOGNAME': 'cltbld', 08:02:36 INFO - 'MAIL': '/var/mail/cltbld', 08:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:36 INFO - 'MOZ_NO_REMOTE': '1', 08:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:36 INFO - 'NO_EM_RESTART': '1', 08:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:36 INFO - 'PWD': '/builds/slave/test', 08:02:36 INFO - 'SHELL': '/bin/bash', 08:02:36 INFO - 'SHLVL': '1', 08:02:36 INFO - 'TERM': 'linux', 08:02:36 INFO - 'TMOUT': '86400', 08:02:36 INFO - 'USER': 'cltbld', 08:02:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:36 INFO - '_': '/tools/buildbot/bin/python'} 08:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:36 INFO - Running setup.py (path:/tmp/pip-SKhUU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:36 INFO - Running setup.py (path:/tmp/pip-3xeB8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:36 INFO - Running setup.py (path:/tmp/pip-sF64Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:36 INFO - Running setup.py (path:/tmp/pip-ynpWOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:36 INFO - Running setup.py (path:/tmp/pip-85Oskx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 INFO - Running setup.py (path:/tmp/pip-N3CUOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 INFO - Running setup.py (path:/tmp/pip-7bJkxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 INFO - Running setup.py (path:/tmp/pip-KLCSTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:37 INFO - Running setup.py (path:/tmp/pip-JLeVp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:37 INFO - Running setup.py (path:/tmp/pip-1YM4tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:37 INFO - Running setup.py (path:/tmp/pip-NxbhUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:37 INFO - Running setup.py (path:/tmp/pip-yDUXF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:37 INFO - Running setup.py (path:/tmp/pip-wjzhyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:37 INFO - Running setup.py (path:/tmp/pip-eMIFjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:37 INFO - Running setup.py (path:/tmp/pip-wdyGmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:37 INFO - Running setup.py (path:/tmp/pip-ep5uvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:37 INFO - Running setup.py (path:/tmp/pip-kzup5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:37 INFO - Running setup.py install for manifestparser 08:02:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozcrash 08:02:38 INFO - Running setup.py install for mozdebug 08:02:38 INFO - Running setup.py install for mozdevice 08:02:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozfile 08:02:38 INFO - Running setup.py install for mozhttpd 08:02:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozinfo 08:02:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozInstall 08:02:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozleak 08:02:38 INFO - Running setup.py install for mozlog 08:02:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for moznetwork 08:02:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozprocess 08:02:39 INFO - Running setup.py install for mozprofile 08:02:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozrunner 08:02:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozscreenshot 08:02:39 INFO - Running setup.py install for moztest 08:02:39 INFO - Running setup.py install for mozversion 08:02:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:39 INFO - Cleaning up... 08:02:39 INFO - Return code: 0 08:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:39 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:39 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 08:02:39 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 08:02:39 INFO - Using env: {'DISPLAY': ':0', 08:02:39 INFO - 'HOME': '/home/cltbld', 08:02:39 INFO - 'LANG': 'en_US.UTF-8', 08:02:39 INFO - 'LANGUAGE': 'en_US:en', 08:02:39 INFO - 'LOGNAME': 'cltbld', 08:02:39 INFO - 'MAIL': '/var/mail/cltbld', 08:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:39 INFO - 'MOZ_NO_REMOTE': '1', 08:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:39 INFO - 'NO_EM_RESTART': '1', 08:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:39 INFO - 'PWD': '/builds/slave/test', 08:02:39 INFO - 'SHELL': '/bin/bash', 08:02:39 INFO - 'SHLVL': '1', 08:02:39 INFO - 'TERM': 'linux', 08:02:39 INFO - 'TMOUT': '86400', 08:02:39 INFO - 'USER': 'cltbld', 08:02:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:39 INFO - '_': '/tools/buildbot/bin/python'} 08:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:39 INFO - Running setup.py (path:/tmp/pip-JTkQBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:39 INFO - Running setup.py (path:/tmp/pip-fHTPST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:40 INFO - Running setup.py (path:/tmp/pip-_bSpiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:40 INFO - Running setup.py (path:/tmp/pip-DlSTxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:40 INFO - Running setup.py (path:/tmp/pip-M1de5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:40 INFO - Running setup.py (path:/tmp/pip-1hxQr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:40 INFO - Running setup.py (path:/tmp/pip-3AwxLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:40 INFO - Running setup.py (path:/tmp/pip-kQeNJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:40 INFO - Running setup.py (path:/tmp/pip-l4M6dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:40 INFO - Running setup.py (path:/tmp/pip-H_0PNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:40 INFO - Running setup.py (path:/tmp/pip-C0_w_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:40 INFO - Running setup.py (path:/tmp/pip-X7xyQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:40 INFO - Running setup.py (path:/tmp/pip-Kf80TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:40 INFO - Running setup.py (path:/tmp/pip-coaEnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:40 INFO - Running setup.py (path:/tmp/pip-oIZqCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:41 INFO - Running setup.py (path:/tmp/pip-amMaFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:41 INFO - Running setup.py (path:/tmp/pip-KOTe07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:41 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)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:41 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)) 08:02:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:43 INFO - Downloading blessings-1.6.tar.gz 08:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:43 INFO - Installing collected packages: blessings 08:02:43 INFO - Running setup.py install for blessings 08:02:43 INFO - Successfully installed blessings 08:02:43 INFO - Cleaning up... 08:02:43 INFO - Return code: 0 08:02:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:43 INFO - Reading from file tmpfile_stdout 08:02:43 INFO - Current package versions: 08:02:43 INFO - argparse == 1.2.1 08:02:43 INFO - blessings == 1.6 08:02:43 INFO - blobuploader == 1.2.4 08:02:43 INFO - docopt == 0.6.1 08:02:43 INFO - functools32 == 3.2.3-2 08:02:43 INFO - jsonschema == 2.5.1 08:02:43 INFO - manifestparser == 1.1 08:02:43 INFO - mozInstall == 1.12 08:02:43 INFO - mozcrash == 1.0 08:02:43 INFO - mozdebug == 0.1 08:02:43 INFO - mozdevice == 0.49 08:02:43 INFO - mozfile == 1.2 08:02:43 INFO - mozhttpd == 0.7 08:02:43 INFO - mozinfo == 0.9 08:02:43 INFO - mozleak == 0.1 08:02:43 INFO - mozlog == 3.4 08:02:43 INFO - moznetwork == 0.27 08:02:43 INFO - mozprocess == 0.23 08:02:43 INFO - mozprofile == 0.28 08:02:43 INFO - mozrunner == 6.13 08:02:43 INFO - mozscreenshot == 0.1 08:02:43 INFO - mozsystemmonitor == 0.3 08:02:43 INFO - moztest == 0.7 08:02:43 INFO - mozversion == 1.4 08:02:43 INFO - psutil == 3.1.1 08:02:43 INFO - requests == 1.2.3 08:02:43 INFO - wsgiref == 0.1.2 08:02:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:43 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')]} 08:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:43 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')]} 08:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:43 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:43 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 08:02:43 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 08:02:43 INFO - Using env: {'DISPLAY': ':0', 08:02:43 INFO - 'HOME': '/home/cltbld', 08:02:43 INFO - 'LANG': 'en_US.UTF-8', 08:02:43 INFO - 'LANGUAGE': 'en_US:en', 08:02:43 INFO - 'LOGNAME': 'cltbld', 08:02:43 INFO - 'MAIL': '/var/mail/cltbld', 08:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:43 INFO - 'MOZ_NO_REMOTE': '1', 08:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:43 INFO - 'NO_EM_RESTART': '1', 08:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:43 INFO - 'PWD': '/builds/slave/test', 08:02:43 INFO - 'SHELL': '/bin/bash', 08:02:43 INFO - 'SHLVL': '1', 08:02:43 INFO - 'TERM': 'linux', 08:02:43 INFO - 'TMOUT': '86400', 08:02:43 INFO - 'USER': 'cltbld', 08:02:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:43 INFO - '_': '/tools/buildbot/bin/python'} 08:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 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)) 08:02:43 INFO - Cleaning up... 08:02:43 INFO - Return code: 0 08:02:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:43 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')]} 08:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:43 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')]} 08:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:43 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 0x17f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1901a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b62480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, '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': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', '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 08:02:43 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 08:02:43 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 08:02:43 INFO - Using env: {'DISPLAY': ':0', 08:02:43 INFO - 'HOME': '/home/cltbld', 08:02:43 INFO - 'LANG': 'en_US.UTF-8', 08:02:43 INFO - 'LANGUAGE': 'en_US:en', 08:02:43 INFO - 'LOGNAME': 'cltbld', 08:02:43 INFO - 'MAIL': '/var/mail/cltbld', 08:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:43 INFO - 'MOZ_NO_REMOTE': '1', 08:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:43 INFO - 'NO_EM_RESTART': '1', 08:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:43 INFO - 'PWD': '/builds/slave/test', 08:02:43 INFO - 'SHELL': '/bin/bash', 08:02:43 INFO - 'SHLVL': '1', 08:02:43 INFO - 'TERM': 'linux', 08:02:43 INFO - 'TMOUT': '86400', 08:02:43 INFO - 'USER': 'cltbld', 08:02:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:43 INFO - '_': '/tools/buildbot/bin/python'} 08:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:44 INFO - Cleaning up... 08:02:44 INFO - Return code: 0 08:02:44 INFO - Running post-action listener: _resource_record_post_action 08:02:44 INFO - Running post-action listener: _start_resource_monitoring 08:02:44 INFO - Starting resource monitoring. 08:02:44 INFO - [mozharness: 2016-12-28 16:02:44.119586Z] Finished create-virtualenv step (success) 08:02:44 INFO - [mozharness: 2016-12-28 16:02:44.120135Z] Running install step. 08:02:44 INFO - Running pre-action listener: _resource_record_pre_action 08:02:44 INFO - Running main action method: install 08:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:44 INFO - Reading from file tmpfile_stdout 08:02:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:44 INFO - Reading from file tmpfile_stdout 08:02:44 INFO - Output received: 08:02:44 INFO - Usage: mozinstall [options] installer 08:02:44 INFO - Options: 08:02:44 INFO - -h, --help show this help message and exit 08:02:44 INFO - -d DEST, --destination=DEST 08:02:44 INFO - Directory to install application into. [default: 08:02:44 INFO - "/builds/slave/test"] 08:02:44 INFO - --app=APP Application being installed. [default: firefox] 08:02:44 INFO - mkdir: /builds/slave/test/build/application 08:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:03:00 INFO - Reading from file tmpfile_stdout 08:03:00 INFO - Output received: 08:03:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:03:00 INFO - Running post-action listener: _resource_record_post_action 08:03:00 INFO - [mozharness: 2016-12-28 16:03:00.482762Z] Finished install step (success) 08:03:00 INFO - [mozharness: 2016-12-28 16:03:00.483096Z] Running run-tests step. 08:03:00 INFO - Running pre-action listener: _resource_record_pre_action 08:03:00 INFO - Running main action method: run_tests 08:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:00 INFO - Python 2.7.3 08:03:00 INFO - Return code: 0 08:03:00 INFO - grabbing minidump binary from tooltool 08:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:00 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 0x1b5f820>, '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 0x1b60520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b609b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:00 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 08:03:00 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 08:03:00 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 08:03:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:00 INFO - Return code: 0 08:03:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:03:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:03:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:03:00 INFO - Using env: {'DISPLAY': ':0', 08:03:00 INFO - 'HOME': '/home/cltbld', 08:03:00 INFO - 'LANG': 'en_US.UTF-8', 08:03:00 INFO - 'LANGUAGE': 'en_US:en', 08:03:00 INFO - 'LOGNAME': 'cltbld', 08:03:00 INFO - 'MAIL': '/var/mail/cltbld', 08:03:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:00 INFO - 'MOZ_NO_REMOTE': '1', 08:03:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:00 INFO - 'NO_EM_RESTART': '1', 08:03:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:00 INFO - 'PWD': '/builds/slave/test', 08:03:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:00 INFO - 'SHELL': '/bin/bash', 08:03:00 INFO - 'SHLVL': '1', 08:03:00 INFO - 'TERM': 'linux', 08:03:00 INFO - 'TMOUT': '86400', 08:03:00 INFO - 'USER': 'cltbld', 08:03:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063', 08:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:00 INFO - '_': '/tools/buildbot/bin/python'} 08:03:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:03:00 INFO - mozversion application_buildid: 20161228065236 08:03:00 INFO - mozversion application_changeset: a6d29e9432f5f88a941c0ea5284cb082f34bd097 08:03:00 INFO - mozversion application_display_name: Nightly 08:03:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:00 INFO - mozversion application_name: Firefox 08:03:00 INFO - mozversion application_remotingname: firefox 08:03:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:03:00 INFO - mozversion application_vendor: Mozilla 08:03:00 INFO - mozversion application_version: 53.0a1 08:03:00 INFO - mozversion platform_buildid: 20161228065236 08:03:00 INFO - mozversion platform_changeset: a6d29e9432f5f88a941c0ea5284cb082f34bd097 08:03:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:03:00 INFO - mozversion platform_version: 53.0a1 08:03:00 INFO - using testdate: 1482940980 08:03:00 INFO - actual date: 1482940980 08:03:00 INFO - starting webserver on 'localhost:58079' 08:03:00 INFO - SUITE-START | Running 2 tests 08:03:00 INFO - TEST-START | dromaeo_css 08:03:00 INFO - operating with platform_type : linux_ 08:03:00 INFO - Initialising browser for dromaeo_css test... 08:03:00 INFO - TEST-INFO | started process 4094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9Ef9j/profile http://localhost:58079/getInfo.html) 08:03:01 INFO - PROCESS | 4094 | 1482940981276 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 08:03:04 INFO - PROCESS | 4094 | __metrics Screen width/height:1600/1200 08:03:04 INFO - PROCESS | 4094 | colorDepth:24 08:03:04 INFO - PROCESS | 4094 | Browser inner width/height: 1024/697 08:03:04 INFO - PROCESS | 4094 | __metrics 08:03:05 ERROR - PROCESS | 4094 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:03:06 INFO - TEST-INFO | 4094: exit 0 08:03:06 INFO - Browser initialized. 08:03:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:06 INFO - TEST-INFO | started process 4214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9Ef9j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:18 INFO - PROCESS | 4214 | RSS: Main: 158015488 08:03:18 INFO - PROCESS | 4214 | 08:06:21 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58079/tests/dromaeo/cssquery-ext.html) 08:06:22 INFO - PROCESS | 4214 | RSS: Main: 166801408 08:06:22 INFO - PROCESS | 4214 | 08:08:06 INFO - PROCESS | 4214 | ************************* 08:08:06 INFO - PROCESS | 4214 | A coding exception was thrown and uncaught in a Task. 08:08:06 INFO - PROCESS | 4214 | 08:08:06 INFO - PROCESS | 4214 | Full message: ReferenceError: fetch is not defined 08:08:06 INFO - PROCESS | 4214 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:08:06 INFO - PROCESS | 4214 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:08:06 INFO - PROCESS | 4214 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:08:06 INFO - PROCESS | 4214 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:08:06 INFO - PROCESS | 4214 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:08:06 INFO - PROCESS | 4214 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:08:06 INFO - PROCESS | 4214 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:08:06 INFO - PROCESS | 4214 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:08:06 INFO - PROCESS | 4214 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:08:06 INFO - PROCESS | 4214 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:08:06 INFO - PROCESS | 4214 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:08:06 INFO - PROCESS | 4214 | 08:08:06 INFO - PROCESS | 4214 | ************************* 08:09:25 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-ext.html (next: http://localhost:58079/tests/dromaeo/cssquery-jquery.html) 08:09:25 INFO - PROCESS | 4214 | RSS: Main: 162156544 08:09:25 INFO - PROCESS | 4214 | 08:12:27 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58079/tests/dromaeo/cssquery-mootools.html) 08:12:28 INFO - PROCESS | 4214 | RSS: Main: 169406464 08:12:28 INFO - PROCESS | 4214 | 08:15:30 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58079/tests/dromaeo/cssquery-prototype.html) 08:15:31 INFO - PROCESS | 4214 | RSS: Main: 164118528 08:15:31 INFO - PROCESS | 4214 | 08:18:34 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58079/tests/dromaeo/cssquery-yui.html) 08:18:35 INFO - PROCESS | 4214 | RSS: Main: 166961152 08:18:35 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-yui.html (next: http://localhost:58079/tests/dromaeo/cssquery-dojo.html) 08:21:38 INFO - PROCESS | 4214 | RSS: Main: 166211584 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | __start_tp_report 08:21:38 INFO - PROCESS | 4214 | _x_x_mozilla_page_load 08:21:38 INFO - PROCESS | 4214 | _x_x_mozilla_page_load_details 08:21:38 INFO - PROCESS | 4214 | |i|pagename|runs| 08:21:38 INFO - PROCESS | 4214 | |0;dojo.html;2570.1390034338497;2577.5489289374377;2579.703334116577;2599.805014623903;2605.1533251693204;4655.4878963314;4791.976040119795;4849.296851956464;4852.636052296074;4853.684510506814;4682.086993036351;4803.231482962727;4837.612990960723;4847.563719265266;4879.560839524442;4384.167008268419;4437.644988400936;4461.866144015685;4512.435945506812;4546.340780586829;4112.177564487115;4556.681032327739;4568.7944042518;4583.175028494869;4593.081383723269;4404.647628189737;4443;4451.465824101097;4489.573490518395;4557.384753058344;4363.083752411997;4373.759443230621;4398.494173170095;4422;4477.507474177838;4363.781810909473;4376.606105450524;4378.387025816388;4384.912301753979;4390.780460976938;4690.742009189493;4701.600363969067;4741.739204343759;4746;4777.235642297216;5002.099622068026;5034.899302013976;5085;5110.437851836295;5112.36095488064;5163;5166.715830629314;5172.482751724835;5173.17229243323;5208.817691380784;4808.704111819264;4827.396575428072;4827.734474603931;4827.806887724451;4882.316475693406;5178.042062218502;5187.066328060985;5191.221316802435;5226.529612334908;5264.710440925709;5000.724960127228;5005.174146265898;5015.924761128586;5038.067957427887;5061.645684802029;5069.746512674352;5072.721000344943;5075.87310317245;5083.313752643419;5125.948740512622;4972.179590367621;4996.1007018736245;5012.624053196025;5037.949620503748;5056.443791182967;5052.242163675478;5142.30578871855;5143.948560514347;5148.485151484896;5151.793928242828;4322.783860806947;4345.826166953287;4349.369341445473;4352.064306174188;4391;3781.697464202857;3784.038256646575;3784.8296826642318;3788.3938569829247;3820.4842346282894;4267.253230684618;4315.503717072577;4320.330348795942;4358.782060897006;4362.062156636339;5186.40356359016;5196.064708352457;5199.350081239845;5201.557867581222;5238.292830467838;4340.631046361032;4357.281048627005;4358.6730995175485;4366.061296821199;4402.5597440255715;4533.433320834895;4564.954350456519;4590.563896429834;4610.193216187154;4633.189191891405;4728.479867214535;4741.028089241629;4759.0719809636785;4774.95225047745;4780.880477988078;5062.949370506395;5093.516115968977;5105.387353517602;5109.412417571878;5138.691678499302;4789.592884604708;4790.353302304145;4801.4718380977365;4834.5890599298045;4840;5096.0827051131155;5098.260752190986;5111.3355263815465;5116.1046816806165;5151.098557752453;4983.651144419856;5032.320636714143;5094.465081166572;5179;5226.843194704165;4975.9004819902675;4977.626677999092;4984.2025275955675;5010.69935803853;5039.798408063636;4990.451050384528;4997.300377947017;5016.498350164954;5017.523335283142;5024.924626130684;4798.904021919612;4860.173770459101;4903.994681090297;4929.778159982881;4996.400431948189;4990.80036798524;4999.350084488993;5002.974985125051;5055.772490237875;5094.745262736774;4894.412670479565;4897.534734200245;4902.754862256944;4919.163742163769;4946.579540739078 08:21:38 INFO - PROCESS | 4214 | |1;ext.html;499.8200647766804;512.9256257842613;516.506736067056;519.1278651864868;544.9400915219894;36084.639153608456;36970.26059478809;37061.99999999996;37140.81429592848;37150.25699486009;38065.8096709516;38293.617063829355;38362.42456363157;38392.80803595985;38536;7502.924970750304;7669.118051424074;7674.386049116058;7690.500117492373;9445.527723613826;9326.580303886307;9595.376300540478;9600.279979001569;9600.711978640617;9611.95194024029;9594.616215351378;9599;9635.614575416976;9655.710328690151;9675.129238368545;9519.23846092318;9570;9621.855672164924;9624.422534647874;9629.711108666786;9436.622535098588;9513.809723805485;9517.904820951771;9519.476428796483;9536.2371010319;32651.510227346607;32977.505337419956;33137;33143.502847457305;33216.33567328664;3537.2925414916863;3656.9085772855624;3658.762180458262;3659.597444281127;3689.8893033209047;25055.87472062628;25230.747692523022;25430;25635.230943071736;26143.607845882136;3331.68349006844;3360.764746467724;3365.5624768779903;3422.819127401043;3442.6729460701195;235360;236856;236922;237721;237781;44820.77589612031;44956.77521612371;45091.77454112709;45119;45249.77375113103;46083.53916460859;46096;46395.5360446398;46486.30270545944;46628.53371466242;10751.731206719738;10858.891411085946;10971.83542246867;11001.22991390595;11010.944945275221;7289.635518224068;7362.300581444754;8676.696315628922;8847.292216622784;8907.153820387053;15183;15185.62035949088;15192.696146077016;15213;15301.770473442908;6222.968885155546;6328.430441260309;6395.584287021329;6486.156799616019;6489.707963141575;700.8212905709114;718.4360277182386;719.8668246374333;721.7401735375261;722.7398136670794;26010.219693409228;27214;27559;27740;27837.304067398476;820.1429506166071;843.8312337532518;850.0521918061318;862.1809281182901;863.2921004776149;13919.234442105579;14328.785068223984;14567.500810858097;14793.63015924589;14898.553043408716;332085;335586;335622;336193;336412;47685;47976.7601161992;48021.519784801705;48045.5195448048;48081.75959120252;1043.9373637581618;1158.9942050289694;1208.1965492947268;1214.684182112657;1218.0438355890406;24473.38816529601;25172.24483265505;25872.8706356467;26255.212343629722;26357.34106647349;38866.805665971486;39419.80290098531;39453;39464.60535394609;39583.40624890687;278857;279060;280402;280520;280653;22918.19786307471;38859;39249.80375098106;39349.60650393574;39356.50617648171;37910.24179516339;38118.809405952794;39378.80310598428;41912;43113.35329970116;36501.63498364983;36963.44554831626;37217;38251.23497529978;38404.42393364158;36428.81785591055;36637.26725465529;37075.81462092672;37477.62522374741;37485;36168.27663446769;36300.45549316815;36640;36675.633243667224;36680.26639467249;31457.370852583277;34054.8297258522;34119.48820767641;34121.82939085289;34148.31703365968;23208.535829283657;23335.41661458477;23560.920970752955;23881.761182387952;23922.28233153008 08:21:38 INFO - PROCESS | 4214 | |2;jquery.html;362.7297663240886;377.4074702716734;384.4156881540059;385.9864904728335;391.408972451598;15663;16977.06626135562;17077.658446831058;17095.91452042741;17263;16182.919085404586;16473.752893706605;16888.746668799948;17055.232514536845;17057.232424540893;4859.465458799538;5104.489551044903;5107.61692873036;5110.259012443194;5111.386633603973;5034.395872495305;5194.948050519503;5465.9726701366435;5494.532964698005;5557.861053473655;5532.170174473821;5534.529564986981;5541.27963364764;5542.889142217174;5543.36251331096;5287.233351164079;5378.354597448311;5420.186971954218;5422.566194704415;5453.945460545384;5260.684358938476;5297.841064768063;5302.2841916341185;5318.095923692981;5323.494268044529;12367.072469564819;17467.213975371138;18522.722159167624;19519.414417567496;19525;2080.552681173555;2112.862663926855;2130.2437634639637;2135.9021036601903;2255.966160507577;8656.523891185981;8930.955345223298;9383;9522.571484283224;9637.566309516089;1563.3043295733403;1564.4759005732978;1568.4196847166506;1584.952451426459;1587.936482540697;64182.35817641811;65049;65188.67405662989;66177.99999999952;67792;9842;9855.31012829095;9977.201823854075;10007.949960250298;10029.097381235579;13605.659858503419;13670.863291367157;13734.313284335743;13776.517821876187;13778.517751878837;6385.840353991188;6674.299198584175;6794.898076528856;6931.549449285781;6958.721651133999;6205.937940620536;6234.3453937336835;6452.322506136882;6456.451201647818;6462.772073306057;4158.708890377705;4196.622303992655;4211.7262377945335;4243.957560424418;4359.891002724894;1536.4238410596026;1594.7129516686875;1617.70583533173;1831.597048649295;1884.3122260374864;799.4883274704194;810.2343285595056;813.7874566895283;835.7450977451936;836.3727204596553;15376.077435353915;15432.92283538575;15463;15531.611709707347;15535.689286214212;793.0443815202667;795.1809636074852;811.3347055414504;813.495632707725;821.117298903681;8322.421358815647;8530.573471326408;8709.564521773886;9083.591238394289;9593.760155996157;351767;354318;355158;358867;359833;74447.25552744512;75619.24380756122;75788.24211757812;76310;77184;882.1663527966139;915.8580420034905;922.4188761080476;931.3480563605503;934.4860326820358;15378;15581.766273506133;15589.688206235585;15786.605334866721;15802.60493487626;34764.47853282253;35072.47391289082;35334.646653533135;35754.821225894746;36042;45386;46798;46860;48553;49361;7321.743738969323;7366.263373662591;7446.962765186139;7538.660760265691;8073.87889181651;9023.90976090257;10800.135989121009;11039.83440248413;11334.433278336215;11437.485313161094;9303.209227215762;9556.474393908124;9656.855147172657;9731.805363892825;9742.123208910949;9302.95348523253;9643.9035609643;9779.364341317792;9963.35238209543;9996.500174991366;8832;8878.200961913459;9241.075892410705;9259.814803704023;9326.253899688145;6770.8645827084165;6977.546459480118;7046.401055910305;8011.278984891388;8088.555129467935;9049.638014479611;9402.95298523503;9547.952260238655;9558.709574207393;9692.22462203008 08:21:38 INFO - PROCESS | 4214 | |3;mootools.html;1312.8030795380687;1314.4610709609055;1316.6313432238974;1319.571139379702;1320.0825426328702;6662.933370666292;6877.6217308048035;7024.1922178949435;7410.925890741098;7470.551766893984;6933.514653974224;7142.2857714228685;7143.3570978611915;7299.270072992698;7310.049693539832;2107.852450328474;2123.2674727219087;2142.678598210265;2144.6997420361163;2153.6446486329814;1994.441556364213;2045.4068320187127;2053.281351526961;2148.140743702516;2232.8660280383147;2185.191479152708;2211.148707747521;2212.6017316882953;2215.1471683401924;2215.7341119065654;2084.6351888419467;2085.35354040248;2091.4144039668995;2101.3065688322818;2110.1242984161554;2116.2487317002397;2119.95760084799;2125.171183238538;2134.8932553372424;2144.2066435418838;7433.516821406592;7473;7509.924900750977;7528.924710752932;7530.43521735872;4510.797014134372;4566.862994110182;4597;4641.883952901171;4642;2761.502929472694;2948.5110019440044;2979.9851000744857;3022.4106299271652;3055.052933590594;1098.2970898624887;1101.3336931156696;1128.227164392394;1143.7140714821294;1158.3050169897995;9706.902930970671;9739.56171972263;9835.852462213072;9873.80252394948;9895.505224738663;3756.248750249906;3970.5830887756947;3993.4608827808456;4034.8386064557676;4058.188362327546;7643.847123057508;7664.540127592362;7665.578393188428;7679.078510578766;7691.923080769233;4382.627476664456;4462.129884672523;4467.218236808546;4490.618297444688;4502.414686090853;3955.4660120883314;4145.046639272984;4220.620144186976;4220.683448741357;4229.619334259932;3264.8041117533025;3296.1100502864574;3357.278185190147;3366.7811592246426;3382.323535292902;915.3226612306845;939.9436033837992;1030.3354336453096;1057.836035414512;1059.0680201422854;722.7109156337402;734.6069852628818;752.1650967426152;753.7814033930208;761.2425636491615;4419.248727716296;4742.241241401428;4805.783739731721;4807.711537307773;4809.759512024385;812.5937031484258;814.4583851738528;823.3660081737029;833.5657092777794;842.6418772021866;3205.1826784170353;3206.8396580170897;3247.594050743657;3267.950980735291;3323.9833800831325;8465.449745766506;8852.778680532909;8867.512286824287;8874.86687699685;8876.911230887608;8821.867671984925;8868.379213455126;8884.067172946876;8892.822143557221;8900.955495222612;6935.202451718016;7005.299470052954;7031.859362812817;7034.472414568928;7035.296470352924;4669.136209801198;4724.858254252378;4768.213244814706;4820.614350851994;4929.408470983505;8032.959835200787;8103.756887293391;8109.432339736398;8122.309603683753;8130.105688374156;8185.181481851767;8208.46644968075;8223;8282.088970213392;8307.044689860744;6018.067199584071;6076.088586712029;6085.1785009023215;6090.2996155440915;6095.786647467317;6603.306652801387;6664.600123992576;6698.39714425704;6728.865422691617;6855.965720171367;5267.420583735709;5979.880402392015;6017.157597936205;6074.1799857020505;6096.237970253718;6005.969970150121;6042.395760424099;6057.151998720271;6057.606255593372;6138.508919286535;5267.394249661338;5398.541124004347;5441.347038355423;5503.036968530571;5507.146392309199;4197.559256278169;4199.307114326102;4260.95739042618;4318.769150792009;4419.779011049371;3983.3626619740703;4036.414719865662;4068.9186216276103;4097.672186225154;4215.178040282116 08:21:38 INFO - PROCESS | 4214 | |4;prototype.html;352.72839913266785;356.57033274903745;358.11009641042017;359.5900673232514;362.8693670278701;4971.005798840229;5016.598672106232;5017.523335283151;5045.217991211368;5060.190369540875;4928.5564299213065;4940.2342636891335;4943.505649435064;4957.810650000743;4976.751162441881;3729.9067523311996;3856.730028897964;3896.6687831534355;3901.531816182048;4069.8168582413787;3829.444730514074;3861.555921069071;3873.7288389812725;3879.9806000970098;3887.5529314128953;3853.6339047790557;3864.3237433449176;3872.3223435898744;3872.7676339419586;3876.3216437123533;3658.304922064799;3860.401637746154;3861.8607510784386;3877.1664092220167;3880.417937309398;3353.9496907546404;3370.1406141433777;3371.3088816792497;3372.6121496028027;3384.560007199073;4826.710397376169;4826.758662066918;4842.322074909515;4849.2968519564465;4856.858638220016;4326.848560300375;4336.848210312624;4342.956570434319;4346.956530434687;4349.456317960255;4862.878428039327;5097.541221290065;5111.642185047048;5169.508896654812;5186.351706036746;3690.6309369063147;3699.8335074921692;3704.018435114697;3707.9629203707887;3709.870154544578;5279.392869819982;5421.186821976696;5457.890842183174;5468.890622187574;5477.835664930059;4027.234825383168;4059.4316795648633;4073.103917138225;4074.674026077966;4077.082656402286;4126.381042843537;4127.236461254677;4133.7106402551535;4138.772367519755;4159.209750147463;4453.910921781546;4545.6136228420955;4566.589006989387;4601.700889442175;4608.170529304691;5179.637425380187;5219.582433405319;5231.852573226443;5236.476352364733;5257.5005374489365;1361.6800051987775;1385.2450414524108;1395.5813256023152;1403.6701375176826;1405.5221224783418;958.2669258017622;979.1628157924872;984.3995162950595;990.7721224118493;1002.7242508310127;4314;4322.913541729211;4325.740455572675;4334.739915605074;4335.4363932689175;5188.584913206934;5206.5314121729225;5212.931349073507;5220.243064755589;5238.397584277781;4080.265552200573;4334.544872788375;4336.566343365701;4349.478062632505;4376.089900216384;2769.1969328894797;2779.207925741154;2783.580374009229;2788.60959465675;2788.60959465675;4817.662763606514;4834.347363106006;4838.491958344393;4842.467328593852;4845.297431872429;5031.7987280509105;5296.364436267596;5305.761240744176;5309.973450132725;5360.544353729977;4777.928331075037;4794.760261986887;4797.625175538131;4801.207800712843;4806.687565308243;5175.896482070413;5176.818811341585;5180.119379705384;5197.24639927216;5205.947940520547;4972.8508144755715;5120.233519435788;5140.317587136782;5142.357205349332;5317.680939143509;4861.635377346784;4995.875103122451;4997.875053123701;5011.799528018839;5014.924776128288;3714.1457464783794;3717.182219911615;3720.1443667957064;3725.70194384454;3753.6809371203753;5426.511613954763;5440.483154100354;5453.182022696627;5462.24156800813;5471.425500322409;5036.219385995177;5225.817096401608;5250.899640143973;5262.8947421052135;5309.2301616266195;5249.4225635180865;5251.159814429673;5251.868703282448;5258.711615654189;5270.367555893317;5203.19350500673;5215.973920130375;5250.159974404077;5254.42201357858;5256.500632439912;4945.332380128637;5195.376554813447;5233.476652334736;5272.578193744414;5349.251104845403;5111.9870901342265;5133.230015497706;5134.15286477727;5140.691558506352;5144.459831717616 08:21:38 INFO - PROCESS | 4214 | |5;yui.html;652.1684851813934;661.784919901032;692.0277010799828;698.2528694297102;707.4800021983842;12424.192427492208;12606.180598261106;12676.302803345812;12841.807372889403;12916.677083072927;12270.447829847679;12683.429245683943;12871.227726336427;12915;12934.159279646816;805.1827395193883;824.1511243419287;826.8801023851538;827.4166712467726;829.9543525106117;794.6741835847304;802.6869520886859;808.8139727862596;834.1450013735908;835.3692961813822;859.9269062129695;868.5266529741275;870.9042005379404;871.4422769427572;875.1248751248751;853.6116067189414;856.3534531428794;857.6483641706901;858.2704701004128;859.3640705877668;636.4717284653726;636.837606410367;637.4263163153153;638.1767519899324;638.4509321983137;13189.472421103144;13401.731965360736;13425.731485370336;13441.126326788728;14049.227292498908;10982.670519884416;11448;11917.940410297893;12337.568185113478;13366.732665346639;11041.503132359063;11345.489452974636;11451.94274028633;11532.94233528827;12114.575989840401;4201.33215408218;4209.326507758744;4250.744955302692;4392.802323895432;4405.449318835145;64454.3554564453;65319.3468065318;65496.67251663711;66301;66442.3355766441;9376.671816486527;9593.328467007383;9595.568199431042;9610.807783844284;9616.567254473426;17417.912910435367;17441;17444.563885902953;17537;17596.384126555764;6183.319834818167;6227.459240345384;6259.906101408483;6325.65208913505;6355.237371515448;3381.8309084545676;3397.405454045532;3424.7945123292684;3431.9142021449666;3435.6736110069505;2589.210290861268;2617.2148355493277;2631.7499837515406;2632.447186090904;2632.6972398174457;470.92936059591335;472.4566748239552;474.3454033433839;479.09212043177985;481.57621293261707;561.5732043646858;574.0786038408295;575.4648177195165;578.673049726903;582.251806428737;7329.450291228072;7360.815979600553;7386.15059268191;7440.813979650552;7450.478466507401;479.63787340557656;496.7193535652417;498.07109740334016;517.8317046959753;522.9555487783581;3354.8322583871195;3580.2839432113683;3597.514335564665;3660.633936606318;3697.482352470656;66176;66391.66804165948;66749.66625166843;68072.65963670249;68624.6568767163;58091.70954145202;58183;58756.70621646864;59266;59783.70108149431;50052;51471.48528514667;51566;52161;52571;6766.391024807594;7045.577265364094;7128.465365097535;7167.371300671475;7167.7132914682825;37873.62126378811;37930.81034594809;38053.809730951165;38949;39760.60239397569;48031.5196848041;48914;49577.25634115563;49769.25346119884;50296.24555631595;8398.87401688963;8410.411271210956;8552.700655477029;10645.414502202453;10706.464676765974;12054.337011464453;12438.564650237198;12567.802477498893;12766.29785361814;13163.736725265633;10724.463776810971;10820.56717731282;10942.835857461985;11990.760184796081;11991.22057066288;11084.16868734832;11233.66299011031;11269.49287282058;11463.942680286878;11806.173567850168;10323.277370583986;11056.447177640925;11208.159388045766;11581.015613672933;11880.762384752084;9148.542572871196;9495.715128546155;9662.516874156405;9714.854277185988;9905.702828915144;9256.120668536478;9458.574364153767;9507.809843802946;9510.857337140087;9661.46861922601 08:21:38 INFO - PROCESS | 4214 | __end_tp_report 08:21:38 INFO - PROCESS | 4214 | __start_cc_report 08:21:38 INFO - PROCESS | 4214 | _x_x_mozilla_cycle_collect,342 08:21:38 INFO - PROCESS | 4214 | __end_cc_report 08:21:38 INFO - PROCESS | 4214 | __startTimestamp1482942098316__endTimestamp 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | ------- Summary: start ------- 08:21:38 INFO - PROCESS | 4214 | Number of tests: 6 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#0] dojo.html Cycles:165 Average:4728.36 Median:4852.64 stddev:506.66 (10.4%) stddev-sans-first:479.09 08:21:38 INFO - PROCESS | 4214 | Values: 2570.1 2577.5 2579.7 2599.8 2605.2 4655.5 4792.0 4849.3 4852.6 4853.7 4682.1 4803.2 4837.6 4847.6 4879.6 4384.2 4437.6 4461.9 4512.4 4546.3 4112.2 4556.7 4568.8 4583.2 4593.1 4404.6 4443.0 4451.5 4489.6 4557.4 4363.1 4373.8 4398.5 4422.0 4477.5 4363.8 4376.6 4378.4 4384.9 4390.8 4690.7 4701.6 4741.7 4746.0 4777.2 5002.1 5034.9 5085.0 5110.4 5112.4 5163.0 5166.7 5172.5 5173.2 5208.8 4808.7 4827.4 4827.7 4827.8 4882.3 5178.0 5187.1 5191.2 5226.5 5264.7 5000.7 5005.2 5015.9 5038.1 5061.6 5069.7 5072.7 5075.9 5083.3 5125.9 4972.2 4996.1 5012.6 5037.9 5056.4 5052.2 5142.3 5143.9 5148.5 5151.8 4322.8 4345.8 4349.4 4352.1 4391.0 3781.7 3784.0 3784.8 3788.4 3820.5 4267.3 4315.5 4320.3 4358.8 4362.1 5186.4 5196.1 5199.4 5201.6 5238.3 4340.6 4357.3 4358.7 4366.1 4402.6 4533.4 4565.0 4590.6 4610.2 4633.2 4728.5 4741.0 4759.1 4775.0 4780.9 5062.9 5093.5 5105.4 5109.4 5138.7 4789.6 4790.4 4801.5 4834.6 4840.0 5096.1 5098.3 5111.3 5116.1 5151.1 4983.7 5032.3 5094.5 5179.0 5226.8 4975.9 4977.6 4984.2 5010.7 5039.8 4990.5 4997.3 5016.5 5017.5 5024.9 4798.9 4860.2 4904.0 4929.8 4996.4 4990.8 4999.4 5003.0 5055.8 5094.7 4894.4 4897.5 4902.8 4919.2 4946.6 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#1] ext.html Cycles:180 Average:43703.05 Median:37183.63 stddev:75103.83 (202.0%) stddev-sans-first:75244.47 08:21:38 INFO - PROCESS | 4214 | Values: 499.8 512.9 516.5 519.1 544.9 36084.6 36970.3 37062.0 37140.8 37150.3 38065.8 38293.6 38362.4 38392.8 38536.0 7502.9 7669.1 7674.4 7690.5 9445.5 9326.6 9595.4 9600.3 9600.7 9612.0 9594.6 9599.0 9635.6 9655.7 9675.1 9519.2 9570.0 9621.9 9624.4 9629.7 9436.6 9513.8 9517.9 9519.5 9536.2 32651.5 32977.5 33137.0 33143.5 33216.3 3537.3 3656.9 3658.8 3659.6 3689.9 25055.9 25230.7 25430.0 25635.2 26143.6 3331.7 3360.8 3365.6 3422.8 3442.7 235360.0 236856.0 236922.0 237721.0 237781.0 44820.8 44956.8 45091.8 45119.0 45249.8 46083.5 46096.0 46395.5 46486.3 46628.5 10751.7 10858.9 10971.8 11001.2 11010.9 7289.6 7362.3 8676.7 8847.3 8907.2 15183.0 15185.6 15192.7 15213.0 15301.8 6223.0 6328.4 6395.6 6486.2 6489.7 700.8 718.4 719.9 721.7 722.7 26010.2 27214.0 27559.0 27740.0 27837.3 820.1 843.8 850.1 862.2 863.3 13919.2 14328.8 14567.5 14793.6 14898.6 332085.0 335586.0 335622.0 336193.0 336412.0 47685.0 47976.8 48021.5 48045.5 48081.8 1043.9 1159.0 1208.2 1214.7 1218.0 24473.4 25172.2 25872.9 26255.2 26357.3 38866.8 39419.8 39453.0 39464.6 39583.4 278857.0 279060.0 280402.0 280520.0 280653.0 22918.2 38859.0 39249.8 39349.6 39356.5 37910.2 38118.8 39378.8 41912.0 43113.4 36501.6 36963.4 37217.0 38251.2 38404.4 36428.8 36637.3 37075.8 37477.6 37485.0 36168.3 36300.5 36640.0 36675.6 36680.3 31457.4 34054.8 34119.5 34121.8 34148.3 23208.5 23335.4 23560.9 23881.8 23922.3 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#2] jquery.html Cycles:180 Average:22778.94 Median:5421.38 stddev:58920.82 (1086.8%) stddev-sans-first:59062.07 08:21:38 INFO - PROCESS | 4214 | Values: 362.7 377.4 384.4 386.0 391.4 15663.0 16977.1 17077.7 17095.9 17263.0 16182.9 16473.8 16888.7 17055.2 17057.2 4859.5 5104.5 5107.6 5110.3 5111.4 5034.4 5194.9 5466.0 5494.5 5557.9 5532.2 5534.5 5541.3 5542.9 5543.4 5287.2 5378.4 5420.2 5422.6 5453.9 5260.7 5297.8 5302.3 5318.1 5323.5 12367.1 17467.2 18522.7 19519.4 19525.0 2080.6 2112.9 2130.2 2135.9 2256.0 8656.5 8931.0 9383.0 9522.6 9637.6 1563.3 1564.5 1568.4 1585.0 1587.9 64182.4 65049.0 65188.7 66178.0 67792.0 9842.0 9855.3 9977.2 10007.9 10029.1 13605.7 13670.9 13734.3 13776.5 13778.5 6385.8 6674.3 6794.9 6931.5 6958.7 6205.9 6234.3 6452.3 6456.5 6462.8 4158.7 4196.6 4211.7 4244.0 4359.9 1536.4 1594.7 1617.7 1831.6 1884.3 799.5 810.2 813.8 835.7 836.4 15376.1 15432.9 15463.0 15531.6 15535.7 793.0 795.2 811.3 813.5 821.1 8322.4 8530.6 8709.6 9083.6 9593.8 351767.0 354318.0 355158.0 358867.0 359833.0 74447.3 75619.2 75788.2 76310.0 77184.0 882.2 915.9 922.4 931.3 934.5 15378.0 15581.8 15589.7 15786.6 15802.6 34764.5 35072.5 35334.6 35754.8 36042.0 45386.0 46798.0 46860.0 48553.0 49361.0 7321.7 7366.3 7447.0 7538.7 8073.9 9023.9 10800.1 11039.8 11334.4 11437.5 9303.2 9556.5 9656.9 9731.8 9742.1 9303.0 9643.9 9779.4 9963.4 9996.5 8832.0 8878.2 9241.1 9259.8 9326.3 6770.9 6977.5 7046.4 8011.3 8088.6 9049.6 9403.0 9548.0 9558.7 9692.2 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#3] mootools.html Cycles:180 Average:4739.81 Median:4815.19 stddev:2579.17 (53.6%) stddev-sans-first:2573.54 08:21:38 INFO - PROCESS | 4214 | Values: 1312.8 1314.5 1316.6 1319.6 1320.1 6662.9 6877.6 7024.2 7410.9 7470.6 6933.5 7142.3 7143.4 7299.3 7310.0 2107.9 2123.3 2142.7 2144.7 2153.6 1994.4 2045.4 2053.3 2148.1 2232.9 2185.2 2211.1 2212.6 2215.1 2215.7 2084.6 2085.4 2091.4 2101.3 2110.1 2116.2 2120.0 2125.2 2134.9 2144.2 7433.5 7473.0 7509.9 7528.9 7530.4 4510.8 4566.9 4597.0 4641.9 4642.0 2761.5 2948.5 2980.0 3022.4 3055.1 1098.3 1101.3 1128.2 1143.7 1158.3 9706.9 9739.6 9835.9 9873.8 9895.5 3756.2 3970.6 3993.5 4034.8 4058.2 7643.8 7664.5 7665.6 7679.1 7691.9 4382.6 4462.1 4467.2 4490.6 4502.4 3955.5 4145.0 4220.6 4220.7 4229.6 3264.8 3296.1 3357.3 3366.8 3382.3 915.3 939.9 1030.3 1057.8 1059.1 722.7 734.6 752.2 753.8 761.2 4419.2 4742.2 4805.8 4807.7 4809.8 812.6 814.5 823.4 833.6 842.6 3205.2 3206.8 3247.6 3268.0 3324.0 8465.4 8852.8 8867.5 8874.9 8876.9 8821.9 8868.4 8884.1 8892.8 8901.0 6935.2 7005.3 7031.9 7034.5 7035.3 4669.1 4724.9 4768.2 4820.6 4929.4 8033.0 8103.8 8109.4 8122.3 8130.1 8185.2 8208.5 8223.0 8282.1 8307.0 6018.1 6076.1 6085.2 6090.3 6095.8 6603.3 6664.6 6698.4 6728.9 6856.0 5267.4 5979.9 6017.2 6074.2 6096.2 6006.0 6042.4 6057.2 6057.6 6138.5 5267.4 5398.5 5441.3 5503.0 5507.1 4197.6 4199.3 4261.0 4318.8 4419.8 3983.4 4036.4 4068.9 4097.7 4215.2 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#4] prototype.html Cycles:180 Average:4303.50 Median:4840.41 stddev:1223.08 (25.3%) stddev-sans-first:1190.02 08:21:38 INFO - PROCESS | 4214 | Values: 352.7 356.6 358.1 359.6 362.9 4971.0 5016.6 5017.5 5045.2 5060.2 4928.6 4940.2 4943.5 4957.8 4976.8 3729.9 3856.7 3896.7 3901.5 4069.8 3829.4 3861.6 3873.7 3880.0 3887.6 3853.6 3864.3 3872.3 3872.8 3876.3 3658.3 3860.4 3861.9 3877.2 3880.4 3353.9 3370.1 3371.3 3372.6 3384.6 4826.7 4826.8 4842.3 4849.3 4856.9 4326.8 4336.8 4343.0 4347.0 4349.5 4862.9 5097.5 5111.6 5169.5 5186.4 3690.6 3699.8 3704.0 3708.0 3709.9 5279.4 5421.2 5457.9 5468.9 5477.8 4027.2 4059.4 4073.1 4074.7 4077.1 4126.4 4127.2 4133.7 4138.8 4159.2 4453.9 4545.6 4566.6 4601.7 4608.2 5179.6 5219.6 5231.9 5236.5 5257.5 1361.7 1385.2 1395.6 1403.7 1405.5 958.3 979.2 984.4 990.8 1002.7 4314.0 4322.9 4325.7 4334.7 4335.4 5188.6 5206.5 5212.9 5220.2 5238.4 4080.3 4334.5 4336.6 4349.5 4376.1 2769.2 2779.2 2783.6 2788.6 2788.6 4817.7 4834.3 4838.5 4842.5 4845.3 5031.8 5296.4 5305.8 5310.0 5360.5 4777.9 4794.8 4797.6 4801.2 4806.7 5175.9 5176.8 5180.1 5197.2 5205.9 4972.9 5120.2 5140.3 5142.4 5317.7 4861.6 4995.9 4997.9 5011.8 5014.9 3714.1 3717.2 3720.1 3725.7 3753.7 5426.5 5440.5 5453.2 5462.2 5471.4 5036.2 5225.8 5250.9 5262.9 5309.2 5249.4 5251.2 5251.9 5258.7 5270.4 5203.2 5216.0 5250.2 5254.4 5256.5 4945.3 5195.4 5233.5 5272.6 5349.3 5112.0 5133.2 5134.2 5140.7 5144.5 08:21:38 INFO - PROCESS | 4214 | 08:21:38 INFO - PROCESS | 4214 | [#5] yui.html Cycles:180 Average:14895.62 Median:50883.87 stddev:19100.13 (37.5%) stddev-sans-first:19123.76 08:21:38 INFO - PROCESS | 4214 | Values: 652.2 661.8 692.0 698.3 707.5 12424.2 12606.2 12676.3 12841.8 12916.7 12270.4 12683.4 12871.2 12915.0 12934.2 805.2 824.2 826.9 827.4 830.0 794.7 802.7 808.8 834.1 835.4 859.9 868.5 870.9 871.4 875.1 853.6 856.4 857.6 858.3 859.4 636.5 636.8 637.4 638.2 638.5 13189.5 13401.7 13425.7 13441.1 14049.2 10982.7 11448.0 11917.9 12337.6 13366.7 11041.5 11345.5 11451.9 11532.9 12114.6 4201.3 4209.3 4250.7 4392.8 4405.4 64454.4 65319.3 65496.7 66301.0 66442.3 9376.7 9593.3 9595.6 9610.8 9616.6 17417.9 17441.0 17444.6 17537.0 17596.4 6183.3 6227.5 6259.9 6325.7 6355.2 3381.8 3397.4 3424.8 3431.9 3435.7 2589.2 2617.2 2631.7 2632.4 2632.7 470.9 472.5 474.3 479.1 481.6 561.6 574.1 575.5 578.7 582.3 7329.5 7360.8 7386.2 7440.8 7450.5 479.6 496.7 498.1 517.8 523.0 3354.8 3580.3 3597.5 3660.6 3697.5 66176.0 66391.7 66749.7 68072.7 68624.7 58091.7 58183.0 58756.7 59266.0 59783.7 50052.0 51471.5 51566.0 52161.0 52571.0 6766.4 7045.6 7128.5 7167.4 7167.7 37873.6 37930.8 38053.8 38949.0 39760.6 48031.5 48914.0 49577.3 49769.3 50296.2 8398.9 8410.4 8552.7 10645.4 10706.5 12054.3 12438.6 12567.8 12766.3 13163.7 10724.5 10820.6 10942.8 11990.8 11991.2 11084.2 11233.7 11269.5 11463.9 11806.2 10323.3 11056.4 11208.2 11581.0 11880.8 9148.5 9495.7 9662.5 9714.9 9905.7 9256.1 9458.6 9507.8 9510.9 9661.5 08:21:38 INFO - PROCESS | 4214 | -------- Summary: end -------- 08:21:38 INFO - PROCESS | 4214 | 08:21:39 INFO - TEST-INFO | 4214: exit 0 08:21:39 INFO - TEST-OK | dromaeo_css | took 1118404ms 08:21:39 INFO - TEST-START | kraken 08:21:39 INFO - operating with platform_type : linux_ 08:21:39 INFO - Initialising browser for kraken test... 08:21:39 INFO - TEST-INFO | started process 4571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaoL4jo/profile http://localhost:58079/getInfo.html) 08:21:39 INFO - PROCESS | 4571 | 1482942099662 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 08:21:43 INFO - PROCESS | 4571 | __metrics Screen width/height:1600/1200 08:21:43 INFO - PROCESS | 4571 | colorDepth:24 08:21:43 INFO - PROCESS | 4571 | Browser inner width/height: 1024/697 08:21:43 INFO - PROCESS | 4571 | __metrics 08:21:43 ERROR - PROCESS | 4571 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:21:44 INFO - TEST-INFO | 4571: exit 0 08:21:44 INFO - Browser initialized. 08:21:44 INFO - Running cycle 1/1 for kraken test... 08:21:44 INFO - TEST-INFO | started process 4693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaoL4jo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:56 INFO - PROCESS | 4693 | RSS: Main: 158023680 08:21:56 INFO - PROCESS | 4693 | 08:21:59 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:00 INFO - PROCESS | 4693 | RSS: Main: 163840000 08:22:00 INFO - PROCESS | 4693 | 08:22:03 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-dft) 08:22:03 INFO - PROCESS | 4693 | RSS: Main: 162840576 08:22:03 INFO - PROCESS | 4693 | 08:22:06 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-fft) 08:22:07 INFO - PROCESS | 4693 | RSS: Main: 159289344 08:22:07 INFO - PROCESS | 4693 | 08:22:09 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-oscillator) 08:22:10 INFO - PROCESS | 4693 | RSS: Main: 160014336 08:22:10 INFO - PROCESS | 4693 | 08:22:12 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:13 INFO - PROCESS | 4693 | RSS: Main: 160104448 08:22:13 INFO - PROCESS | 4693 | 08:22:16 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:16 INFO - PROCESS | 4693 | RSS: Main: 165199872 08:22:16 INFO - PROCESS | 4693 | 08:22:20 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:21 INFO - PROCESS | 4693 | RSS: Main: 162074624 08:22:21 INFO - PROCESS | 4693 | 08:22:23 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58079/tests/kraken/driver.html?testName=json-parse-financial) 08:22:24 INFO - PROCESS | 4693 | RSS: Main: 162770944 08:22:24 INFO - PROCESS | 4693 | 08:22:26 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:26 INFO - PROCESS | 4693 | RSS: Main: 163213312 08:22:26 INFO - PROCESS | 4693 | 08:22:28 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:29 INFO - PROCESS | 4693 | RSS: Main: 162574336 08:22:29 INFO - PROCESS | 4693 | 08:22:31 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:32 INFO - PROCESS | 4693 | RSS: Main: 163459072 08:22:32 INFO - PROCESS | 4693 | 08:22:35 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:35 INFO - PROCESS | 4693 | RSS: Main: 163602432 08:22:35 INFO - PROCESS | 4693 | 08:22:38 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:39 INFO - PROCESS | 4693 | RSS: Main: 163360768 08:22:39 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58079/tests/kraken/driver.html?testName=ai-astar) 08:22:41 INFO - PROCESS | 4693 | RSS: Main: 165052416 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | __start_tp_report 08:22:41 INFO - PROCESS | 4693 | _x_x_mozilla_page_load 08:22:41 INFO - PROCESS | 4693 | _x_x_mozilla_page_load_details 08:22:41 INFO - PROCESS | 4693 | |i|pagename|runs| 08:22:41 INFO - PROCESS | 4693 | |0;ai-astar;108;115;114;115;116;115;118;115;116;115 08:22:41 INFO - PROCESS | 4693 | |1;audio-beat-detection;152;128;127;171;138;139;129;133;153;132 08:22:41 INFO - PROCESS | 4693 | |2;audio-dft;167;169;165;175;164;163;165;164;163;164 08:22:41 INFO - PROCESS | 4693 | |3;audio-fft;75;76;77;102;77;77;76;76;95;78 08:22:41 INFO - PROCESS | 4693 | |4;audio-oscillator;86;84;114;85;84;85;96;85;86;105 08:22:41 INFO - PROCESS | 4693 | |5;imaging-gaussian-blur;117;118;119;118;117;120;119;119;118;118 08:22:41 INFO - PROCESS | 4693 | |6;imaging-darkroom;151;150;151;151;152;151;149;150;151;150 08:22:41 INFO - PROCESS | 4693 | |7;imaging-desaturate;95;97;95;97;96;96;97;97;99;96 08:22:41 INFO - PROCESS | 4693 | |8;json-parse-financial;66;68;69;69;69;70;68;67;69;67 08:22:41 INFO - PROCESS | 4693 | |9;json-stringify-tinderbox;67;69;67;69;69;69;68;68;68;67 08:22:41 INFO - PROCESS | 4693 | |10;stanford-crypto-aes;88;92;86;85;87;86;86;86;85;86 08:22:41 INFO - PROCESS | 4693 | |11;stanford-crypto-ccm;141;147;148;135;155;136;144;133;192;161 08:22:41 INFO - PROCESS | 4693 | |12;stanford-crypto-pbkdf2;184;177;177;177;175;179;178;185;181;177 08:22:41 INFO - PROCESS | 4693 | |13;stanford-crypto-sha256-iterative;70;70;70;71;72;71;70;69;69;69 08:22:41 INFO - PROCESS | 4693 | __end_tp_report 08:22:41 INFO - PROCESS | 4693 | __start_cc_report 08:22:41 INFO - PROCESS | 4693 | _x_x_mozilla_cycle_collect,798 08:22:41 INFO - PROCESS | 4693 | __end_cc_report 08:22:41 INFO - PROCESS | 4693 | __startTimestamp1482942161596__endTimestamp 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | ------- Summary: start ------- 08:22:41 INFO - PROCESS | 4693 | Number of tests: 14 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:2.58 (2.2%) stddev-sans-first:1.13 08:22:41 INFO - PROCESS | 4693 | Values: 108.0 115.0 114.0 115.0 116.0 115.0 118.0 115.0 116.0 115.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:138.50 stddev:14.24 (10.3%) stddev-sans-first:14.45 08:22:41 INFO - PROCESS | 4693 | Values: 152.0 128.0 127.0 171.0 138.0 139.0 129.0 133.0 153.0 132.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:3.70 (2.2%) stddev-sans-first:3.90 08:22:41 INFO - PROCESS | 4693 | Values: 167.0 169.0 165.0 175.0 164.0 163.0 165.0 164.0 163.0 164.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#3] audio-fft Cycles:10 Average:80.90 Median:77.00 stddev:9.46 (12.3%) stddev-sans-first:9.79 08:22:41 INFO - PROCESS | 4693 | Values: 75.0 76.0 77.0 102.0 77.0 77.0 76.0 76.0 95.0 78.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:85.00 stddev:10.57 (12.4%) stddev-sans-first:11.06 08:22:41 INFO - PROCESS | 4693 | Values: 86.0 84.0 114.0 85.0 84.0 85.0 96.0 85.0 86.0 105.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.95 (0.8%) stddev-sans-first:0.88 08:22:41 INFO - PROCESS | 4693 | Values: 117.0 118.0 119.0 118.0 117.0 120.0 119.0 119.0 118.0 118.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 08:22:41 INFO - PROCESS | 4693 | Values: 151.0 150.0 151.0 151.0 152.0 151.0 149.0 150.0 151.0 150.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:1.18 (1.2%) stddev-sans-first:1.12 08:22:41 INFO - PROCESS | 4693 | Values: 95.0 97.0 95.0 97.0 96.0 96.0 97.0 97.0 99.0 96.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.01 08:22:41 INFO - PROCESS | 4693 | Values: 66.0 68.0 69.0 69.0 69.0 70.0 68.0 67.0 69.0 67.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 08:22:41 INFO - PROCESS | 4693 | Values: 67.0 69.0 67.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.06 (2.4%) stddev-sans-first:2.13 08:22:41 INFO - PROCESS | 4693 | Values: 88.0 92.0 86.0 85.0 87.0 86.0 86.0 86.0 85.0 86.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:147.50 stddev:17.46 (11.8%) stddev-sans-first:18.27 08:22:41 INFO - PROCESS | 4693 | Values: 141.0 147.0 148.0 135.0 155.0 136.0 144.0 133.0 192.0 161.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:178.50 stddev:3.30 (1.8%) stddev-sans-first:2.96 08:22:41 INFO - PROCESS | 4693 | Values: 184.0 177.0 177.0 177.0 175.0 179.0 178.0 185.0 181.0 177.0 08:22:41 INFO - PROCESS | 4693 | 08:22:41 INFO - PROCESS | 4693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 08:22:41 INFO - PROCESS | 4693 | Values: 70.0 70.0 70.0 71.0 72.0 71.0 70.0 69.0 69.0 69.0 08:22:41 INFO - PROCESS | 4693 | -------- Summary: end -------- 08:22:41 INFO - PROCESS | 4693 | 08:22:42 INFO - TEST-INFO | 4693: exit 0 08:22:42 INFO - TEST-OK | kraken | took 63500ms 08:22:42 INFO - SUITE-END | took 1181s 08:22:42 INFO - Completed test suite (00:19:41) 08:22:42 INFO - javascript benchmark 08:22:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6234.9451546719665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.1390034338497, 2577.5489289374377, 2579.703334116577, 2599.805014623903, 2605.1533251693204, 4655.4878963314, 4791.976040119795, 4849.296851956464, 4852.636052296074, 4853.684510506814, 4682.086993036351, 4803.231482962727, 4837.612990960723, 4847.563719265266, 4879.560839524442, 4384.167008268419, 4437.644988400936, 4461.866144015685, 4512.435945506812, 4546.340780586829, 4112.177564487115, 4556.681032327739, 4568.7944042518, 4583.175028494869, 4593.081383723269, 4404.647628189737, 4443.0, 4451.465824101097, 4489.573490518395, 4557.384753058344, 4363.083752411997, 4373.759443230621, 4398.494173170095, 4422.0, 4477.507474177838, 4363.781810909473, 4376.606105450524, 4378.387025816388, 4384.912301753979, 4390.780460976938, 4690.742009189493, 4701.600363969067, 4741.739204343759, 4746.0, 4777.235642297216, 5002.099622068026, 5034.899302013976, 5085.0, 5110.437851836295, 5112.36095488064, 5163.0, 5166.715830629314, 5172.482751724835, 5173.17229243323, 5208.817691380784, 4808.704111819264, 4827.396575428072, 4827.734474603931, 4827.806887724451, 4882.316475693406, 5178.042062218502, 5187.066328060985, 5191.221316802435, 5226.529612334908, 5264.710440925709, 5000.724960127228, 5005.174146265898, 5015.924761128586, 5038.067957427887, 5061.645684802029, 5069.746512674352, 5072.721000344943, 5075.87310317245, 5083.313752643419, 5125.948740512622, 4972.179590367621, 4996.1007018736245, 5012.624053196025, 5037.949620503748, 5056.443791182967, 5052.242163675478, 5142.30578871855, 5143.948560514347, 5148.485151484896, 5151.793928242828, 4322.783860806947, 4345.826166953287, 4349.369341445473, 4352.064306174188, 4391.0, 3781.697464202857, 3784.038256646575, 3784.8296826642318, 3788.3938569829247, 3820.4842346282894, 4267.253230684618, 4315.503717072577, 4320.330348795942, 4358.782060897006, 4362.062156636339, 5186.40356359016, 5196.064708352457, 5199.350081239845, 5201.557867581222, 5238.292830467838, 4340.631046361032, 4357.281048627005, 4358.6730995175485, 4366.061296821199, 4402.5597440255715, 4533.433320834895, 4564.954350456519, 4590.563896429834, 4610.193216187154, 4633.189191891405, 4728.479867214535, 4741.028089241629, 4759.0719809636785, 4774.95225047745, 4780.880477988078, 5062.949370506395, 5093.516115968977, 5105.387353517602, 5109.412417571878, 5138.691678499302, 4789.592884604708, 4790.353302304145, 4801.4718380977365, 4834.5890599298045, 4840.0, 5096.0827051131155, 5098.260752190986, 5111.3355263815465, 5116.1046816806165, 5151.098557752453, 4983.651144419856, 5032.320636714143, 5094.465081166572, 5179.0, 5226.843194704165, 4975.9004819902675, 4977.626677999092, 4984.2025275955675, 5010.69935803853, 5039.798408063636, 4990.451050384528, 4997.300377947017, 5016.498350164954, 5017.523335283142, 5024.924626130684, 4798.904021919612, 4860.173770459101, 4903.994681090297, 4929.778159982881, 4996.400431948189, 4990.80036798524, 4999.350084488993, 5002.974985125051, 5055.772490237875, 5094.745262736774, 4894.412670479565, 4897.534734200245, 4902.754862256944, 4919.163742163769, 4946.579540739078], "value": 4694.681476685976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.8200647766804, 512.9256257842613, 516.506736067056, 519.1278651864868, 544.9400915219894, 36084.639153608456, 36970.26059478809, 37061.99999999996, 37140.81429592848, 37150.25699486009, 38065.8096709516, 38293.617063829355, 38362.42456363157, 38392.80803595985, 38536.0, 7502.924970750304, 7669.118051424074, 7674.386049116058, 7690.500117492373, 9445.527723613826, 9326.580303886307, 9595.376300540478, 9600.279979001569, 9600.711978640617, 9611.95194024029, 9594.616215351378, 9599.0, 9635.614575416976, 9655.710328690151, 9675.129238368545, 9519.23846092318, 9570.0, 9621.855672164924, 9624.422534647874, 9629.711108666786, 9436.622535098588, 9513.809723805485, 9517.904820951771, 9519.476428796483, 9536.2371010319, 32651.510227346607, 32977.505337419956, 33137.0, 33143.502847457305, 33216.33567328664, 3537.2925414916863, 3656.9085772855624, 3658.762180458262, 3659.597444281127, 3689.8893033209047, 25055.87472062628, 25230.747692523022, 25430.0, 25635.230943071736, 26143.607845882136, 3331.68349006844, 3360.764746467724, 3365.5624768779903, 3422.819127401043, 3442.6729460701195, 235360.0, 236856.0, 236922.0, 237721.0, 237781.0, 44820.77589612031, 44956.77521612371, 45091.77454112709, 45119.0, 45249.77375113103, 46083.53916460859, 46096.0, 46395.5360446398, 46486.30270545944, 46628.53371466242, 10751.731206719738, 10858.891411085946, 10971.83542246867, 11001.22991390595, 11010.944945275221, 7289.635518224068, 7362.300581444754, 8676.696315628922, 8847.292216622784, 8907.153820387053, 15183.0, 15185.62035949088, 15192.696146077016, 15213.0, 15301.770473442908, 6222.968885155546, 6328.430441260309, 6395.584287021329, 6486.156799616019, 6489.707963141575, 700.8212905709114, 718.4360277182386, 719.8668246374333, 721.7401735375261, 722.7398136670794, 26010.219693409228, 27214.0, 27559.0, 27740.0, 27837.304067398476, 820.1429506166071, 843.8312337532518, 850.0521918061318, 862.1809281182901, 863.2921004776149, 13919.234442105579, 14328.785068223984, 14567.500810858097, 14793.63015924589, 14898.553043408716, 332085.0, 335586.0, 335622.0, 336193.0, 336412.0, 47685.0, 47976.7601161992, 48021.519784801705, 48045.5195448048, 48081.75959120252, 1043.9373637581618, 1158.9942050289694, 1208.1965492947268, 1214.684182112657, 1218.0438355890406, 24473.38816529601, 25172.24483265505, 25872.8706356467, 26255.212343629722, 26357.34106647349, 38866.805665971486, 39419.80290098531, 39453.0, 39464.60535394609, 39583.40624890687, 278857.0, 279060.0, 280402.0, 280520.0, 280653.0, 22918.19786307471, 38859.0, 39249.80375098106, 39349.60650393574, 39356.50617648171, 37910.24179516339, 38118.809405952794, 39378.80310598428, 41912.0, 43113.35329970116, 36501.63498364983, 36963.44554831626, 37217.0, 38251.23497529978, 38404.42393364158, 36428.81785591055, 36637.26725465529, 37075.81462092672, 37477.62522374741, 37485.0, 36168.27663446769, 36300.45549316815, 36640.0, 36675.633243667224, 36680.26639467249, 31457.370852583277, 34054.8297258522, 34119.48820767641, 34121.82939085289, 34148.31703365968, 23208.535829283657, 23335.41661458477, 23560.920970752955, 23881.761182387952, 23922.28233153008], "value": 16908.275762149653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7297663240886, 377.4074702716734, 384.4156881540059, 385.9864904728335, 391.408972451598, 15663.0, 16977.06626135562, 17077.658446831058, 17095.91452042741, 17263.0, 16182.919085404586, 16473.752893706605, 16888.746668799948, 17055.232514536845, 17057.232424540893, 4859.465458799538, 5104.489551044903, 5107.61692873036, 5110.259012443194, 5111.386633603973, 5034.395872495305, 5194.948050519503, 5465.9726701366435, 5494.532964698005, 5557.861053473655, 5532.170174473821, 5534.529564986981, 5541.27963364764, 5542.889142217174, 5543.36251331096, 5287.233351164079, 5378.354597448311, 5420.186971954218, 5422.566194704415, 5453.945460545384, 5260.684358938476, 5297.841064768063, 5302.2841916341185, 5318.095923692981, 5323.494268044529, 12367.072469564819, 17467.213975371138, 18522.722159167624, 19519.414417567496, 19525.0, 2080.552681173555, 2112.862663926855, 2130.2437634639637, 2135.9021036601903, 2255.966160507577, 8656.523891185981, 8930.955345223298, 9383.0, 9522.571484283224, 9637.566309516089, 1563.3043295733403, 1564.4759005732978, 1568.4196847166506, 1584.952451426459, 1587.936482540697, 64182.35817641811, 65049.0, 65188.67405662989, 66177.99999999952, 67792.0, 9842.0, 9855.31012829095, 9977.201823854075, 10007.949960250298, 10029.097381235579, 13605.659858503419, 13670.863291367157, 13734.313284335743, 13776.517821876187, 13778.517751878837, 6385.840353991188, 6674.299198584175, 6794.898076528856, 6931.549449285781, 6958.721651133999, 6205.937940620536, 6234.3453937336835, 6452.322506136882, 6456.451201647818, 6462.772073306057, 4158.708890377705, 4196.622303992655, 4211.7262377945335, 4243.957560424418, 4359.891002724894, 1536.4238410596026, 1594.7129516686875, 1617.70583533173, 1831.597048649295, 1884.3122260374864, 799.4883274704194, 810.2343285595056, 813.7874566895283, 835.7450977451936, 836.3727204596553, 15376.077435353915, 15432.92283538575, 15463.0, 15531.611709707347, 15535.689286214212, 793.0443815202667, 795.1809636074852, 811.3347055414504, 813.495632707725, 821.117298903681, 8322.421358815647, 8530.573471326408, 8709.564521773886, 9083.591238394289, 9593.760155996157, 351767.0, 354318.0, 355158.0, 358867.0, 359833.0, 74447.25552744512, 75619.24380756122, 75788.24211757812, 76310.0, 77184.0, 882.1663527966139, 915.8580420034905, 922.4188761080476, 931.3480563605503, 934.4860326820358, 15378.0, 15581.766273506133, 15589.688206235585, 15786.605334866721, 15802.60493487626, 34764.47853282253, 35072.47391289082, 35334.646653533135, 35754.821225894746, 36042.0, 45386.0, 46798.0, 46860.0, 48553.0, 49361.0, 7321.743738969323, 7366.263373662591, 7446.962765186139, 7538.660760265691, 8073.87889181651, 9023.90976090257, 10800.135989121009, 11039.83440248413, 11334.433278336215, 11437.485313161094, 9303.209227215762, 9556.474393908124, 9656.855147172657, 9731.805363892825, 9742.123208910949, 9302.95348523253, 9643.9035609643, 9779.364341317792, 9963.35238209543, 9996.500174991366, 8832.0, 8878.200961913459, 9241.075892410705, 9259.814803704023, 9326.253899688145, 6770.8645827084165, 6977.546459480118, 7046.401055910305, 8011.278984891388, 8088.555129467935, 9049.638014479611, 9402.95298523503, 9547.952260238655, 9558.709574207393, 9692.22462203008], "value": 7887.982128966574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.8030795380687, 1314.4610709609055, 1316.6313432238974, 1319.571139379702, 1320.0825426328702, 6662.933370666292, 6877.6217308048035, 7024.1922178949435, 7410.925890741098, 7470.551766893984, 6933.514653974224, 7142.2857714228685, 7143.3570978611915, 7299.270072992698, 7310.049693539832, 2107.852450328474, 2123.2674727219087, 2142.678598210265, 2144.6997420361163, 2153.6446486329814, 1994.441556364213, 2045.4068320187127, 2053.281351526961, 2148.140743702516, 2232.8660280383147, 2185.191479152708, 2211.148707747521, 2212.6017316882953, 2215.1471683401924, 2215.7341119065654, 2084.6351888419467, 2085.35354040248, 2091.4144039668995, 2101.3065688322818, 2110.1242984161554, 2116.2487317002397, 2119.95760084799, 2125.171183238538, 2134.8932553372424, 2144.2066435418838, 7433.516821406592, 7473.0, 7509.924900750977, 7528.924710752932, 7530.43521735872, 4510.797014134372, 4566.862994110182, 4597.0, 4641.883952901171, 4642.0, 2761.502929472694, 2948.5110019440044, 2979.9851000744857, 3022.4106299271652, 3055.052933590594, 1098.2970898624887, 1101.3336931156696, 1128.227164392394, 1143.7140714821294, 1158.3050169897995, 9706.902930970671, 9739.56171972263, 9835.852462213072, 9873.80252394948, 9895.505224738663, 3756.248750249906, 3970.5830887756947, 3993.4608827808456, 4034.8386064557676, 4058.188362327546, 7643.847123057508, 7664.540127592362, 7665.578393188428, 7679.078510578766, 7691.923080769233, 4382.627476664456, 4462.129884672523, 4467.218236808546, 4490.618297444688, 4502.414686090853, 3955.4660120883314, 4145.046639272984, 4220.620144186976, 4220.683448741357, 4229.619334259932, 3264.8041117533025, 3296.1100502864574, 3357.278185190147, 3366.7811592246426, 3382.323535292902, 915.3226612306845, 939.9436033837992, 1030.3354336453096, 1057.836035414512, 1059.0680201422854, 722.7109156337402, 734.6069852628818, 752.1650967426152, 753.7814033930208, 761.2425636491615, 4419.248727716296, 4742.241241401428, 4805.783739731721, 4807.711537307773, 4809.759512024385, 812.5937031484258, 814.4583851738528, 823.3660081737029, 833.5657092777794, 842.6418772021866, 3205.1826784170353, 3206.8396580170897, 3247.594050743657, 3267.950980735291, 3323.9833800831325, 8465.449745766506, 8852.778680532909, 8867.512286824287, 8874.86687699685, 8876.911230887608, 8821.867671984925, 8868.379213455126, 8884.067172946876, 8892.822143557221, 8900.955495222612, 6935.202451718016, 7005.299470052954, 7031.859362812817, 7034.472414568928, 7035.296470352924, 4669.136209801198, 4724.858254252378, 4768.213244814706, 4820.614350851994, 4929.408470983505, 8032.959835200787, 8103.756887293391, 8109.432339736398, 8122.309603683753, 8130.105688374156, 8185.181481851767, 8208.46644968075, 8223.0, 8282.088970213392, 8307.044689860744, 6018.067199584071, 6076.088586712029, 6085.1785009023215, 6090.2996155440915, 6095.786647467317, 6603.306652801387, 6664.600123992576, 6698.39714425704, 6728.865422691617, 6855.965720171367, 5267.420583735709, 5979.880402392015, 6017.157597936205, 6074.1799857020505, 6096.237970253718, 6005.969970150121, 6042.395760424099, 6057.151998720271, 6057.606255593372, 6138.508919286535, 5267.394249661338, 5398.541124004347, 5441.347038355423, 5503.036968530571, 5507.146392309199, 4197.559256278169, 4199.307114326102, 4260.95739042618, 4318.769150792009, 4419.779011049371, 3983.3626619740703, 4036.414719865662, 4068.9186216276103, 4097.672186225154, 4215.178040282116], "value": 3867.912562712531, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.72839913266785, 356.57033274903745, 358.11009641042017, 359.5900673232514, 362.8693670278701, 4971.005798840229, 5016.598672106232, 5017.523335283151, 5045.217991211368, 5060.190369540875, 4928.5564299213065, 4940.2342636891335, 4943.505649435064, 4957.810650000743, 4976.751162441881, 3729.9067523311996, 3856.730028897964, 3896.6687831534355, 3901.531816182048, 4069.8168582413787, 3829.444730514074, 3861.555921069071, 3873.7288389812725, 3879.9806000970098, 3887.5529314128953, 3853.6339047790557, 3864.3237433449176, 3872.3223435898744, 3872.7676339419586, 3876.3216437123533, 3658.304922064799, 3860.401637746154, 3861.8607510784386, 3877.1664092220167, 3880.417937309398, 3353.9496907546404, 3370.1406141433777, 3371.3088816792497, 3372.6121496028027, 3384.560007199073, 4826.710397376169, 4826.758662066918, 4842.322074909515, 4849.2968519564465, 4856.858638220016, 4326.848560300375, 4336.848210312624, 4342.956570434319, 4346.956530434687, 4349.456317960255, 4862.878428039327, 5097.541221290065, 5111.642185047048, 5169.508896654812, 5186.351706036746, 3690.6309369063147, 3699.8335074921692, 3704.018435114697, 3707.9629203707887, 3709.870154544578, 5279.392869819982, 5421.186821976696, 5457.890842183174, 5468.890622187574, 5477.835664930059, 4027.234825383168, 4059.4316795648633, 4073.103917138225, 4074.674026077966, 4077.082656402286, 4126.381042843537, 4127.236461254677, 4133.7106402551535, 4138.772367519755, 4159.209750147463, 4453.910921781546, 4545.6136228420955, 4566.589006989387, 4601.700889442175, 4608.170529304691, 5179.637425380187, 5219.582433405319, 5231.852573226443, 5236.476352364733, 5257.5005374489365, 1361.6800051987775, 1385.2450414524108, 1395.5813256023152, 1403.6701375176826, 1405.5221224783418, 958.2669258017622, 979.1628157924872, 984.3995162950595, 990.7721224118493, 1002.7242508310127, 4314.0, 4322.913541729211, 4325.740455572675, 4334.739915605074, 4335.4363932689175, 5188.584913206934, 5206.5314121729225, 5212.931349073507, 5220.243064755589, 5238.397584277781, 4080.265552200573, 4334.544872788375, 4336.566343365701, 4349.478062632505, 4376.089900216384, 2769.1969328894797, 2779.207925741154, 2783.580374009229, 2788.60959465675, 2788.60959465675, 4817.662763606514, 4834.347363106006, 4838.491958344393, 4842.467328593852, 4845.297431872429, 5031.7987280509105, 5296.364436267596, 5305.761240744176, 5309.973450132725, 5360.544353729977, 4777.928331075037, 4794.760261986887, 4797.625175538131, 4801.207800712843, 4806.687565308243, 5175.896482070413, 5176.818811341585, 5180.119379705384, 5197.24639927216, 5205.947940520547, 4972.8508144755715, 5120.233519435788, 5140.317587136782, 5142.357205349332, 5317.680939143509, 4861.635377346784, 4995.875103122451, 4997.875053123701, 5011.799528018839, 5014.924776128288, 3714.1457464783794, 3717.182219911615, 3720.1443667957064, 3725.70194384454, 3753.6809371203753, 5426.511613954763, 5440.483154100354, 5453.182022696627, 5462.24156800813, 5471.425500322409, 5036.219385995177, 5225.817096401608, 5250.899640143973, 5262.8947421052135, 5309.2301616266195, 5249.4225635180865, 5251.159814429673, 5251.868703282448, 5258.711615654189, 5270.367555893317, 5203.19350500673, 5215.973920130375, 5250.159974404077, 5254.42201357858, 5256.500632439912, 4945.332380128637, 5195.376554813447, 5233.476652334736, 5272.578193744414, 5349.251104845403, 5111.9870901342265, 5133.230015497706, 5134.15286477727, 5140.691558506352, 5144.459831717616], "value": 3936.967671463284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.1684851813934, 661.784919901032, 692.0277010799828, 698.2528694297102, 707.4800021983842, 12424.192427492208, 12606.180598261106, 12676.302803345812, 12841.807372889403, 12916.677083072927, 12270.447829847679, 12683.429245683943, 12871.227726336427, 12915.0, 12934.159279646816, 805.1827395193883, 824.1511243419287, 826.8801023851538, 827.4166712467726, 829.9543525106117, 794.6741835847304, 802.6869520886859, 808.8139727862596, 834.1450013735908, 835.3692961813822, 859.9269062129695, 868.5266529741275, 870.9042005379404, 871.4422769427572, 875.1248751248751, 853.6116067189414, 856.3534531428794, 857.6483641706901, 858.2704701004128, 859.3640705877668, 636.4717284653726, 636.837606410367, 637.4263163153153, 638.1767519899324, 638.4509321983137, 13189.472421103144, 13401.731965360736, 13425.731485370336, 13441.126326788728, 14049.227292498908, 10982.670519884416, 11448.0, 11917.940410297893, 12337.568185113478, 13366.732665346639, 11041.503132359063, 11345.489452974636, 11451.94274028633, 11532.94233528827, 12114.575989840401, 4201.33215408218, 4209.326507758744, 4250.744955302692, 4392.802323895432, 4405.449318835145, 64454.3554564453, 65319.3468065318, 65496.67251663711, 66301.0, 66442.3355766441, 9376.671816486527, 9593.328467007383, 9595.568199431042, 9610.807783844284, 9616.567254473426, 17417.912910435367, 17441.0, 17444.563885902953, 17537.0, 17596.384126555764, 6183.319834818167, 6227.459240345384, 6259.906101408483, 6325.65208913505, 6355.237371515448, 3381.8309084545676, 3397.405454045532, 3424.7945123292684, 3431.9142021449666, 3435.6736110069505, 2589.210290861268, 2617.2148355493277, 2631.7499837515406, 2632.447186090904, 2632.6972398174457, 470.92936059591335, 472.4566748239552, 474.3454033433839, 479.09212043177985, 481.57621293261707, 561.5732043646858, 574.0786038408295, 575.4648177195165, 578.673049726903, 582.251806428737, 7329.450291228072, 7360.815979600553, 7386.15059268191, 7440.813979650552, 7450.478466507401, 479.63787340557656, 496.7193535652417, 498.07109740334016, 517.8317046959753, 522.9555487783581, 3354.8322583871195, 3580.2839432113683, 3597.514335564665, 3660.633936606318, 3697.482352470656, 66176.0, 66391.66804165948, 66749.66625166843, 68072.65963670249, 68624.6568767163, 58091.70954145202, 58183.0, 58756.70621646864, 59266.0, 59783.70108149431, 50052.0, 51471.48528514667, 51566.0, 52161.0, 52571.0, 6766.391024807594, 7045.577265364094, 7128.465365097535, 7167.371300671475, 7167.7132914682825, 37873.62126378811, 37930.81034594809, 38053.809730951165, 38949.0, 39760.60239397569, 48031.5196848041, 48914.0, 49577.25634115563, 49769.25346119884, 50296.24555631595, 8398.87401688963, 8410.411271210956, 8552.700655477029, 10645.414502202453, 10706.464676765974, 12054.337011464453, 12438.564650237198, 12567.802477498893, 12766.29785361814, 13163.736725265633, 10724.463776810971, 10820.56717731282, 10942.835857461985, 11990.760184796081, 11991.22057066288, 11084.16868734832, 11233.66299011031, 11269.49287282058, 11463.942680286878, 11806.173567850168, 10323.277370583986, 11056.447177640925, 11208.159388045766, 11581.015613672933, 11880.762384752084, 9148.542572871196, 9495.715128546155, 9662.516874156405, 9714.854277185988, 9905.702828915144, 9256.120668536478, 9458.574364153767, 9507.809843802946, 9510.857337140087, 9661.46861922601], "value": 6160.806435078645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 114.0, 115.0, 116.0, 115.0, 118.0, 115.0, 116.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 127.0, 171.0, 138.0, 139.0, 129.0, 133.0, 153.0, 132.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 165.0, 175.0, 164.0, 163.0, 165.0, 164.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 102.0, 77.0, 77.0, 76.0, 76.0, 95.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 114.0, 85.0, 84.0, 85.0, 96.0, 85.0, 86.0, 105.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 118.0, 117.0, 120.0, 119.0, 119.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 152.0, 151.0, 149.0, 150.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 96.0, 96.0, 97.0, 97.0, 99.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 67.0, 69.0, 67.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 86.0, 85.0, 87.0, 86.0, 86.0, 86.0, 85.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 147.0, 148.0, 135.0, 155.0, 136.0, 144.0, 133.0, 192.0, 161.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 177.0, 177.0, 175.0, 179.0, 178.0, 185.0, 181.0, 177.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 71.0, 72.0, 71.0, 70.0, 69.0, 69.0, 69.0], "value": 70.1, "unit": "score"}]}]} 08:22:42 INFO - Return code: 0 08:22:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:42 ERROR - # TBPL SUCCESS # 08:22:42 INFO - Running post-action listener: _resource_record_post_action 08:22:42 INFO - [mozharness: 2016-12-28 16:22:42.873661Z] Finished run-tests step (success) 08:22:42 INFO - Running post-run listener: _resource_record_post_run 08:22:42 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393859072; Read time: 16; Write time: 270476 08:22:42 INFO - TinderboxPrint: CPU usage
13.5% 08:22:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:22:42 INFO - TinderboxPrint: I/O write bytes / time
393,859,072 / 270,476 08:22:42 INFO - TinderboxPrint: CPU idle
8,267.0 (86.5%) 08:22:42 INFO - TinderboxPrint: CPU user
1,233.1 (12.9%) 08:22:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110649344; Read time: 0; Write time: 78660 08:22:42 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 283209728; Read time: 0; Write time: 191816 08:22:43 INFO - Running post-run listener: _upload_blobber_files 08:22:43 INFO - Blob upload gear active. 08:22:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:44 INFO - (blobuploader) - INFO - Done attempting. 08:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:45 INFO - (blobuploader) - INFO - Done attempting. 08:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:46 INFO - (blobuploader) - INFO - Done attempting. 08:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:50 INFO - (blobuploader) - INFO - Done attempting. 08:22:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:50 INFO - Return code: 0 08:22:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8ce3658e5d18b412f88b3002fb8bbbe62cecac0db144371ac627d5ddedf8aa507e2c21848c501b17ec65a1e47b927f424968c9f326f66575a4c03eb28b1fdcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59aef7aa21150cc3d18adbd6b6d975100606da940f3f3e1fa4e0ffeb6656a02dd8093a61088c78f55691338c02229bf2ae49d8b71d0435170e6b8222e8bac5cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9db6d8c64977fbdfce8b6336932cc0a80dae00b449f1c4147762b888502090cfa6d82fe1b26dd50aff938727f7abe309d2f7e1c3c415e98b0ec13f4c0715d1e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fcf7ebb2f3d5336668097a12e907396c682337511309653a0bde798cc7ac60b33910863c46a0f8d2fe1feadde65f6ba46bd02d5f4bb61a3d3402dd71b86b658"} 08:22:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:50 INFO - Contents: 08:22:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8ce3658e5d18b412f88b3002fb8bbbe62cecac0db144371ac627d5ddedf8aa507e2c21848c501b17ec65a1e47b927f424968c9f326f66575a4c03eb28b1fdcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59aef7aa21150cc3d18adbd6b6d975100606da940f3f3e1fa4e0ffeb6656a02dd8093a61088c78f55691338c02229bf2ae49d8b71d0435170e6b8222e8bac5cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9db6d8c64977fbdfce8b6336932cc0a80dae00b449f1c4147762b888502090cfa6d82fe1b26dd50aff938727f7abe309d2f7e1c3c415e98b0ec13f4c0715d1e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fcf7ebb2f3d5336668097a12e907396c682337511309653a0bde798cc7ac60b33910863c46a0f8d2fe1feadde65f6ba46bd02d5f4bb61a3d3402dd71b86b658"} 08:22:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:50 INFO - Copying logs to upload dir... 08:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.911528 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-28 08:22:48.992579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 08:22:48.996592) ========= 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=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8ce3658e5d18b412f88b3002fb8bbbe62cecac0db144371ac627d5ddedf8aa507e2c21848c501b17ec65a1e47b927f424968c9f326f66575a4c03eb28b1fdcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59aef7aa21150cc3d18adbd6b6d975100606da940f3f3e1fa4e0ffeb6656a02dd8093a61088c78f55691338c02229bf2ae49d8b71d0435170e6b8222e8bac5cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9db6d8c64977fbdfce8b6336932cc0a80dae00b449f1c4147762b888502090cfa6d82fe1b26dd50aff938727f7abe309d2f7e1c3c415e98b0ec13f4c0715d1e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fcf7ebb2f3d5336668097a12e907396c682337511309653a0bde798cc7ac60b33910863c46a0f8d2fe1feadde65f6ba46bd02d5f4bb61a3d3402dd71b86b658"} build_url:https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/HNVlJchETKyMNlS93wABHQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8ce3658e5d18b412f88b3002fb8bbbe62cecac0db144371ac627d5ddedf8aa507e2c21848c501b17ec65a1e47b927f424968c9f326f66575a4c03eb28b1fdcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59aef7aa21150cc3d18adbd6b6d975100606da940f3f3e1fa4e0ffeb6656a02dd8093a61088c78f55691338c02229bf2ae49d8b71d0435170e6b8222e8bac5cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9db6d8c64977fbdfce8b6336932cc0a80dae00b449f1c4147762b888502090cfa6d82fe1b26dd50aff938727f7abe309d2f7e1c3c415e98b0ec13f4c0715d1e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fcf7ebb2f3d5336668097a12e907396c682337511309653a0bde798cc7ac60b33910863c46a0f8d2fe1feadde65f6ba46bd02d5f4bb61a3d3402dd71b86b658"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 08:22:49.023615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:22:49.024118) ========= 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=0333a256a5e4f052382dd180000001b1-1482932113.876316-1678130063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:22:49.106101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 08:22:49.106532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 08:22:49.106872) ========= ========= Total master_lag: 0.17 =========