builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1474542728.29 results: success (0) buildid: 20160922025458 builduid: 156a8247997649eebfa071c0c1cf2c62 revision: 612a50c5350689a8e465d0a542a37e32613a88bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.295255) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.295651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.295964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.391471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.391726) ========= 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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 04:12:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-09-22 04:12:09 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148899 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.618714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.618997) ========= 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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019729 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.662919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:08.663243) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 612a50c5350689a8e465d0a542a37e32613a88bd --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 612a50c5350689a8e465d0a542a37e32613a88bd --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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 04:12:09,450 truncating revision to first 12 chars 2016-09-22 04:12:09,450 Setting DEBUG logging. 2016-09-22 04:12:09,450 attempt 1/10 2016-09-22 04:12:09,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/612a50c53506?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 04:12:09,873 unpacking tar archive at: mozilla-central-612a50c53506/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760449 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:09.438050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:09.438373) ========= script_repo_revision: 612a50c5350689a8e465d0a542a37e32613a88bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:09.438783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:09.439048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 04:12:09.448021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-22 04:12:09.448427) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:10 INFO - MultiFileLogger online at 20160922 04:12:10 in /builds/slave/test 04:12:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:12:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:10 INFO - {'append_to_log': False, 04:12:10 INFO - 'base_work_dir': '/builds/slave/test', 04:12:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:12:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:10 INFO - 'branch': 'Firefox-Non-PGO', 04:12:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:10 INFO - 'config_files': ('talos/linux_config.py',), 04:12:10 INFO - 'default_actions': ('clobber', 04:12:10 INFO - 'read-buildbot-config', 04:12:10 INFO - 'download-and-extract', 04:12:10 INFO - 'populate-webroot', 04:12:10 INFO - 'create-virtualenv', 04:12:10 INFO - 'install', 04:12:10 INFO - 'run-tests'), 04:12:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:10 INFO - 'download_minidump_stackwalk': True, 04:12:10 INFO - 'download_symbols': 'ondemand', 04:12:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:10 INFO - 'installer_path': 'installer.exe', 04:12:10 INFO - 'log_level': 'info', 04:12:10 INFO - 'log_name': 'talos', 04:12:10 INFO - 'log_to_console': True, 04:12:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:10 INFO - 'opt_config_files': (), 04:12:10 INFO - 'pip_index': False, 04:12:10 INFO - 'sps_profile': False, 04:12:10 INFO - 'sps_profile_interval': 0, 04:12:10 INFO - 'suite': 'dromaeojs', 04:12:10 INFO - 'system_bits': '32', 04:12:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:10 INFO - 'title': 'talos-linux64-ix-008', 04:12:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:10 INFO - 'use_talos_json': True, 04:12:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:10 INFO - 'work_dir': 'build'} 04:12:10 INFO - [mozharness: 2016-09-22 11:12:10.327944Z] Running clobber step. 04:12:10 INFO - Running pre-action listener: _resource_record_pre_action 04:12:10 INFO - Running main action method: clobber 04:12:10 INFO - rmtree: /builds/slave/test/build 04:12:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:11 INFO - Running post-action listener: _resource_record_post_action 04:12:11 INFO - [mozharness: 2016-09-22 11:12:11.310074Z] Finished clobber step (success) 04:12:11 INFO - [mozharness: 2016-09-22 11:12:11.310174Z] Running read-buildbot-config step. 04:12:11 INFO - Running pre-action listener: _resource_record_pre_action 04:12:11 INFO - Running main action method: read_buildbot_config 04:12:11 INFO - Using buildbot properties: 04:12:11 INFO - { 04:12:11 INFO - "project": "", 04:12:11 INFO - "product": "firefox", 04:12:11 INFO - "script_repo_revision": "production", 04:12:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:12:11 INFO - "repository": "", 04:12:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:12:11 INFO - "buildid": "20160922025458", 04:12:11 INFO - "pgo_build": "False", 04:12:11 INFO - "basedir": "/builds/slave/test", 04:12:11 INFO - "buildnumber": 217, 04:12:11 INFO - "slavename": "talos-linux64-ix-008", 04:12:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:12:11 INFO - "platform": "ubuntu64_hw", 04:12:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:12:11 INFO - "branch": "mozilla-central", 04:12:11 INFO - "repo_path": "mozilla-central", 04:12:11 INFO - "revision": "612a50c5350689a8e465d0a542a37e32613a88bd", 04:12:11 INFO - "stage_platform": "linux64", 04:12:11 INFO - "builduid": "156a8247997649eebfa071c0c1cf2c62", 04:12:11 INFO - "slavebuilddir": "test" 04:12:11 INFO - } 04:12:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:12:11 INFO - Running post-action listener: _resource_record_post_action 04:12:11 INFO - [mozharness: 2016-09-22 11:12:11.312629Z] Finished read-buildbot-config step (success) 04:12:11 INFO - [mozharness: 2016-09-22 11:12:11.312719Z] Running download-and-extract step. 04:12:11 INFO - Running pre-action listener: _resource_record_pre_action 04:12:11 INFO - Running main action method: download_and_extract 04:12:11 INFO - mkdir: /builds/slave/test/build/tests 04:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:11 INFO - trying https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:12:11 INFO - Downloaded 1361 bytes. 04:12:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:12:11 INFO - Using the following test package requirements: 04:12:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:12:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'jsshell-linux-x86_64.zip'], 04:12:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:12:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:12:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:12:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:12:12 INFO - Expected file size: 20372721 04:12:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:12:17 INFO - Expected file size: 20372721 04:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:12:22 INFO - Expected file size: 14414059 04:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:23 INFO - trying https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:26 INFO - Downloaded 55621928 bytes. 04:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:12:26 INFO - mkdir: /builds/slave/test/properties 04:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:26 INFO - Contents: 04:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:12:26 INFO - Running post-action listener: _resource_record_post_action 04:12:26 INFO - Running post-action listener: set_extra_try_arguments 04:12:26 INFO - [mozharness: 2016-09-22 11:12:26.954819Z] Finished download-and-extract step (success) 04:12:26 INFO - [mozharness: 2016-09-22 11:12:26.955048Z] Running populate-webroot step. 04:12:26 INFO - Running pre-action listener: _resource_record_pre_action 04:12:26 INFO - Running main action method: populate_webroot 04:12:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:26 INFO - '--tppagecycles', 04:12:26 INFO - '7'], 04:12:26 INFO - 'tests': ['tsvgm']}}, 04:12:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['damp', 'tps']}, 04:12:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'tests': ['damp', 'tps']}, 04:12:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['dromaeo_dom']}, 04:12:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['basic_compositor_video']}, 04:12:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:12:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['a11yr', 04:12:26 INFO - 'ts_paint', 04:12:26 INFO - 'tpaint', 04:12:26 INFO - 'sessionrestore', 04:12:26 INFO - 'sessionrestore_no_auto_restore', 04:12:26 INFO - 'tabpaint']}, 04:12:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['tsvgx', 04:12:26 INFO - 'tsvgr_opacity', 04:12:26 INFO - 'tart', 04:12:26 INFO - 'tscrollx', 04:12:26 INFO - 'cart']}, 04:12:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:26 INFO - 'tsvgr_opacity', 04:12:26 INFO - 'tart', 04:12:26 INFO - 'tscrollx', 04:12:26 INFO - 'cart']}, 04:12:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'talos_options': ['--disable-e10s'], 04:12:26 INFO - 'tests': ['tp5o']}, 04:12:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'tests': ['tp5o']}, 04:12:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'talos_options': ['--disable-e10s', 04:12:26 INFO - '--xperf_path', 04:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:26 INFO - 'tests': ['tp5n']}, 04:12:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:26 INFO - 'talos_options': ['--xperf_path', 04:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:26 INFO - 'tests': ['tp5n']}}, 04:12:26 INFO - 'talos.zip': {'path': '', 04:12:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:26 INFO - Running post-action listener: _resource_record_post_action 04:12:26 INFO - [mozharness: 2016-09-22 11:12:26.977519Z] Finished populate-webroot step (success) 04:12:26 INFO - [mozharness: 2016-09-22 11:12:26.977608Z] Running create-virtualenv step. 04:12:26 INFO - Running pre-action listener: _resource_record_pre_action 04:12:26 INFO - Running main action method: create_virtualenv 04:12:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:27 INFO - Using real prefix '/usr' 04:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:29 INFO - Installing pip.................done. 04:12:29 INFO - Return code: 0 04:12:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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', 'pip>=1.5'] in /builds/slave/test/build 04:12: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 pip>=1.5 04:12:29 INFO - Using env: {'DISPLAY': ':0', 04:12:29 INFO - 'HOME': '/home/cltbld', 04:12:29 INFO - 'LANG': 'en_US.UTF-8', 04:12:29 INFO - 'LANGUAGE': 'en_US:en', 04:12:29 INFO - 'LOGNAME': 'cltbld', 04:12:29 INFO - 'MAIL': '/var/mail/cltbld', 04:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:29 INFO - 'MOZ_NO_REMOTE': '1', 04:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:29 INFO - 'NO_EM_RESTART': '1', 04:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:29 INFO - 'PWD': '/builds/slave/test', 04:12:29 INFO - 'SHELL': '/bin/bash', 04:12:29 INFO - 'SHLVL': '1', 04:12:29 INFO - 'TERM': 'linux', 04:12:29 INFO - 'TMOUT': '86400', 04:12:29 INFO - 'USER': 'cltbld', 04:12:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:29 INFO - '_': '/tools/buildbot/bin/python'} 04:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:12:29 INFO - Cleaning up... 04:12:29 INFO - Return code: 0 04:12:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', '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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12: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 psutil>=3.1.1 04:12:29 INFO - Using env: {'DISPLAY': ':0', 04:12:29 INFO - 'HOME': '/home/cltbld', 04:12:29 INFO - 'LANG': 'en_US.UTF-8', 04:12:29 INFO - 'LANGUAGE': 'en_US:en', 04:12:29 INFO - 'LOGNAME': 'cltbld', 04:12:29 INFO - 'MAIL': '/var/mail/cltbld', 04:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:29 INFO - 'MOZ_NO_REMOTE': '1', 04:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:29 INFO - 'NO_EM_RESTART': '1', 04:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:29 INFO - 'PWD': '/builds/slave/test', 04:12:29 INFO - 'SHELL': '/bin/bash', 04:12:29 INFO - 'SHLVL': '1', 04:12:29 INFO - 'TERM': 'linux', 04:12:29 INFO - 'TMOUT': '86400', 04:12:29 INFO - 'USER': 'cltbld', 04:12:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:29 INFO - '_': '/tools/buildbot/bin/python'} 04:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:29 INFO - Downloading/unpacking psutil>=3.1.1 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:31 INFO - Installing collected packages: psutil 04:12:31 INFO - Running setup.py install for psutil 04:12:32 INFO - building 'psutil._psutil_linux' extension 04:12:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:12:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:12:32 INFO - building 'psutil._psutil_posix' extension 04:12:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:12:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:32 INFO - Successfully installed psutil 04:12:32 INFO - Cleaning up... 04:12:32 INFO - Return code: 0 04:12:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:12: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 mozsystemmonitor==0.3 04:12:32 INFO - Using env: {'DISPLAY': ':0', 04:12:32 INFO - 'HOME': '/home/cltbld', 04:12:32 INFO - 'LANG': 'en_US.UTF-8', 04:12:32 INFO - 'LANGUAGE': 'en_US:en', 04:12:32 INFO - 'LOGNAME': 'cltbld', 04:12:32 INFO - 'MAIL': '/var/mail/cltbld', 04:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:32 INFO - 'MOZ_NO_REMOTE': '1', 04:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:32 INFO - 'NO_EM_RESTART': '1', 04:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:32 INFO - 'PWD': '/builds/slave/test', 04:12:32 INFO - 'SHELL': '/bin/bash', 04:12:32 INFO - 'SHLVL': '1', 04:12:32 INFO - 'TERM': 'linux', 04:12:32 INFO - 'TMOUT': '86400', 04:12:32 INFO - 'USER': 'cltbld', 04:12:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:32 INFO - '_': '/tools/buildbot/bin/python'} 04:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:34 INFO - Installing collected packages: mozsystemmonitor 04:12:34 INFO - Running setup.py install for mozsystemmonitor 04:12:34 INFO - Successfully installed mozsystemmonitor 04:12:34 INFO - Cleaning up... 04:12:34 INFO - Return code: 0 04:12:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12:34 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')]} 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:34 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')]} 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:34 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:34 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 04:12:34 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 04:12:34 INFO - Using env: {'DISPLAY': ':0', 04:12:34 INFO - 'HOME': '/home/cltbld', 04:12:34 INFO - 'LANG': 'en_US.UTF-8', 04:12:34 INFO - 'LANGUAGE': 'en_US:en', 04:12:34 INFO - 'LOGNAME': 'cltbld', 04:12:34 INFO - 'MAIL': '/var/mail/cltbld', 04:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:34 INFO - 'MOZ_NO_REMOTE': '1', 04:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:34 INFO - 'NO_EM_RESTART': '1', 04:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:34 INFO - 'PWD': '/builds/slave/test', 04:12:34 INFO - 'SHELL': '/bin/bash', 04:12:34 INFO - 'SHLVL': '1', 04:12:34 INFO - 'TERM': 'linux', 04:12:34 INFO - 'TMOUT': '86400', 04:12:34 INFO - 'USER': 'cltbld', 04:12:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:34 INFO - '_': '/tools/buildbot/bin/python'} 04:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:35 INFO - Downloading/unpacking jsonschema==2.5.1 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:37 INFO - warning: no files found matching '*.txt' 04:12:37 INFO - no previously-included directories found matching 'build' 04:12:37 INFO - no previously-included directories found matching 'dist' 04:12:37 INFO - no previously-included directories found matching '.git*' 04:12:37 INFO - Installing collected packages: jsonschema, functools32 04:12:37 INFO - Running setup.py install for functools32 04:12:37 INFO - warning: no files found matching '*.txt' 04:12:37 INFO - no previously-included directories found matching 'build' 04:12:37 INFO - no previously-included directories found matching 'dist' 04:12:37 INFO - no previously-included directories found matching '.git*' 04:12:37 INFO - Successfully installed jsonschema functools32 04:12:37 INFO - Cleaning up... 04:12:37 INFO - Return code: 0 04:12:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:37 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')]} 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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')]} 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:37 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 04:12:37 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 04:12:37 INFO - Using env: {'DISPLAY': ':0', 04:12:37 INFO - 'HOME': '/home/cltbld', 04:12:37 INFO - 'LANG': 'en_US.UTF-8', 04:12:37 INFO - 'LANGUAGE': 'en_US:en', 04:12:37 INFO - 'LOGNAME': 'cltbld', 04:12:37 INFO - 'MAIL': '/var/mail/cltbld', 04:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:37 INFO - 'MOZ_NO_REMOTE': '1', 04:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:37 INFO - 'NO_EM_RESTART': '1', 04:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:37 INFO - 'PWD': '/builds/slave/test', 04:12:37 INFO - 'SHELL': '/bin/bash', 04:12:37 INFO - 'SHLVL': '1', 04:12:37 INFO - 'TERM': 'linux', 04:12:37 INFO - 'TMOUT': '86400', 04:12:37 INFO - 'USER': 'cltbld', 04:12:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:37 INFO - '_': '/tools/buildbot/bin/python'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:37 INFO - Cleaning up... 04:12:37 INFO - Return code: 0 04:12:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:37 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')]} 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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')]} 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:37 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 04:12:37 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 04:12:37 INFO - Using env: {'DISPLAY': ':0', 04:12:37 INFO - 'HOME': '/home/cltbld', 04:12:37 INFO - 'LANG': 'en_US.UTF-8', 04:12:37 INFO - 'LANGUAGE': 'en_US:en', 04:12:37 INFO - 'LOGNAME': 'cltbld', 04:12:37 INFO - 'MAIL': '/var/mail/cltbld', 04:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:37 INFO - 'MOZ_NO_REMOTE': '1', 04:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:37 INFO - 'NO_EM_RESTART': '1', 04:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:37 INFO - 'PWD': '/builds/slave/test', 04:12:37 INFO - 'SHELL': '/bin/bash', 04:12:37 INFO - 'SHLVL': '1', 04:12:37 INFO - 'TERM': 'linux', 04:12:37 INFO - 'TMOUT': '86400', 04:12:37 INFO - 'USER': 'cltbld', 04:12:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:37 INFO - '_': '/tools/buildbot/bin/python'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:40 INFO - Downloading docopt-0.6.1.tar.gz 04:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:40 INFO - Running setup.py install for blobuploader 04:12:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:40 INFO - Running setup.py install for requests 04:12:40 INFO - Running setup.py install for docopt 04:12:41 INFO - Successfully installed blobuploader requests docopt 04:12:41 INFO - Cleaning up... 04:12:41 INFO - Return code: 0 04:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:41 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:41 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 04:12:41 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 04:12:41 INFO - Using env: {'DISPLAY': ':0', 04:12:41 INFO - 'HOME': '/home/cltbld', 04:12:41 INFO - 'LANG': 'en_US.UTF-8', 04:12:41 INFO - 'LANGUAGE': 'en_US:en', 04:12:41 INFO - 'LOGNAME': 'cltbld', 04:12:41 INFO - 'MAIL': '/var/mail/cltbld', 04:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:41 INFO - 'MOZ_NO_REMOTE': '1', 04:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:41 INFO - 'NO_EM_RESTART': '1', 04:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:41 INFO - 'PWD': '/builds/slave/test', 04:12:41 INFO - 'SHELL': '/bin/bash', 04:12:41 INFO - 'SHLVL': '1', 04:12:41 INFO - 'TERM': 'linux', 04:12:41 INFO - 'TMOUT': '86400', 04:12:41 INFO - 'USER': 'cltbld', 04:12:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:41 INFO - '_': '/tools/buildbot/bin/python'} 04:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:41 INFO - Running setup.py (path:/tmp/pip-mkTBUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:41 INFO - Running setup.py (path:/tmp/pip-T2LEJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:41 INFO - Running setup.py (path:/tmp/pip-uVFVcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:41 INFO - Running setup.py (path:/tmp/pip-CtFAEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:41 INFO - Running setup.py (path:/tmp/pip-t7Ge3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:41 INFO - Running setup.py (path:/tmp/pip-BBe_0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:41 INFO - Running setup.py (path:/tmp/pip-yk1vgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:41 INFO - Running setup.py (path:/tmp/pip-VHKZYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:41 INFO - Running setup.py (path:/tmp/pip-UpegM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:41 INFO - Running setup.py (path:/tmp/pip-AhSP4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:42 INFO - Running setup.py (path:/tmp/pip-QXrTIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:42 INFO - Running setup.py (path:/tmp/pip-yOYu7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:42 INFO - Running setup.py (path:/tmp/pip-MOccrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:42 INFO - Running setup.py (path:/tmp/pip-iucEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:42 INFO - Running setup.py (path:/tmp/pip-iMbVgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:42 INFO - Running setup.py (path:/tmp/pip-lnAqy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:42 INFO - Running setup.py (path:/tmp/pip-xlbMhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:42 INFO - Running setup.py install for manifestparser 04:12:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:42 INFO - Running setup.py install for mozcrash 04:12:42 INFO - Running setup.py install for mozdebug 04:12:42 INFO - Running setup.py install for mozdevice 04:12:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:42 INFO - Running setup.py install for mozfile 04:12:43 INFO - Running setup.py install for mozhttpd 04:12:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for mozinfo 04:12:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for mozInstall 04:12:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for mozleak 04:12:43 INFO - Running setup.py install for mozlog 04:12:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for moznetwork 04:12:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for mozprocess 04:12:43 INFO - Running setup.py install for mozprofile 04:12:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:43 INFO - Running setup.py install for mozrunner 04:12:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:44 INFO - Running setup.py install for mozscreenshot 04:12:44 INFO - Running setup.py install for moztest 04:12:44 INFO - Running setup.py install for mozversion 04:12:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:44 INFO - Cleaning up... 04:12:44 INFO - Return code: 0 04:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:44 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:44 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 04:12:44 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 04:12:44 INFO - Using env: {'DISPLAY': ':0', 04:12:44 INFO - 'HOME': '/home/cltbld', 04:12:44 INFO - 'LANG': 'en_US.UTF-8', 04:12:44 INFO - 'LANGUAGE': 'en_US:en', 04:12:44 INFO - 'LOGNAME': 'cltbld', 04:12:44 INFO - 'MAIL': '/var/mail/cltbld', 04:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:44 INFO - 'MOZ_NO_REMOTE': '1', 04:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:44 INFO - 'NO_EM_RESTART': '1', 04:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:44 INFO - 'PWD': '/builds/slave/test', 04:12:44 INFO - 'SHELL': '/bin/bash', 04:12:44 INFO - 'SHLVL': '1', 04:12:44 INFO - 'TERM': 'linux', 04:12:44 INFO - 'TMOUT': '86400', 04:12:44 INFO - 'USER': 'cltbld', 04:12:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:44 INFO - '_': '/tools/buildbot/bin/python'} 04:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:44 INFO - Running setup.py (path:/tmp/pip-Cpj5tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:44 INFO - Running setup.py (path:/tmp/pip-RFYVEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:44 INFO - Running setup.py (path:/tmp/pip-Wrv2En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:44 INFO - Running setup.py (path:/tmp/pip-qypdLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:44 INFO - Running setup.py (path:/tmp/pip-W5Fwrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:44 INFO - Running setup.py (path:/tmp/pip-Ee7VqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:44 INFO - Running setup.py (path:/tmp/pip-p9a4m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:45 INFO - Running setup.py (path:/tmp/pip-_09E9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:45 INFO - Running setup.py (path:/tmp/pip-x7rLOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:45 INFO - Running setup.py (path:/tmp/pip-0J8yqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:45 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)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:45 INFO - Running setup.py (path:/tmp/pip-QZkTTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:45 INFO - Running setup.py (path:/tmp/pip-ng1nxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:45 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)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:45 INFO - Running setup.py (path:/tmp/pip-Yb7jws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:45 INFO - Running setup.py (path:/tmp/pip-xRSo36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:45 INFO - Running setup.py (path:/tmp/pip-bVybEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:45 INFO - Running setup.py (path:/tmp/pip-mQ9uQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:45 INFO - Running setup.py (path:/tmp/pip-QI_1y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:47 INFO - Downloading blessings-1.6.tar.gz 04:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:47 INFO - Installing collected packages: blessings 04:12:47 INFO - Running setup.py install for blessings 04:12:47 INFO - Successfully installed blessings 04:12:47 INFO - Cleaning up... 04:12:47 INFO - Return code: 0 04:12:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:48 INFO - Reading from file tmpfile_stdout 04:12:48 INFO - Current package versions: 04:12:48 INFO - argparse == 1.2.1 04:12:48 INFO - blessings == 1.6 04:12:48 INFO - blobuploader == 1.2.4 04:12:48 INFO - docopt == 0.6.1 04:12:48 INFO - functools32 == 3.2.3-2 04:12:48 INFO - jsonschema == 2.5.1 04:12:48 INFO - manifestparser == 1.1 04:12:48 INFO - mozInstall == 1.12 04:12:48 INFO - mozcrash == 0.17 04:12:48 INFO - mozdebug == 0.1 04:12:48 INFO - mozdevice == 0.48 04:12:48 INFO - mozfile == 1.2 04:12:48 INFO - mozhttpd == 0.7 04:12:48 INFO - mozinfo == 0.9 04:12:48 INFO - mozleak == 0.1 04:12:48 INFO - mozlog == 3.4 04:12:48 INFO - moznetwork == 0.27 04:12:48 INFO - mozprocess == 0.23 04:12:48 INFO - mozprofile == 0.28 04:12:48 INFO - mozrunner == 6.12 04:12:48 INFO - mozscreenshot == 0.1 04:12:48 INFO - mozsystemmonitor == 0.3 04:12:48 INFO - moztest == 0.7 04:12:48 INFO - mozversion == 1.4 04:12:48 INFO - psutil == 3.1.1 04:12:48 INFO - requests == 1.2.3 04:12:48 INFO - wsgiref == 0.1.2 04:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:48 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 04:12:48 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 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:48 INFO - Cleaning up... 04:12:48 INFO - Return code: 0 04:12:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 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 0x7f29d1af1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, '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': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:48 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 04:12:48 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 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:48 INFO - Cleaning up... 04:12:48 INFO - Return code: 0 04:12:48 INFO - Running post-action listener: _resource_record_post_action 04:12:48 INFO - Running post-action listener: _start_resource_monitoring 04:12:48 INFO - Starting resource monitoring. 04:12:48 INFO - [mozharness: 2016-09-22 11:12:48.645239Z] Finished create-virtualenv step (success) 04:12:48 INFO - [mozharness: 2016-09-22 11:12:48.645758Z] Running install step. 04:12:48 INFO - Running pre-action listener: _resource_record_pre_action 04:12:48 INFO - Running main action method: install 04:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:48 INFO - Reading from file tmpfile_stdout 04:12:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:48 INFO - Reading from file tmpfile_stdout 04:12:48 INFO - Output received: 04:12:48 INFO - Usage: mozinstall [options] installer 04:12:48 INFO - Options: 04:12:48 INFO - -h, --help show this help message and exit 04:12:48 INFO - -d DEST, --destination=DEST 04:12:48 INFO - Directory to install application into. [default: 04:12:48 INFO - "/builds/slave/test"] 04:12:48 INFO - --app=APP Application being installed. [default: firefox] 04:12:48 INFO - mkdir: /builds/slave/test/build/application 04:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:05 INFO - Reading from file tmpfile_stdout 04:13:05 INFO - Output received: 04:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:05 INFO - Running post-action listener: _resource_record_post_action 04:13:05 INFO - [mozharness: 2016-09-22 11:13:05.002469Z] Finished install step (success) 04:13:05 INFO - [mozharness: 2016-09-22 11:13:05.002715Z] Running run-tests step. 04:13:05 INFO - Running pre-action listener: _resource_record_pre_action 04:13:05 INFO - Running main action method: run_tests 04:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:05 INFO - Python 2.7.3 04:13:05 INFO - Return code: 0 04:13:05 INFO - grabbing minidump binary from tooltool 04:13:05 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')]} 04:13:05 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 0x28b9f60>, '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 0x28bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:05 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 04:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:05 INFO - Return code: 0 04:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:05 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:13:05 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:13:05 INFO - Using env: {'DISPLAY': ':0', 04:13:05 INFO - 'HOME': '/home/cltbld', 04:13:05 INFO - 'LANG': 'en_US.UTF-8', 04:13:05 INFO - 'LANGUAGE': 'en_US:en', 04:13:05 INFO - 'LOGNAME': 'cltbld', 04:13:05 INFO - 'MAIL': '/var/mail/cltbld', 04:13:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:05 INFO - 'MOZ_NO_REMOTE': '1', 04:13:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:05 INFO - 'NO_EM_RESTART': '1', 04:13:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:05 INFO - 'PWD': '/builds/slave/test', 04:13:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:05 INFO - 'SHELL': '/bin/bash', 04:13:05 INFO - 'SHLVL': '1', 04:13:05 INFO - 'TERM': 'linux', 04:13:05 INFO - 'TMOUT': '86400', 04:13:05 INFO - 'USER': 'cltbld', 04:13:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548', 04:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:05 INFO - '_': '/tools/buildbot/bin/python'} 04:13:05 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:13:05 INFO - mozversion application_buildid: 20160922025458 04:13:05 INFO - mozversion application_changeset: 612a50c5350689a8e465d0a542a37e32613a88bd 04:13:05 INFO - mozversion application_display_name: Nightly 04:13:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:05 INFO - mozversion application_name: Firefox 04:13:05 INFO - mozversion application_remotingname: firefox 04:13:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:13:05 INFO - mozversion application_vendor: Mozilla 04:13:05 INFO - mozversion application_version: 52.0a1 04:13:05 INFO - mozversion platform_buildid: 20160922025458 04:13:05 INFO - mozversion platform_changeset: 612a50c5350689a8e465d0a542a37e32613a88bd 04:13:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:13:05 INFO - mozversion platform_version: 52.0a1 04:13:05 INFO - using testdate: 1474542785 04:13:05 INFO - actual date: 1474542785 04:13:05 INFO - starting webserver on 'localhost:57928' 04:13:05 INFO - SUITE-START | Running 2 tests 04:13:05 INFO - TEST-START | dromaeo_css 04:13:05 INFO - operating with platform_type : linux_ 04:13:05 INFO - Initialising browser for dromaeo_css test... 04:13:05 INFO - TEST-INFO | started process 28753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVN9D9/profile http://localhost:57928/getInfo.html) 04:13:09 INFO - PROCESS | 28753 | __metrics Screen width/height:1600/1200 04:13:09 INFO - PROCESS | 28753 | colorDepth:24 04:13:09 INFO - PROCESS | 28753 | Browser inner width/height: 1024/697 04:13:09 INFO - PROCESS | 28753 | __metrics 04:13:10 INFO - PROCESS | 28753 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:13:10 INFO - PROCESS | 28753 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:11 INFO - TEST-INFO | 28753: exit 0 04:13:11 INFO - Browser initialized. 04:13:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:11 INFO - TEST-INFO | started process 28834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVN9D9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:23 INFO - PROCESS | 28834 | RSS: Main: 175181824 04:13:23 INFO - PROCESS | 28834 | 04:14:15 INFO - PROCESS | 28834 | 1474542855329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:16:28 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57928/tests/dromaeo/cssquery-ext.html) 04:16:29 INFO - PROCESS | 28834 | RSS: Main: 296140800 04:16:29 INFO - PROCESS | 28834 | 04:19:31 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-ext.html (next: http://localhost:57928/tests/dromaeo/cssquery-jquery.html) 04:19:32 INFO - PROCESS | 28834 | RSS: Main: 283095040 04:19:32 INFO - PROCESS | 28834 | 04:22:34 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57928/tests/dromaeo/cssquery-mootools.html) 04:22:35 INFO - PROCESS | 28834 | RSS: Main: 218066944 04:22:35 INFO - PROCESS | 28834 | 04:25:37 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57928/tests/dromaeo/cssquery-prototype.html) 04:25:38 INFO - PROCESS | 28834 | RSS: Main: 220274688 04:25:38 INFO - PROCESS | 28834 | 04:28:41 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57928/tests/dromaeo/cssquery-yui.html) 04:28:42 INFO - PROCESS | 28834 | RSS: Main: 223629312 04:28:42 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | Cycle 1(1): loaded http://localhost:57928/tests/dromaeo/cssquery-yui.html (next: http://localhost:57928/tests/dromaeo/cssquery-dojo.html) 04:31:45 INFO - PROCESS | 28834 | RSS: Main: 311398400 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | __start_tp_report 04:31:45 INFO - PROCESS | 28834 | _x_x_mozilla_page_load 04:31:45 INFO - PROCESS | 28834 | _x_x_mozilla_page_load_details 04:31:45 INFO - PROCESS | 28834 | |i|pagename|runs| 04:31:45 INFO - PROCESS | 28834 | |0;dojo.html;2551.591745320749;2574.8197626166175;2609.7781688556465;2613.869306534673;2627.461370419064;4609.055143695543;4691.319758634996;4709.481956984729;4718.032803275329;4720.126776546337;4660.4174478190225;4700.0599880023965;4712.481627021033;4723.267893476508;4799.616030717543;4244.681648876332;4249.553796851317;4289.978550107261;4318.805653745589;4338.284183109783;4092.7135100542973;4379.627731642814;4398.3182606695855;4418.2268103082;4466.73199608023;4197.328427451624;4364.170807546556;4371.16947779924;4452;4464.218761716703;4200.306949353353;4276.636485898703;4297.205017071852;4299.054208074219;4307.935380969288;4278;4281.464816897887;4296.699231053827;4303.591158839905;4324.675649326282;4715.7642117893965;4734.810607575693;4743.169945259566;4801.663883528155;4810.6873053251775;5051.570616497602;5059.316992206079;5062.40951987702;5063.063333283354;5064.56951159152;4870;4929.186684197103;5005.824796132118;5094.032133894548;5147.6911385317;4746.762661866893;4751.026039661931;4756.120117778222;4802.375691160127;4813.5427134421825;5196.58427325813;5199;5204.843854684365;5206.609504287194;5257.658252213594;4822.156122678517;4872.049950259665;4945.258211268267;4976.328195693535;5050.242463630485;4998.375203099613;4999.325091112726;5011.674241174312;5085.796568137307;5188.325517682677;5016.297718319438;5028.220625803006;5031;5046.26829109777;5096.668716533413;4873.6832105913;4927.704337739747;5006.098902197639;5016.996600679806;5021.121303771898;4324.740515569076;4379.430674012358;4390.560943905648;4392.450943632046;4403.801828917706;3770.0951771574623;3804.410316400962;3815.6756675682323;3844.4041173618134;3855.9421608675893;4203.159368126387;4240.809163587646;4385.232584297735;4385.539518350591;4434.445694288214;5020.849374518771;5073.264376665436;5074.238864170404;5074.391073071255;5144.639875208774;4305.763183024964;4337.154254920323;4339;4349.956500434955;4407.515173330931;4519.683622146418;4618.422697162855;4631.374764406829;4640.814367425332;4658.906821863544;4684.648651351231;4710.764461776829;4762.595179409789;4763.428388593391;4808.0383923214795;5094.057599344133;5104.897902041864;5106.617003724661;5107.182850743863;5169.560587350117;4755.048990201904;4756.857294281177;4768.546988036131;4770.666053376231;4811.422629284369;4850.102730994778;4855.101806165871;4880.292357608056;4890.339804126397;4897.363342765418;4973.229149481836;4976.427710813303;4977.527134922177;4978.303037574815;5025.296458495886;4841.273808928689;4843.1524483216;4843.4430040545785;4854.466008738966;4900.166971614763;4762.738049407178;4780.737059461763;4793.616510679207;4874.78063487151;4937.160682684024;4811.206150985048;4870.805167793249;4879.585235255043;4891.926621100615;4895.583875370633;4810.037992401463;4982.501749824988;4997.875053123701;5005.649604527794;5018.347614810052;4735.928961065656;4805.7597120144555;4808.759562021815;4819.421669399694;4823.0353929215 04:31:45 INFO - PROCESS | 28834 | |1;ext.html;541.8266154830455;548.816146590892;554.0442736279917;563.9763828650998;567.6764244380703;28143.859280703593;28810.711892881063;30950.84524577374;31008.22479438018;38284;36886.44670329947;40905.386419203736;41031;41078.58921410785;41166.794166029205;7611.200823913492;7740.303372696456;7742.380609551251;7751.922480775176;7752.302292793647;7604.277593628596;7691.500052496598;7698.268664476894;7698.923010769877;7702.0757509098985;7710.691572337099;7734.071911370644;7741.303282704555;7749.7675069748;7751.922480775176;7673.3861291096855;7696.692132314701;7705.190954949761;7711.228877112244;7721.845563088763;7603.695852165962;7660.808479787994;7666.348360389374;7668.38652907766;7680.692772289158;37758.62241377578;37779.81110094432;37989.81005094985;38058.61941380578;38131.42802857959;2806.466771313444;2906.447774922758;3085.398347322273;3088.9806363900084;3541.4687796830426;28089.719102808915;28228.71771282302;28244.152675419566;28711;28728.425431491254;3448.6551344865566;3512.5082488451635;3538.2503431923124;3575.928481430383;3635.418333066723;245338;247836;248714;248941;248979;49232;49436.50563494391;49458.25812612814;49480.75259623751;49515.79115775199;28670.71329286722;29081;29250.561241581392;29337.85331073331;51631.48368516342;14078.888166775067;14149.29253537319;14160.716785664228;14161.079529830527;14164.291785410895;11448.771024579462;11529;11529.942350288195;11535.480903359368;11536.019438347834;17615.295388184586;17633.294668213384;17665.911670441565;17724.556886077695;17736.871575410776;6916.6541672916155;6951.513394062367;6970.686319115652;6984.869614767443;7078.433725301964;780.8594452998401;907.2333877873186;933.2394098809449;936.7377134402378;961.9780176097679;26566.203013909613;27366;27669.723302767117;27733.445331093266;27817.721822781514;878.3193025405234;888.2671795768517;914.8261830252363;935.9438433693864;997.1872923567414;13224.537141200011;14012.71974560503;14020.859791401956;14223.715525689428;14307.499237526637;358337;361656;362075;362244;362375;45965.310520342224;46170;46244.306335404995;46328.768356158005;46428.5357146431;1073.903348698621;1095.315427857589;1145.7994850901225;1170.7073231692077;1189.3102000839492;25138;28378.716212837608;28734.425311494073;28905.855470722512;29291.26771830636;39589.40615890706;40201.59798401978;40206.396904045876;40226.79886600548;40394.79802600968;295287;295516;295886;296052;296818;20749.1700331985;21484.24805131813;23254.88372558194;23951.76048239495;24101.276961691176;37913.45038595386;38322;38603.42094868523;38761.61238387693;38833.80583097066;32894;32920;33180.83409582936;33409.49885751764;33665;32832.343353133285;32833.835830820695;33573.83213083919;33846.261383607525;33880.83059584686;33083;33121.668783311856;33210.169745756546;33223.501647474826;33530.83234583811;28663;31307;32441.51337729983;35470.290594187456;35702.642973569935;24678.629820552345;25232;25342.493150137263;25669.61495577605;25689.743102569482 04:31:45 INFO - PROCESS | 28834 | |2;jquery.html;344.9754229937086;364.12428110394495;368.28185039173616;368.4583662016834;394.4812571468519;12082.335471549071;15517.844821551782;15969.520914372573;16161.99999999997;17127.486175414728;16046.43837465689;16396.18019099046;16766.329346826144;16878.240479178436;17000.914995425006;4930.679505832128;4961.5286547778;5080.466551012146;5124.564412024983;5167.870803229912;3679.5032670589394;3861.440091186776;4899.093667671492;4969.751512424383;4990.900181996358;5551.666899985994;5782.710864456782;5818.505427038707;5883.588148829584;5895.115732640095;5693;5826.863761566497;5859.1797148399255;5863.384344643794;5863.912041319383;5134.666246693991;5134.871628209325;5137.614678899097;5146.433892271847;5149.76826042829;19039.90480047591;20212.69680954787;20369.4907627309;20374.694379584318;20387.286444974354;1796.3712700554831;1850.7686539182603;1856.4337876947525;1890.3289332286977;2250.5723912456747;12412.503499859995;13111.934440327832;13518.405562085023;13543.729125417534;13710.38303276355;1645.9670806583922;1705.6247625522365;1711.3496871188993;1713.1348668922114;1776.9644607107784;65503;67732.98400523947;67926.32073679299;68381.65809170972;69974.65012674955;9325.720228393158;9329.440233586007;9546.474943878153;9584.66453674132;9822.950885245527;13063.412146453433;13078.084534082713;13089.083764136609;13095.738085238241;13098.541551045859;7010.509264351446;7090.787276381717;7143.428525718034;7166.713331466787;7296.306850849161;6774;6882.69027893746;6937.68780404883;6948.756793512202;6993.055937448481;5904.291485021739;5918.822435326947;5977.402259774075;6024.307204671519;6149.877002460015;1763.9911800440916;1781.5635169383324;1782.1445706061163;1812.7099664053687;1815.7185636226407;671.7715976567893;835.7868743470376;836.8200836820113;859.5229647545547;876.7676565710092;16554.751678724828;17023;17092.059936703354;17157.399491017753;18042.2783088675;861.7285555050264;882.4484697064335;896.6323807239131;899.5007770687331;955.9713208603753;9406.43561386319;10177.18582513397;10252.538635761408;10288.61822846759;10323.432211228455;397786;401528;402262;405299;409661;51639.74180129075;70346;70539.2987666171;70640.2935970644;71825.28174718186;935.3452583191793;963.7542426681151;984.950752462374;986.6645340584092;994.1599348550463;15057.957424735274;15446.922765386102;15644.92177539105;15763.763543547086;16027;33575.83212084022;34132;34392.65607343894;37063;39736;48829;49187;49393.75303123461;49539;52285.215721763445;6675.833104172434;6835.316468353125;6866.34769696878;7141.321574450419;7579.5073320234005;10078.647247346307;11078.889211107786;11207.775844482901;11333;11603.825942610698;9205.309601780027;9365.672201472917;9413.482258475575;9770.36492627977;9786.021397860157;5214.9478505214465;9349.345545811728;9649.951750241204;9666.214165934714;10271.178305735373;9306.488143152192;9600.615975361186;9648.228141748783;9915.900840991786;10025.498725063864;6614.768483103068;6703.262641109572;6909.481788865955;6995.7201711932985;7039.472039596948;6929.064576282138;9086.091390860862;9178.862317065383;9435.29235307341;9950.154236889655 04:31:45 INFO - PROCESS | 28834 | |3;mootools.html;1353.533031104269;1392.5613431768993;1440.9567712968615;1652.983470165298;1665.2506372132536;6783.118194634691;6969.825754356131;7278.927210727891;7892.131865494798;7900.683972641094;7309.890351644716;7543;7547.396208303323;7713.614319284027;7724.497907636014;2132.7014218009454;2146.5063035501844;2150.6773983902385;2161.167950339115;2165.740111186652;1825.917833697487;1895.1661269041647;2089.874607523546;2123.288698286076;2201.8128459081;2085.6662933930575;2166.04693934669;2168.772278910715;2177.3032629558547;2179.572380091035;2125.3836387447623;2136;2138.9358319250446;2158.870467771939;2160.3302976077307;2109.072008316336;2122.5012122151284;2128.9148434062618;2139.4437446264083;2140.5825863956534;7626.313631773167;7715.498492597963;7765.495242809199;7854.4894581851995;7870.606469676493;4541.296099104644;4655.11552804966;4665.206914824488;4672.4393072831135;4676.649251306166;2780.402213524102;2894.2619631993916;2940.6177196964472;2941.5734718465915;2943.9107530213746;968.3028219681888;975.707287813653;988.5699720621552;995.4176806568166;1005.0552480668149;10448.05967462932;10448.216383771247;10451.947740261327;10456;10463.94768026155;4106.733062350938;4126.09225970286;4282.5075116361395;4305.935410968838;4314.439122914001;9006.729798106067;9039.593218305192;9044.81910361789;9045.140711632384;9053.59258833354;4710.222813235778;4739.597134243628;4744.146053710365;4745.406824146981;4745.762711864393;4131.772752498641;4250.213710463574;4299.097189590221;4303.07483890965;4304.504981927056;3423.2639982403903;3475.9665595626843;3479.0606536235073;3501;3560.305740380601;1001.8597396364515;1016.7661437869332;1030.8144533983805;1088.4448931045065;1092.9726756831142;656.2059907511964;674.357938419949;741.525423728814;822.9465084769471;863.8272345530919;5154.61340399464;5280.207968804633;5286.577073834084;5370.140777475585;5442.183672449085;427.3333599584658;429.5875959079256;594.6729298885596;883.8188171424842;910.6630546697631;3735.3276410246417;3840.9039774005873;3959.1685745993086;4042.0905296308683;4048.959510404917;9442.197413219816;9552.856707149398;9643.662471813594;9677.806443871083;9687.17658998993;8804.691835785718;9257;9611.567479463301;9625.56684949179;9627.470489123025;7135.571865688075;7357.227491113463;7361.705531778776;7364.079490063742;7364.3003914628025;5073;5259.973700131628;5341.572674185978;5361.651492652965;5453.509184173285;8455.873161902453;8801.823963520821;8836;8911.2425443838;8916.33127515426;8748.69379571712;8831.823363532822;8994.50530220818;9043.412178208395;9056.909430905607;6369.522285828674;6568.671566421755;6569.80290591283;6576.967115164393;6579.868402631825;7226.530275532074;7303.087114110736;7303.269673032654;7323.816904577428;7376.594287314249;6405.935940640534;6509.576877502947;6605.966970165311;6707.832304192434;6776.322367763381;6504.512161587805;6544.149260596282;6563.212414510289;6601.537892347682;6619.735210591715;5845.532357411312;5965.28416590012;6005.699715014319;6237.157983672146;6303.842403939938;4611.93082103762;4677.46209185948;4757.833475828329;4764.285357196448;4820.421549414093;4691.413573303337;4694.906101878011;4788.976055119702;4812.181929072136;4893.192623217129 04:31:45 INFO - PROCESS | 28834 | |4;prototype.html;287.15862522808175;295.44603867747975;304.855193782953;305.0634551925588;305.3374178033667;4789.922267489817;4830.565249127578;4842.75786210689;4859.441164266111;4866.513348665132;4786.013804271232;4798.736069516175;4815.157347464197;4816.434658735908;4821.180399332113;3824.330742120125;3830.1190726133004;3843.13529455873;3864.3237433449176;3870.2066076454257;3721.1441368485266;3822.732408731376;3870.8000519838797;3871.264459752652;3907.492026036611;3755.3991361382186;3761;3767.227718317752;3772.3398405279104;3790.3177428062936;3757.849686012556;3763.4354846773203;3772.358699021173;3773.2642134783728;3800.3539398302355;3089.891853785129;3170.461021626329;3219.130834674648;3363.1592101974506;3373.5325133566976;4640.744759038285;4650.325702773112;4654.138984287918;4655.51023672425;4662.533746625344;4282.443282373302;4283.892902677458;4285.550017248175;4287.099709061101;4289.463817022872;4584.701994370389;4707.846577588479;4987.226979818098;4994;5019.64862459628;3613.5483064616924;3614.8734794282072;3616.8914932552066;3624.474451204587;3635.473101297461;5199.818006369759;5217.2695822584865;5221.216817477371;5231.738413079369;5238.292830467914;3657.9634203658156;3721.7208709346905;3723.404255319136;3734.775913445202;3754.7371683982406;3747.5502939647417;3781.4327850822046;3784.735068545175;3786.9431958520645;3803.6386543278345;4276.87169384919;4280.437640261344;4289.378040184156;4291.50647675515;4310.4611923509565;4996.400431948116;5008.549230569266;5020.874478138076;5029.1450453423;5030;1254.6988722706667;1303.882650561454;1307.1242267680677;1308.6205000549924;1313.8226339444052;803.1526739290105;809.7085049382217;839.4459656626597;844.6072576252072;844.936629752771;3986.142979259473;3988.2422339755353;3995.5604883462797;4028.8115006072694;4057.472528571267;4589.655775816827;4599.609033232213;4607.401037865123;4611.608013318905;4632.100838656135;3960.32674445345;3970.4242884782125;3971.841126354971;3989.8005099744896;4004.519457665099;2356.104680221505;2439.8044957970465;2462.7906627936827;2465.6794616699713;2492.800575953919;4361.214981303332;4625.352450656911;4786.1863483207935;4795.561331600506;4849.345338379274;5306.52241298285;5313.459096861944;5316.787328506894;5317.601179911522;5332.626716129834;4868.902621947612;4880.877978050577;4885.021566265668;4895.265710143436;4911.189653707098;4957.578605818546;5154.1237989542615;5193.221016847503;5199.610029247897;5217.765200566059;5113.64204505681;5114.258432527188;5115.820946266863;5121.567255553582;5135.740274279306;4717.693349932243;4837.709737415626;4886.900447399449;4891.217405215149;4908.870959679365;3716.591174970697;3744.64425879541;3752.981235093807;3755.0987762937243;3767.7566403086366;5207.3490813648295;5226.425093239816;5235.973820130875;5236.188390799432;5248.868778280574;5087.898242035212;5102.923456148235;5105.115609680519;5106.872328191825;5113.463086376026;4833.4441539223435;5019.67372120811;5025.798968041384;5058.64589478733;5059.974700126623;4995.550400463976;5012.6240531960975;5014.498550144956;5018.648694591344;5023.397192336943;4956.042363266562;5083.415407228216;5108.3359163310015;5119.436861945258;5141.305923700253;4938.259261110862;4968.527989840959;4974.8756281093265;4981;4987.979868153258 04:31:45 INFO - PROCESS | 28834 | |5;yui.html;621.9689015549222;673.2426020726682;694.2259380790421;705.9752908648192;723.7466886589692;12949.482020719171;14149.504767333145;14154.079984800981;14182.219977901212;14184.36170372333;12379.195352302095;12494.812577811317;12511;12547.309897955609;12569.497220111207;604.8729766748988;621.7419770795115;748.2891253309364;750.4221749253072;767.5893397032588;768.9577073260969;768.9615519224044;769.6036541181296;771.2981187119722;772.2007722007723;811.8863359129697;813.6297984417076;815.6329651656748;816.5223344343566;816.6692489541745;637.9393957574047;654.9836254093685;759.8784194528904;769.9422543309274;810.2424233341815;574.8505388598952;575.1085816983658;575.3469811763637;575.3613489027218;575.4820661404727;11775.411229438494;11805.881941180563;11810.704732381673;11816.05471562273;11824.349660768654;12474.81287780675;13068.150570212905;13237.867621323856;13376.464941402332;13512.121712088781;9352.532373381304;11477.253978491455;11495.770084598262;11732.237404568676;11769.293842369485;4033.7781422021776;4047.4738284023183;4063.573324800883;4094.2220978014084;4286.7856607169515;59716;60872.39127608756;60881.6955915222;60893.391066089214;60947.781044379306;9904.900950990397;9955.352902061342;10040.397576145455;10517.631882884063;10735.892641073646;17405.912970435067;17453.91273043652;17632.735508967377;17651.470455886345;17697.646047079244;6561.770338038145;6573.079768832367;6628.237752658506;6736.360045795642;6779.49153813466;3569;3600.855965761393;3622.6558476945174;3640.2355505343644;3640.6541378568995;2846.0323490013493;2967.6142101527093;2968.6437627484406;2970.3168271297723;2990.685977972325;497.855621869661;509.0277569841585;512.9871753206199;514.3210961530818;515.7911046026366;422.79917039406035;592.7865968251426;601.2334273800851;610.6610830988844;614.4807637546355;8124.959375203086;8213.178682131738;8271.421000529905;8338.207870252438;8654.437461564978;505.630889450703;588.9440503152193;593.1458699472745;615.602936106218;623.267660498921;3896.668783153407;3943.5267767867467;3996.1008773025837;4064.04494943688;4130.318497447947;103464.96535034703;106603.46698266458;106707;107518;109013;93011;95330.52334738281;95835;95878.52060739652;96464.51767741116;46900.2964955526;48974.75512622414;66096.33903660998;79284.60357698174;81681.59159204166;7746.612669366622;7829.530228186327;7941.682332706627;7969.840603187788;8070.314023308085;31754.682453175174;37033.444498332006;44073;45133.32300015437;45369.31946020878;39181.41227881527;52890.73554632202;53903.730481347346;55881.44118558925;56492.7175364137;10360.53377598025;10491.370517768959;10606.204534659777;10822.891771082188;10852.294600850919;10477.9476102619;10518.211134164816;10866.61966831157;11010.339379637247;11517.366544840113;10912.727181820517;11207.383593902414;11270.211085223955;11311.943440282746;11459.770804584028;11223.88776112261;11286.66140015801;11328.150388721044;11585.536578537101;11698.47356868926;11156.55373785072;11244.606438774603;11251.38117403518;11366.318020918772;12170.634880953585;8774;8861.689840855539;8903.688370906988;8960.551972401485;9184.081591840762;9781.951090244504;9834.704958851245;9968.152707019695;10042.196624269895;10052.246081544059 04:31:45 INFO - PROCESS | 28834 | __end_tp_report 04:31:45 INFO - PROCESS | 28834 | __start_cc_report 04:31:45 INFO - PROCESS | 28834 | _x_x_mozilla_cycle_collect,1119 04:31:45 INFO - PROCESS | 28834 | __end_cc_report 04:31:45 INFO - PROCESS | 28834 | __startTimestamp1474543905270__endTimestamp 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | ------- Summary: start ------- 04:31:45 INFO - PROCESS | 28834 | Number of tests: 6 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#0] dojo.html Cycles:165 Average:4660.17 Median:4799.62 stddev:488.24 (10.2%) stddev-sans-first:460.87 04:31:45 INFO - PROCESS | 28834 | Values: 2551.6 2574.8 2609.8 2613.9 2627.5 4609.1 4691.3 4709.5 4718.0 4720.1 4660.4 4700.1 4712.5 4723.3 4799.6 4244.7 4249.6 4290.0 4318.8 4338.3 4092.7 4379.6 4398.3 4418.2 4466.7 4197.3 4364.2 4371.2 4452.0 4464.2 4200.3 4276.6 4297.2 4299.1 4307.9 4278.0 4281.5 4296.7 4303.6 4324.7 4715.8 4734.8 4743.2 4801.7 4810.7 5051.6 5059.3 5062.4 5063.1 5064.6 4870.0 4929.2 5005.8 5094.0 5147.7 4746.8 4751.0 4756.1 4802.4 4813.5 5196.6 5199.0 5204.8 5206.6 5257.7 4822.2 4872.0 4945.3 4976.3 5050.2 4998.4 4999.3 5011.7 5085.8 5188.3 5016.3 5028.2 5031.0 5046.3 5096.7 4873.7 4927.7 5006.1 5017.0 5021.1 4324.7 4379.4 4390.6 4392.5 4403.8 3770.1 3804.4 3815.7 3844.4 3855.9 4203.2 4240.8 4385.2 4385.5 4434.4 5020.8 5073.3 5074.2 5074.4 5144.6 4305.8 4337.2 4339.0 4350.0 4407.5 4519.7 4618.4 4631.4 4640.8 4658.9 4684.6 4710.8 4762.6 4763.4 4808.0 5094.1 5104.9 5106.6 5107.2 5169.6 4755.0 4756.9 4768.5 4770.7 4811.4 4850.1 4855.1 4880.3 4890.3 4897.4 4973.2 4976.4 4977.5 4978.3 5025.3 4841.3 4843.2 4843.4 4854.5 4900.2 4762.7 4780.7 4793.6 4874.8 4937.2 4811.2 4870.8 4879.6 4891.9 4895.6 4810.0 4982.5 4997.9 5005.6 5018.3 4735.9 4805.8 4808.8 4819.4 4823.0 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#1] ext.html Cycles:180 Average:44446.81 Median:3480.58 stddev:80251.34 (2305.7%) stddev-sans-first:80408.76 04:31:45 INFO - PROCESS | 28834 | Values: 541.8 548.8 554.0 564.0 567.7 28143.9 28810.7 30950.8 31008.2 38284.0 36886.4 40905.4 41031.0 41078.6 41166.8 7611.2 7740.3 7742.4 7751.9 7752.3 7604.3 7691.5 7698.3 7698.9 7702.1 7710.7 7734.1 7741.3 7749.8 7751.9 7673.4 7696.7 7705.2 7711.2 7721.8 7603.7 7660.8 7666.3 7668.4 7680.7 37758.6 37779.8 37989.8 38058.6 38131.4 2806.5 2906.4 3085.4 3089.0 3541.5 28089.7 28228.7 28244.2 28711.0 28728.4 3448.7 3512.5 3538.3 3575.9 3635.4 245338.0 247836.0 248714.0 248941.0 248979.0 49232.0 49436.5 49458.3 49480.8 49515.8 28670.7 29081.0 29250.6 29337.9 51631.5 14078.9 14149.3 14160.7 14161.1 14164.3 11448.8 11529.0 11529.9 11535.5 11536.0 17615.3 17633.3 17665.9 17724.6 17736.9 6916.7 6951.5 6970.7 6984.9 7078.4 780.9 907.2 933.2 936.7 962.0 26566.2 27366.0 27669.7 27733.4 27817.7 878.3 888.3 914.8 935.9 997.2 13224.5 14012.7 14020.9 14223.7 14307.5 358337.0 361656.0 362075.0 362244.0 362375.0 45965.3 46170.0 46244.3 46328.8 46428.5 1073.9 1095.3 1145.8 1170.7 1189.3 25138.0 28378.7 28734.4 28905.9 29291.3 39589.4 40201.6 40206.4 40226.8 40394.8 295287.0 295516.0 295886.0 296052.0 296818.0 20749.2 21484.2 23254.9 23951.8 24101.3 37913.5 38322.0 38603.4 38761.6 38833.8 32894.0 32920.0 33180.8 33409.5 33665.0 32832.3 32833.8 33573.8 33846.3 33880.8 33083.0 33121.7 33210.2 33223.5 33530.8 28663.0 31307.0 32441.5 35470.3 35702.6 24678.6 25232.0 25342.5 25669.6 25689.7 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#2] jquery.html Cycles:180 Average:24203.29 Median:5136.24 stddev:66300.04 (1290.8%) stddev-sans-first:66461.83 04:31:45 INFO - PROCESS | 28834 | Values: 345.0 364.1 368.3 368.5 394.5 12082.3 15517.8 15969.5 16162.0 17127.5 16046.4 16396.2 16766.3 16878.2 17000.9 4930.7 4961.5 5080.5 5124.6 5167.9 3679.5 3861.4 4899.1 4969.8 4990.9 5551.7 5782.7 5818.5 5883.6 5895.1 5693.0 5826.9 5859.2 5863.4 5863.9 5134.7 5134.9 5137.6 5146.4 5149.8 19039.9 20212.7 20369.5 20374.7 20387.3 1796.4 1850.8 1856.4 1890.3 2250.6 12412.5 13111.9 13518.4 13543.7 13710.4 1646.0 1705.6 1711.3 1713.1 1777.0 65503.0 67733.0 67926.3 68381.7 69974.7 9325.7 9329.4 9546.5 9584.7 9823.0 13063.4 13078.1 13089.1 13095.7 13098.5 7010.5 7090.8 7143.4 7166.7 7296.3 6774.0 6882.7 6937.7 6948.8 6993.1 5904.3 5918.8 5977.4 6024.3 6149.9 1764.0 1781.6 1782.1 1812.7 1815.7 671.8 835.8 836.8 859.5 876.8 16554.8 17023.0 17092.1 17157.4 18042.3 861.7 882.4 896.6 899.5 956.0 9406.4 10177.2 10252.5 10288.6 10323.4 397786.0 401528.0 402262.0 405299.0 409661.0 51639.7 70346.0 70539.3 70640.3 71825.3 935.3 963.8 985.0 986.7 994.2 15058.0 15446.9 15644.9 15763.8 16027.0 33575.8 34132.0 34392.7 37063.0 39736.0 48829.0 49187.0 49393.8 49539.0 52285.2 6675.8 6835.3 6866.3 7141.3 7579.5 10078.6 11078.9 11207.8 11333.0 11603.8 9205.3 9365.7 9413.5 9770.4 9786.0 5214.9 9349.3 9650.0 9666.2 10271.2 9306.5 9600.6 9648.2 9915.9 10025.5 6614.8 6703.3 6909.5 6995.7 7039.5 6929.1 9086.1 9178.9 9435.3 9950.2 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#3] mootools.html Cycles:180 Average:5086.58 Median:5270.09 stddev:2834.19 (53.8%) stddev-sans-first:2828.25 04:31:45 INFO - PROCESS | 28834 | Values: 1353.5 1392.6 1441.0 1653.0 1665.3 6783.1 6969.8 7278.9 7892.1 7900.7 7309.9 7543.0 7547.4 7713.6 7724.5 2132.7 2146.5 2150.7 2161.2 2165.7 1825.9 1895.2 2089.9 2123.3 2201.8 2085.7 2166.0 2168.8 2177.3 2179.6 2125.4 2136.0 2138.9 2158.9 2160.3 2109.1 2122.5 2128.9 2139.4 2140.6 7626.3 7715.5 7765.5 7854.5 7870.6 4541.3 4655.1 4665.2 4672.4 4676.6 2780.4 2894.3 2940.6 2941.6 2943.9 968.3 975.7 988.6 995.4 1005.1 10448.1 10448.2 10451.9 10456.0 10463.9 4106.7 4126.1 4282.5 4305.9 4314.4 9006.7 9039.6 9044.8 9045.1 9053.6 4710.2 4739.6 4744.1 4745.4 4745.8 4131.8 4250.2 4299.1 4303.1 4304.5 3423.3 3476.0 3479.1 3501.0 3560.3 1001.9 1016.8 1030.8 1088.4 1093.0 656.2 674.4 741.5 822.9 863.8 5154.6 5280.2 5286.6 5370.1 5442.2 427.3 429.6 594.7 883.8 910.7 3735.3 3840.9 3959.2 4042.1 4049.0 9442.2 9552.9 9643.7 9677.8 9687.2 8804.7 9257.0 9611.6 9625.6 9627.5 7135.6 7357.2 7361.7 7364.1 7364.3 5073.0 5260.0 5341.6 5361.7 5453.5 8455.9 8801.8 8836.0 8911.2 8916.3 8748.7 8831.8 8994.5 9043.4 9056.9 6369.5 6568.7 6569.8 6577.0 6579.9 7226.5 7303.1 7303.3 7323.8 7376.6 6405.9 6509.6 6606.0 6707.8 6776.3 6504.5 6544.1 6563.2 6601.5 6619.7 5845.5 5965.3 6005.7 6237.2 6303.8 4611.9 4677.5 4757.8 4764.3 4820.4 4691.4 4694.9 4789.0 4812.2 4893.2 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#4] prototype.html Cycles:180 Average:4143.84 Median:4654.82 stddev:1212.53 (26.0%) stddev-sans-first:1180.87 04:31:45 INFO - PROCESS | 28834 | Values: 287.2 295.4 304.9 305.1 305.3 4789.9 4830.6 4842.8 4859.4 4866.5 4786.0 4798.7 4815.2 4816.4 4821.2 3824.3 3830.1 3843.1 3864.3 3870.2 3721.1 3822.7 3870.8 3871.3 3907.5 3755.4 3761.0 3767.2 3772.3 3790.3 3757.8 3763.4 3772.4 3773.3 3800.4 3089.9 3170.5 3219.1 3363.2 3373.5 4640.7 4650.3 4654.1 4655.5 4662.5 4282.4 4283.9 4285.6 4287.1 4289.5 4584.7 4707.8 4987.2 4994.0 5019.6 3613.5 3614.9 3616.9 3624.5 3635.5 5199.8 5217.3 5221.2 5231.7 5238.3 3658.0 3721.7 3723.4 3734.8 3754.7 3747.6 3781.4 3784.7 3786.9 3803.6 4276.9 4280.4 4289.4 4291.5 4310.5 4996.4 5008.5 5020.9 5029.1 5030.0 1254.7 1303.9 1307.1 1308.6 1313.8 803.2 809.7 839.4 844.6 844.9 3986.1 3988.2 3995.6 4028.8 4057.5 4589.7 4599.6 4607.4 4611.6 4632.1 3960.3 3970.4 3971.8 3989.8 4004.5 2356.1 2439.8 2462.8 2465.7 2492.8 4361.2 4625.4 4786.2 4795.6 4849.3 5306.5 5313.5 5316.8 5317.6 5332.6 4868.9 4880.9 4885.0 4895.3 4911.2 4957.6 5154.1 5193.2 5199.6 5217.8 5113.6 5114.3 5115.8 5121.6 5135.7 4717.7 4837.7 4886.9 4891.2 4908.9 3716.6 3744.6 3753.0 3755.1 3767.8 5207.3 5226.4 5236.0 5236.2 5248.9 5087.9 5102.9 5105.1 5106.9 5113.5 4833.4 5019.7 5025.8 5058.6 5060.0 4995.6 5012.6 5014.5 5018.6 5023.4 4956.0 5083.4 5108.3 5119.4 5141.3 4938.3 4968.5 4974.9 4981.0 4988.0 04:31:45 INFO - PROCESS | 28834 | 04:31:45 INFO - PROCESS | 28834 | [#5] yui.html Cycles:180 Average:17440.41 Median:46134.81 stddev:26003.47 (56.4%) stddev-sans-first:26045.75 04:31:45 INFO - PROCESS | 28834 | Values: 622.0 673.2 694.2 706.0 723.7 12949.5 14149.5 14154.1 14182.2 14184.4 12379.2 12494.8 12511.0 12547.3 12569.5 604.9 621.7 748.3 750.4 767.6 769.0 769.0 769.6 771.3 772.2 811.9 813.6 815.6 816.5 816.7 637.9 655.0 759.9 769.9 810.2 574.9 575.1 575.3 575.4 575.5 11775.4 11805.9 11810.7 11816.1 11824.3 12474.8 13068.2 13237.9 13376.5 13512.1 9352.5 11477.3 11495.8 11732.2 11769.3 4033.8 4047.5 4063.6 4094.2 4286.8 59716.0 60872.4 60881.7 60893.4 60947.8 9904.9 9955.4 10040.4 10517.6 10735.9 17405.9 17453.9 17632.7 17651.5 17697.6 6561.8 6573.1 6628.2 6736.4 6779.5 3569.0 3600.9 3622.7 3640.2 3640.7 2846.0 2967.6 2968.6 2970.3 2990.7 497.9 509.0 513.0 514.3 515.8 422.8 592.8 601.2 610.7 614.5 8125.0 8213.2 8271.4 8338.2 8654.4 505.6 588.9 593.1 615.6 623.3 3896.7 3943.5 3996.1 4064.0 4130.3 103465.0 106603.5 106707.0 107518.0 109013.0 93011.0 95330.5 95835.0 95878.5 96464.5 46900.3 48974.8 66096.3 79284.6 81681.6 7746.6 7829.5 7941.7 7969.8 8070.3 31754.7 37033.4 44073.0 45133.3 45369.3 39181.4 52890.7 53903.7 55881.4 56492.7 10360.5 10491.4 10606.2 10822.9 10852.3 10477.9 10518.2 10866.6 11010.3 11517.4 10912.7 11207.4 11270.2 11311.9 11459.8 11223.9 11286.7 11328.2 11585.5 11698.5 11156.6 11244.6 11251.4 11366.3 12170.6 8774.0 8861.7 8903.7 8960.6 9184.1 9782.0 9834.7 9968.2 10042.2 10052.2 04:31:45 INFO - PROCESS | 28834 | -------- Summary: end -------- 04:31:45 INFO - PROCESS | 28834 | 04:31:46 INFO - TEST-INFO | 28834: exit 0 04:31:46 INFO - TEST-OK | dromaeo_css | took 1120975ms 04:31:46 INFO - TEST-START | kraken 04:31:46 INFO - operating with platform_type : linux_ 04:31:46 INFO - Initialising browser for kraken test... 04:31:46 INFO - TEST-INFO | started process 29143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIQpct/profile http://localhost:57928/getInfo.html) 04:31:50 INFO - PROCESS | 29143 | __metrics Screen width/height:1600/1200 04:31:50 INFO - PROCESS | 29143 | colorDepth:24 04:31:50 INFO - PROCESS | 29143 | Browser inner width/height: 1024/697 04:31:50 INFO - PROCESS | 29143 | __metrics 04:31:51 INFO - PROCESS | 29143 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:31:51 INFO - PROCESS | 29143 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:51 INFO - PROCESS | 29143 | console.error: PushService: 04:31:51 INFO - PROCESS | 29143 | stateChangeProcessEnqueue: Error transitioning state 04:31:51 INFO - PROCESS | 29143 | UnknownError 04:31:52 INFO - TEST-INFO | 29143: exit 0 04:31:52 INFO - Browser initialized. 04:31:52 INFO - Running cycle 1/1 for kraken test... 04:31:52 INFO - TEST-INFO | started process 29224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIQpct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:04 INFO - PROCESS | 29224 | RSS: Main: 175210496 04:32:04 INFO - PROCESS | 29224 | 04:32:07 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57928/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:08 INFO - PROCESS | 29224 | RSS: Main: 243351552 04:32:08 INFO - PROCESS | 29224 | 04:32:11 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57928/tests/kraken/driver.html?testName=audio-dft) 04:32:11 INFO - PROCESS | 29224 | RSS: Main: 218824704 04:32:11 INFO - PROCESS | 29224 | 04:32:14 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57928/tests/kraken/driver.html?testName=audio-fft) 04:32:15 INFO - PROCESS | 29224 | RSS: Main: 300748800 04:32:15 INFO - PROCESS | 29224 | 04:32:17 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57928/tests/kraken/driver.html?testName=audio-oscillator) 04:32:18 INFO - PROCESS | 29224 | RSS: Main: 210190336 04:32:18 INFO - PROCESS | 29224 | 04:32:20 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:21 INFO - PROCESS | 29224 | RSS: Main: 214966272 04:32:21 INFO - PROCESS | 29224 | 04:32:24 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57928/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:25 INFO - PROCESS | 29224 | RSS: Main: 251174912 04:32:25 INFO - PROCESS | 29224 | 04:32:28 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57928/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:29 INFO - PROCESS | 29224 | RSS: Main: 250060800 04:32:29 INFO - PROCESS | 29224 | 04:32:32 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57928/tests/kraken/driver.html?testName=json-parse-financial) 04:32:32 INFO - PROCESS | 29224 | RSS: Main: 249286656 04:32:32 INFO - PROCESS | 29224 | 04:32:34 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:35 INFO - PROCESS | 29224 | RSS: Main: 211963904 04:32:35 INFO - PROCESS | 29224 | 04:32:37 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:37 INFO - PROCESS | 29224 | RSS: Main: 218025984 04:32:37 INFO - PROCESS | 29224 | 04:32:39 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:40 INFO - PROCESS | 29224 | RSS: Main: 224370688 04:32:40 INFO - PROCESS | 29224 | 04:32:43 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:44 INFO - PROCESS | 29224 | RSS: Main: 224436224 04:32:44 INFO - PROCESS | 29224 | 04:32:47 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:47 INFO - PROCESS | 29224 | RSS: Main: 222425088 04:32:47 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | Cycle 1(1): loaded http://localhost:57928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57928/tests/kraken/driver.html?testName=ai-astar) 04:32:49 INFO - PROCESS | 29224 | RSS: Main: 274272256 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | __start_tp_report 04:32:49 INFO - PROCESS | 29224 | _x_x_mozilla_page_load 04:32:49 INFO - PROCESS | 29224 | _x_x_mozilla_page_load_details 04:32:49 INFO - PROCESS | 29224 | |i|pagename|runs| 04:32:49 INFO - PROCESS | 29224 | |0;ai-astar;111;116;113;115;113;115;115;114;114;114 04:32:49 INFO - PROCESS | 29224 | |1;audio-beat-detection;161;123;121;159;124;125;128;126;186;127 04:32:49 INFO - PROCESS | 29224 | |2;audio-dft;162;162;163;161;161;163;162;162;162;161 04:32:49 INFO - PROCESS | 29224 | |3;audio-fft;78;76;76;109;75;77;78;77;104;78 04:32:49 INFO - PROCESS | 29224 | |4;audio-oscillator;85;85;113;84;83;85;114;84;89;110 04:32:49 INFO - PROCESS | 29224 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;118 04:32:49 INFO - PROCESS | 29224 | |6;imaging-darkroom;147;147;146;146;147;146;147;146;148;146 04:32:49 INFO - PROCESS | 29224 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;95;94 04:32:49 INFO - PROCESS | 29224 | |8;json-parse-financial;66;66;76;64;65;66;66;66;65;65 04:32:49 INFO - PROCESS | 29224 | |9;json-stringify-tinderbox;65;65;65;66;66;66;66;66;66;66 04:32:49 INFO - PROCESS | 29224 | |10;stanford-crypto-aes;83;84;83;83;84;93;83;83;84;83 04:32:49 INFO - PROCESS | 29224 | |11;stanford-crypto-ccm;136;135;142;151;138;132;140;132;188;132 04:32:49 INFO - PROCESS | 29224 | |12;stanford-crypto-pbkdf2;187;177;175;173;173;172;172;172;174;174 04:32:49 INFO - PROCESS | 29224 | |13;stanford-crypto-sha256-iterative;70;70;69;69;68;68;69;68;69;68 04:32:49 INFO - PROCESS | 29224 | __end_tp_report 04:32:49 INFO - PROCESS | 29224 | __start_cc_report 04:32:49 INFO - PROCESS | 29224 | _x_x_mozilla_cycle_collect,2007 04:32:49 INFO - PROCESS | 29224 | __end_cc_report 04:32:49 INFO - PROCESS | 29224 | __startTimestamp1474543969647__endTimestamp 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | ------- Summary: start ------- 04:32:49 INFO - PROCESS | 29224 | Number of tests: 14 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.41 (1.2%) stddev-sans-first:1.00 04:32:49 INFO - PROCESS | 29224 | Values: 111.0 116.0 113.0 115.0 113.0 115.0 115.0 114.0 114.0 114.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:127.50 stddev:22.41 (17.6%) stddev-sans-first:22.16 04:32:49 INFO - PROCESS | 29224 | Values: 161.0 123.0 121.0 159.0 124.0 125.0 128.0 126.0 186.0 127.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:32:49 INFO - PROCESS | 29224 | Values: 162.0 162.0 163.0 161.0 161.0 163.0 162.0 162.0 162.0 161.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:12.59 (16.3%) stddev-sans-first:13.23 04:32:49 INFO - PROCESS | 29224 | Values: 78.0 76.0 76.0 109.0 75.0 77.0 78.0 77.0 104.0 78.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.50 stddev:13.33 (15.8%) stddev-sans-first:13.81 04:32:49 INFO - PROCESS | 29224 | Values: 85.0 85.0 113.0 84.0 83.0 85.0 114.0 84.0 89.0 110.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:32:49 INFO - PROCESS | 29224 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:32:49 INFO - PROCESS | 29224 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 148.0 146.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:32:49 INFO - PROCESS | 29224 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:3.41 (5.2%) stddev-sans-first:3.61 04:32:49 INFO - PROCESS | 29224 | Values: 66.0 66.0 76.0 64.0 65.0 66.0 66.0 66.0 65.0 65.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:32:49 INFO - PROCESS | 29224 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.09 (3.7%) stddev-sans-first:3.24 04:32:49 INFO - PROCESS | 29224 | Values: 83.0 84.0 83.0 83.0 84.0 93.0 83.0 83.0 84.0 83.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:139.00 stddev:16.99 (12.2%) stddev-sans-first:17.85 04:32:49 INFO - PROCESS | 29224 | Values: 136.0 135.0 142.0 151.0 138.0 132.0 140.0 132.0 188.0 132.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:4.53 (2.6%) stddev-sans-first:1.67 04:32:49 INFO - PROCESS | 29224 | Values: 187.0 177.0 175.0 173.0 173.0 172.0 172.0 172.0 174.0 174.0 04:32:49 INFO - PROCESS | 29224 | 04:32:49 INFO - PROCESS | 29224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.71 04:32:49 INFO - PROCESS | 29224 | Values: 70.0 70.0 69.0 69.0 68.0 68.0 69.0 68.0 69.0 68.0 04:32:49 INFO - PROCESS | 29224 | -------- Summary: end -------- 04:32:49 INFO - PROCESS | 29224 | 04:32:51 INFO - TEST-INFO | 29224: exit 0 04:32:51 INFO - TEST-OK | kraken | took 64845ms 04:32:51 INFO - SUITE-END | took 1185s 04:32:51 INFO - Completed test suite (00:19:46) 04:32:51 INFO - javascript benchmark 04:32:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2551.591745320749, 2574.8197626166175, 2609.7781688556465, 2613.869306534673, 2627.461370419064, 4609.055143695543, 4691.319758634996, 4709.481956984729, 4718.032803275329, 4720.126776546337, 4660.4174478190225, 4700.0599880023965, 4712.481627021033, 4723.267893476508, 4799.616030717543, 4244.681648876332, 4249.553796851317, 4289.978550107261, 4318.805653745589, 4338.284183109783, 4092.7135100542973, 4379.627731642814, 4398.3182606695855, 4418.2268103082, 4466.73199608023, 4197.328427451624, 4364.170807546556, 4371.16947779924, 4452.0, 4464.218761716703, 4200.306949353353, 4276.636485898703, 4297.205017071852, 4299.054208074219, 4307.935380969288, 4278.0, 4281.464816897887, 4296.699231053827, 4303.591158839905, 4324.675649326282, 4715.7642117893965, 4734.810607575693, 4743.169945259566, 4801.663883528155, 4810.6873053251775, 5051.570616497602, 5059.316992206079, 5062.40951987702, 5063.063333283354, 5064.56951159152, 4870.0, 4929.186684197103, 5005.824796132118, 5094.032133894548, 5147.6911385317, 4746.762661866893, 4751.026039661931, 4756.120117778222, 4802.375691160127, 4813.5427134421825, 5196.58427325813, 5199.0, 5204.843854684365, 5206.609504287194, 5257.658252213594, 4822.156122678517, 4872.049950259665, 4945.258211268267, 4976.328195693535, 5050.242463630485, 4998.375203099613, 4999.325091112726, 5011.674241174312, 5085.796568137307, 5188.325517682677, 5016.297718319438, 5028.220625803006, 5031.0, 5046.26829109777, 5096.668716533413, 4873.6832105913, 4927.704337739747, 5006.098902197639, 5016.996600679806, 5021.121303771898, 4324.740515569076, 4379.430674012358, 4390.560943905648, 4392.450943632046, 4403.801828917706, 3770.0951771574623, 3804.410316400962, 3815.6756675682323, 3844.4041173618134, 3855.9421608675893, 4203.159368126387, 4240.809163587646, 4385.232584297735, 4385.539518350591, 4434.445694288214, 5020.849374518771, 5073.264376665436, 5074.238864170404, 5074.391073071255, 5144.639875208774, 4305.763183024964, 4337.154254920323, 4339.0, 4349.956500434955, 4407.515173330931, 4519.683622146418, 4618.422697162855, 4631.374764406829, 4640.814367425332, 4658.906821863544, 4684.648651351231, 4710.764461776829, 4762.595179409789, 4763.428388593391, 4808.0383923214795, 5094.057599344133, 5104.897902041864, 5106.617003724661, 5107.182850743863, 5169.560587350117, 4755.048990201904, 4756.857294281177, 4768.546988036131, 4770.666053376231, 4811.422629284369, 4850.102730994778, 4855.101806165871, 4880.292357608056, 4890.339804126397, 4897.363342765418, 4973.229149481836, 4976.427710813303, 4977.527134922177, 4978.303037574815, 5025.296458495886, 4841.273808928689, 4843.1524483216, 4843.4430040545785, 4854.466008738966, 4900.166971614763, 4762.738049407178, 4780.737059461763, 4793.616510679207, 4874.78063487151, 4937.160682684024, 4811.206150985048, 4870.805167793249, 4879.585235255043, 4891.926621100615, 4895.583875370633, 4810.037992401463, 4982.501749824988, 4997.875053123701, 5005.649604527794, 5018.347614810052, 4735.928961065656, 4805.7597120144555, 4808.759562021815, 4819.421669399694, 4823.0353929215], "value": 4628.787208625177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.8266154830455, 548.816146590892, 554.0442736279917, 563.9763828650998, 567.6764244380703, 28143.859280703593, 28810.711892881063, 30950.84524577374, 31008.22479438018, 38284.0, 36886.44670329947, 40905.386419203736, 41031.0, 41078.58921410785, 41166.794166029205, 7611.200823913492, 7740.303372696456, 7742.380609551251, 7751.922480775176, 7752.302292793647, 7604.277593628596, 7691.500052496598, 7698.268664476894, 7698.923010769877, 7702.0757509098985, 7710.691572337099, 7734.071911370644, 7741.303282704555, 7749.7675069748, 7751.922480775176, 7673.3861291096855, 7696.692132314701, 7705.190954949761, 7711.228877112244, 7721.845563088763, 7603.695852165962, 7660.808479787994, 7666.348360389374, 7668.38652907766, 7680.692772289158, 37758.62241377578, 37779.81110094432, 37989.81005094985, 38058.61941380578, 38131.42802857959, 2806.466771313444, 2906.447774922758, 3085.398347322273, 3088.9806363900084, 3541.4687796830426, 28089.719102808915, 28228.71771282302, 28244.152675419566, 28711.0, 28728.425431491254, 3448.6551344865566, 3512.5082488451635, 3538.2503431923124, 3575.928481430383, 3635.418333066723, 245338.0, 247836.0, 248714.0, 248941.0, 248979.0, 49232.0, 49436.50563494391, 49458.25812612814, 49480.75259623751, 49515.79115775199, 28670.71329286722, 29081.0, 29250.561241581392, 29337.85331073331, 51631.48368516342, 14078.888166775067, 14149.29253537319, 14160.716785664228, 14161.079529830527, 14164.291785410895, 11448.771024579462, 11529.0, 11529.942350288195, 11535.480903359368, 11536.019438347834, 17615.295388184586, 17633.294668213384, 17665.911670441565, 17724.556886077695, 17736.871575410776, 6916.6541672916155, 6951.513394062367, 6970.686319115652, 6984.869614767443, 7078.433725301964, 780.8594452998401, 907.2333877873186, 933.2394098809449, 936.7377134402378, 961.9780176097679, 26566.203013909613, 27366.0, 27669.723302767117, 27733.445331093266, 27817.721822781514, 878.3193025405234, 888.2671795768517, 914.8261830252363, 935.9438433693864, 997.1872923567414, 13224.537141200011, 14012.71974560503, 14020.859791401956, 14223.715525689428, 14307.499237526637, 358337.0, 361656.0, 362075.0, 362244.0, 362375.0, 45965.310520342224, 46170.0, 46244.306335404995, 46328.768356158005, 46428.5357146431, 1073.903348698621, 1095.315427857589, 1145.7994850901225, 1170.7073231692077, 1189.3102000839492, 25138.0, 28378.716212837608, 28734.425311494073, 28905.855470722512, 29291.26771830636, 39589.40615890706, 40201.59798401978, 40206.396904045876, 40226.79886600548, 40394.79802600968, 295287.0, 295516.0, 295886.0, 296052.0, 296818.0, 20749.1700331985, 21484.24805131813, 23254.88372558194, 23951.76048239495, 24101.276961691176, 37913.45038595386, 38322.0, 38603.42094868523, 38761.61238387693, 38833.80583097066, 32894.0, 32920.0, 33180.83409582936, 33409.49885751764, 33665.0, 32832.343353133285, 32833.835830820695, 33573.83213083919, 33846.261383607525, 33880.83059584686, 33083.0, 33121.668783311856, 33210.169745756546, 33223.501647474826, 33530.83234583811, 28663.0, 31307.0, 32441.51337729983, 35470.290594187456, 35702.642973569935, 24678.629820552345, 25232.0, 25342.493150137263, 25669.61495577605, 25689.743102569482], "value": 16682.061067967228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9754229937086, 364.12428110394495, 368.28185039173616, 368.4583662016834, 394.4812571468519, 12082.335471549071, 15517.844821551782, 15969.520914372573, 16161.99999999997, 17127.486175414728, 16046.43837465689, 16396.18019099046, 16766.329346826144, 16878.240479178436, 17000.914995425006, 4930.679505832128, 4961.5286547778, 5080.466551012146, 5124.564412024983, 5167.870803229912, 3679.5032670589394, 3861.440091186776, 4899.093667671492, 4969.751512424383, 4990.900181996358, 5551.666899985994, 5782.710864456782, 5818.505427038707, 5883.588148829584, 5895.115732640095, 5693.0, 5826.863761566497, 5859.1797148399255, 5863.384344643794, 5863.912041319383, 5134.666246693991, 5134.871628209325, 5137.614678899097, 5146.433892271847, 5149.76826042829, 19039.90480047591, 20212.69680954787, 20369.4907627309, 20374.694379584318, 20387.286444974354, 1796.3712700554831, 1850.7686539182603, 1856.4337876947525, 1890.3289332286977, 2250.5723912456747, 12412.503499859995, 13111.934440327832, 13518.405562085023, 13543.729125417534, 13710.38303276355, 1645.9670806583922, 1705.6247625522365, 1711.3496871188993, 1713.1348668922114, 1776.9644607107784, 65503.0, 67732.98400523947, 67926.32073679299, 68381.65809170972, 69974.65012674955, 9325.720228393158, 9329.440233586007, 9546.474943878153, 9584.66453674132, 9822.950885245527, 13063.412146453433, 13078.084534082713, 13089.083764136609, 13095.738085238241, 13098.541551045859, 7010.509264351446, 7090.787276381717, 7143.428525718034, 7166.713331466787, 7296.306850849161, 6774.0, 6882.69027893746, 6937.68780404883, 6948.756793512202, 6993.055937448481, 5904.291485021739, 5918.822435326947, 5977.402259774075, 6024.307204671519, 6149.877002460015, 1763.9911800440916, 1781.5635169383324, 1782.1445706061163, 1812.7099664053687, 1815.7185636226407, 671.7715976567893, 835.7868743470376, 836.8200836820113, 859.5229647545547, 876.7676565710092, 16554.751678724828, 17023.0, 17092.059936703354, 17157.399491017753, 18042.2783088675, 861.7285555050264, 882.4484697064335, 896.6323807239131, 899.5007770687331, 955.9713208603753, 9406.43561386319, 10177.18582513397, 10252.538635761408, 10288.61822846759, 10323.432211228455, 397786.0, 401528.0, 402262.0, 405299.0, 409661.0, 51639.74180129075, 70346.0, 70539.2987666171, 70640.2935970644, 71825.28174718186, 935.3452583191793, 963.7542426681151, 984.950752462374, 986.6645340584092, 994.1599348550463, 15057.957424735274, 15446.922765386102, 15644.92177539105, 15763.763543547086, 16027.0, 33575.83212084022, 34132.0, 34392.65607343894, 37063.0, 39736.0, 48829.0, 49187.0, 49393.75303123461, 49539.0, 52285.215721763445, 6675.833104172434, 6835.316468353125, 6866.34769696878, 7141.321574450419, 7579.5073320234005, 10078.647247346307, 11078.889211107786, 11207.775844482901, 11333.0, 11603.825942610698, 9205.309601780027, 9365.672201472917, 9413.482258475575, 9770.36492627977, 9786.021397860157, 5214.9478505214465, 9349.345545811728, 9649.951750241204, 9666.214165934714, 10271.178305735373, 9306.488143152192, 9600.615975361186, 9648.228141748783, 9915.900840991786, 10025.498725063864, 6614.768483103068, 6703.262641109572, 6909.481788865955, 6995.7201711932985, 7039.472039596948, 6929.064576282138, 9086.091390860862, 9178.862317065383, 9435.29235307341, 9950.154236889655], "value": 8107.274064608901, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.533031104269, 1392.5613431768993, 1440.9567712968615, 1652.983470165298, 1665.2506372132536, 6783.118194634691, 6969.825754356131, 7278.927210727891, 7892.131865494798, 7900.683972641094, 7309.890351644716, 7543.0, 7547.396208303323, 7713.614319284027, 7724.497907636014, 2132.7014218009454, 2146.5063035501844, 2150.6773983902385, 2161.167950339115, 2165.740111186652, 1825.917833697487, 1895.1661269041647, 2089.874607523546, 2123.288698286076, 2201.8128459081, 2085.6662933930575, 2166.04693934669, 2168.772278910715, 2177.3032629558547, 2179.572380091035, 2125.3836387447623, 2136.0, 2138.9358319250446, 2158.870467771939, 2160.3302976077307, 2109.072008316336, 2122.5012122151284, 2128.9148434062618, 2139.4437446264083, 2140.5825863956534, 7626.313631773167, 7715.498492597963, 7765.495242809199, 7854.4894581851995, 7870.606469676493, 4541.296099104644, 4655.11552804966, 4665.206914824488, 4672.4393072831135, 4676.649251306166, 2780.402213524102, 2894.2619631993916, 2940.6177196964472, 2941.5734718465915, 2943.9107530213746, 968.3028219681888, 975.707287813653, 988.5699720621552, 995.4176806568166, 1005.0552480668149, 10448.05967462932, 10448.216383771247, 10451.947740261327, 10456.0, 10463.94768026155, 4106.733062350938, 4126.09225970286, 4282.5075116361395, 4305.935410968838, 4314.439122914001, 9006.729798106067, 9039.593218305192, 9044.81910361789, 9045.140711632384, 9053.59258833354, 4710.222813235778, 4739.597134243628, 4744.146053710365, 4745.406824146981, 4745.762711864393, 4131.772752498641, 4250.213710463574, 4299.097189590221, 4303.07483890965, 4304.504981927056, 3423.2639982403903, 3475.9665595626843, 3479.0606536235073, 3501.0, 3560.305740380601, 1001.8597396364515, 1016.7661437869332, 1030.8144533983805, 1088.4448931045065, 1092.9726756831142, 656.2059907511964, 674.357938419949, 741.525423728814, 822.9465084769471, 863.8272345530919, 5154.61340399464, 5280.207968804633, 5286.577073834084, 5370.140777475585, 5442.183672449085, 427.3333599584658, 429.5875959079256, 594.6729298885596, 883.8188171424842, 910.6630546697631, 3735.3276410246417, 3840.9039774005873, 3959.1685745993086, 4042.0905296308683, 4048.959510404917, 9442.197413219816, 9552.856707149398, 9643.662471813594, 9677.806443871083, 9687.17658998993, 8804.691835785718, 9257.0, 9611.567479463301, 9625.56684949179, 9627.470489123025, 7135.571865688075, 7357.227491113463, 7361.705531778776, 7364.079490063742, 7364.3003914628025, 5073.0, 5259.973700131628, 5341.572674185978, 5361.651492652965, 5453.509184173285, 8455.873161902453, 8801.823963520821, 8836.0, 8911.2425443838, 8916.33127515426, 8748.69379571712, 8831.823363532822, 8994.50530220818, 9043.412178208395, 9056.909430905607, 6369.522285828674, 6568.671566421755, 6569.80290591283, 6576.967115164393, 6579.868402631825, 7226.530275532074, 7303.087114110736, 7303.269673032654, 7323.816904577428, 7376.594287314249, 6405.935940640534, 6509.576877502947, 6605.966970165311, 6707.832304192434, 6776.322367763381, 6504.512161587805, 6544.149260596282, 6563.212414510289, 6601.537892347682, 6619.735210591715, 5845.532357411312, 5965.28416590012, 6005.699715014319, 6237.157983672146, 6303.842403939938, 4611.93082103762, 4677.46209185948, 4757.833475828329, 4764.285357196448, 4820.421549414093, 4691.413573303337, 4694.906101878011, 4788.976055119702, 4812.181929072136, 4893.192623217129], "value": 4067.553410156436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.15862522808175, 295.44603867747975, 304.855193782953, 305.0634551925588, 305.3374178033667, 4789.922267489817, 4830.565249127578, 4842.75786210689, 4859.441164266111, 4866.513348665132, 4786.013804271232, 4798.736069516175, 4815.157347464197, 4816.434658735908, 4821.180399332113, 3824.330742120125, 3830.1190726133004, 3843.13529455873, 3864.3237433449176, 3870.2066076454257, 3721.1441368485266, 3822.732408731376, 3870.8000519838797, 3871.264459752652, 3907.492026036611, 3755.3991361382186, 3761.0, 3767.227718317752, 3772.3398405279104, 3790.3177428062936, 3757.849686012556, 3763.4354846773203, 3772.358699021173, 3773.2642134783728, 3800.3539398302355, 3089.891853785129, 3170.461021626329, 3219.130834674648, 3363.1592101974506, 3373.5325133566976, 4640.744759038285, 4650.325702773112, 4654.138984287918, 4655.51023672425, 4662.533746625344, 4282.443282373302, 4283.892902677458, 4285.550017248175, 4287.099709061101, 4289.463817022872, 4584.701994370389, 4707.846577588479, 4987.226979818098, 4994.0, 5019.64862459628, 3613.5483064616924, 3614.8734794282072, 3616.8914932552066, 3624.474451204587, 3635.473101297461, 5199.818006369759, 5217.2695822584865, 5221.216817477371, 5231.738413079369, 5238.292830467914, 3657.9634203658156, 3721.7208709346905, 3723.404255319136, 3734.775913445202, 3754.7371683982406, 3747.5502939647417, 3781.4327850822046, 3784.735068545175, 3786.9431958520645, 3803.6386543278345, 4276.87169384919, 4280.437640261344, 4289.378040184156, 4291.50647675515, 4310.4611923509565, 4996.400431948116, 5008.549230569266, 5020.874478138076, 5029.1450453423, 5030.0, 1254.6988722706667, 1303.882650561454, 1307.1242267680677, 1308.6205000549924, 1313.8226339444052, 803.1526739290105, 809.7085049382217, 839.4459656626597, 844.6072576252072, 844.936629752771, 3986.142979259473, 3988.2422339755353, 3995.5604883462797, 4028.8115006072694, 4057.472528571267, 4589.655775816827, 4599.609033232213, 4607.401037865123, 4611.608013318905, 4632.100838656135, 3960.32674445345, 3970.4242884782125, 3971.841126354971, 3989.8005099744896, 4004.519457665099, 2356.104680221505, 2439.8044957970465, 2462.7906627936827, 2465.6794616699713, 2492.800575953919, 4361.214981303332, 4625.352450656911, 4786.1863483207935, 4795.561331600506, 4849.345338379274, 5306.52241298285, 5313.459096861944, 5316.787328506894, 5317.601179911522, 5332.626716129834, 4868.902621947612, 4880.877978050577, 4885.021566265668, 4895.265710143436, 4911.189653707098, 4957.578605818546, 5154.1237989542615, 5193.221016847503, 5199.610029247897, 5217.765200566059, 5113.64204505681, 5114.258432527188, 5115.820946266863, 5121.567255553582, 5135.740274279306, 4717.693349932243, 4837.709737415626, 4886.900447399449, 4891.217405215149, 4908.870959679365, 3716.591174970697, 3744.64425879541, 3752.981235093807, 3755.0987762937243, 3767.7566403086366, 5207.3490813648295, 5226.425093239816, 5235.973820130875, 5236.188390799432, 5248.868778280574, 5087.898242035212, 5102.923456148235, 5105.115609680519, 5106.872328191825, 5113.463086376026, 4833.4441539223435, 5019.67372120811, 5025.798968041384, 5058.64589478733, 5059.974700126623, 4995.550400463976, 5012.6240531960975, 5014.498550144956, 5018.648694591344, 5023.397192336943, 4956.042363266562, 5083.415407228216, 5108.3359163310015, 5119.436861945258, 5141.305923700253, 4938.259261110862, 4968.527989840959, 4974.8756281093265, 4981.0, 4987.979868153258], "value": 3758.5365879505034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.9689015549222, 673.2426020726682, 694.2259380790421, 705.9752908648192, 723.7466886589692, 12949.482020719171, 14149.504767333145, 14154.079984800981, 14182.219977901212, 14184.36170372333, 12379.195352302095, 12494.812577811317, 12511.0, 12547.309897955609, 12569.497220111207, 604.8729766748988, 621.7419770795115, 748.2891253309364, 750.4221749253072, 767.5893397032588, 768.9577073260969, 768.9615519224044, 769.6036541181296, 771.2981187119722, 772.2007722007723, 811.8863359129697, 813.6297984417076, 815.6329651656748, 816.5223344343566, 816.6692489541745, 637.9393957574047, 654.9836254093685, 759.8784194528904, 769.9422543309274, 810.2424233341815, 574.8505388598952, 575.1085816983658, 575.3469811763637, 575.3613489027218, 575.4820661404727, 11775.411229438494, 11805.881941180563, 11810.704732381673, 11816.05471562273, 11824.349660768654, 12474.81287780675, 13068.150570212905, 13237.867621323856, 13376.464941402332, 13512.121712088781, 9352.532373381304, 11477.253978491455, 11495.770084598262, 11732.237404568676, 11769.293842369485, 4033.7781422021776, 4047.4738284023183, 4063.573324800883, 4094.2220978014084, 4286.7856607169515, 59716.0, 60872.39127608756, 60881.6955915222, 60893.391066089214, 60947.781044379306, 9904.900950990397, 9955.352902061342, 10040.397576145455, 10517.631882884063, 10735.892641073646, 17405.912970435067, 17453.91273043652, 17632.735508967377, 17651.470455886345, 17697.646047079244, 6561.770338038145, 6573.079768832367, 6628.237752658506, 6736.360045795642, 6779.49153813466, 3569.0, 3600.855965761393, 3622.6558476945174, 3640.2355505343644, 3640.6541378568995, 2846.0323490013493, 2967.6142101527093, 2968.6437627484406, 2970.3168271297723, 2990.685977972325, 497.855621869661, 509.0277569841585, 512.9871753206199, 514.3210961530818, 515.7911046026366, 422.79917039406035, 592.7865968251426, 601.2334273800851, 610.6610830988844, 614.4807637546355, 8124.959375203086, 8213.178682131738, 8271.421000529905, 8338.207870252438, 8654.437461564978, 505.630889450703, 588.9440503152193, 593.1458699472745, 615.602936106218, 623.267660498921, 3896.668783153407, 3943.5267767867467, 3996.1008773025837, 4064.04494943688, 4130.318497447947, 103464.96535034703, 106603.46698266458, 106707.0, 107518.0, 109013.0, 93011.0, 95330.52334738281, 95835.0, 95878.52060739652, 96464.51767741116, 46900.2964955526, 48974.75512622414, 66096.33903660998, 79284.60357698174, 81681.59159204166, 7746.612669366622, 7829.530228186327, 7941.682332706627, 7969.840603187788, 8070.314023308085, 31754.682453175174, 37033.444498332006, 44073.0, 45133.32300015437, 45369.31946020878, 39181.41227881527, 52890.73554632202, 53903.730481347346, 55881.44118558925, 56492.7175364137, 10360.53377598025, 10491.370517768959, 10606.204534659777, 10822.891771082188, 10852.294600850919, 10477.9476102619, 10518.211134164816, 10866.61966831157, 11010.339379637247, 11517.366544840113, 10912.727181820517, 11207.383593902414, 11270.211085223955, 11311.943440282746, 11459.770804584028, 11223.88776112261, 11286.66140015801, 11328.150388721044, 11585.536578537101, 11698.47356868926, 11156.55373785072, 11244.606438774603, 11251.38117403518, 11366.318020918772, 12170.634880953585, 8774.0, 8861.689840855539, 8903.688370906988, 8960.551972401485, 9184.081591840762, 9781.951090244504, 9834.704958851245, 9968.152707019695, 10042.196624269895, 10052.246081544059], "value": 6412.196687297922, "unit": "score"}], "name": "dromaeo_css", "value": 6280.581725610728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 113.0, 115.0, 113.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 121.0, 159.0, 124.0, 125.0, 128.0, 126.0, 186.0, 127.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 109.0, 75.0, 77.0, 78.0, 77.0, 104.0, 78.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 84.0, 83.0, 85.0, 114.0, 84.0, 89.0, 110.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 76.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 84.0, 93.0, 83.0, 83.0, 84.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 142.0, 151.0, 138.0, 132.0, 140.0, 132.0, 188.0, 132.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 177.0, 175.0, 173.0, 173.0, 172.0, 172.0, 172.0, 174.0, 174.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1550.8999999999999, "alertThreshold": 2.0}]} 04:32:51 INFO - Return code: 0 04:32:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:51 INFO - # TBPL SUCCESS # 04:32:51 INFO - Running post-action listener: _resource_record_post_action 04:32:51 INFO - [mozharness: 2016-09-22 11:32:51.435415Z] Finished run-tests step (success) 04:32:51 INFO - Running post-run listener: _resource_record_post_run 04:32:51 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407994368; Read time: 12; Write time: 303880 04:32:51 INFO - TinderboxPrint: CPU usage
13.1% 04:32:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:32:51 INFO - TinderboxPrint: I/O write bytes / time
407,994,368 / 303,880 04:32:51 INFO - TinderboxPrint: CPU idle
8,336.1 (86.9%) 04:32:51 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 04:32:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:32:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99819520; Read time: 0; Write time: 101396 04:32:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 291520512; Read time: 0; Write time: 194672 04:32:52 INFO - Running post-run listener: _upload_blobber_files 04:32:52 INFO - Blob upload gear active. 04:32:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:32:52 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'] 04:32:52 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 04:32:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:57 INFO - (blobuploader) - INFO - Done attempting. 04:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:58 INFO - (blobuploader) - INFO - Done attempting. 04:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:58 INFO - (blobuploader) - INFO - Done attempting. 04:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:58 INFO - Return code: 0 04:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f1b81985d4aba41266d186f95d339df01f5028e4c0199029d7b43221a2c934af939bc3794e567d3f04810c301619beb9c455822057fe77fca5c24a210ed9aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c16193a2736be67a01e78f1ab8ff5c0ec0c6b89c26a997fcccd802e2fbc9f37f13a0fc4186fd9d3c8f5aaeee96e4f757456847b36944c307d89839a11e36d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5011487053b7add82642f065d496c68028fe6d339edebdb03716f65fdc5ec49d054d68f4f9c38d0f49364b334a0c90b6071c315f118ce4211f31897701f8af"} 04:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:58 INFO - Contents: 04:32:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f1b81985d4aba41266d186f95d339df01f5028e4c0199029d7b43221a2c934af939bc3794e567d3f04810c301619beb9c455822057fe77fca5c24a210ed9aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c16193a2736be67a01e78f1ab8ff5c0ec0c6b89c26a997fcccd802e2fbc9f37f13a0fc4186fd9d3c8f5aaeee96e4f757456847b36944c307d89839a11e36d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5011487053b7add82642f065d496c68028fe6d339edebdb03716f65fdc5ec49d054d68f4f9c38d0f49364b334a0c90b6071c315f118ce4211f31897701f8af"} 04:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:58 INFO - Copying logs to upload dir... 04:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.661253 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-22 04:32:58.224334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 04:32:58.230677) ========= 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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f1b81985d4aba41266d186f95d339df01f5028e4c0199029d7b43221a2c934af939bc3794e567d3f04810c301619beb9c455822057fe77fca5c24a210ed9aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c16193a2736be67a01e78f1ab8ff5c0ec0c6b89c26a997fcccd802e2fbc9f37f13a0fc4186fd9d3c8f5aaeee96e4f757456847b36944c307d89839a11e36d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5011487053b7add82642f065d496c68028fe6d339edebdb03716f65fdc5ec49d054d68f4f9c38d0f49364b334a0c90b6071c315f118ce4211f31897701f8af"} build_url:https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/ReQrjLnCRxWk1rZRyzyTGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f1b81985d4aba41266d186f95d339df01f5028e4c0199029d7b43221a2c934af939bc3794e567d3f04810c301619beb9c455822057fe77fca5c24a210ed9aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c16193a2736be67a01e78f1ab8ff5c0ec0c6b89c26a997fcccd802e2fbc9f37f13a0fc4186fd9d3c8f5aaeee96e4f757456847b36944c307d89839a11e36d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c5011487053b7add82642f065d496c68028fe6d339edebdb03716f65fdc5ec49d054d68f4f9c38d0f49364b334a0c90b6071c315f118ce4211f31897701f8af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 04:32:58.255799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:32:58.256162) ========= 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=32c5991c409366f7fec8a718000001d2-1474542370.34123-851121548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 04:32:58.306825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 04:32:58.307176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 04:32:58.307474) ========= ========= Total master_lag: 0.29 =========